{"level":"warn","ts":"2026-04-28T13:47:20.249236Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-28T13:47:20.249375Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.35:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.35:2380","--initial-cluster=instance=https://199.19.213.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.35:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-28T13:47:20.249487Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-28T13:47:20.249499Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.35:2380"]} {"level":"info","ts":"2026-04-28T13:47:20.249534Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-28T13:47:20.250635Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"]} {"level":"info","ts":"2026-04-28T13:47:20.250745Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.35:2380"],"listen-peer-urls":["https://199.19.213.35:2380"],"advertise-client-urls":["https://199.19.213.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.35:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-28T13:47:20.257402Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.377979ms"} {"level":"info","ts":"2026-04-28T13:47:20.265658Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d1606b245347dc08","cluster-id":"e68e205b85faf98a"} {"level":"info","ts":"2026-04-28T13:47:20.265878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T13:47:20.265915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became follower at term 0"} {"level":"info","ts":"2026-04-28T13:47:20.265984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d1606b245347dc08 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T13:47:20.266006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became follower at term 1"} {"level":"info","ts":"2026-04-28T13:47:20.266053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=(15087176555451374600)"} {"level":"warn","ts":"2026-04-28T13:47:20.275658Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T13:47:20.278298Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T13:47:20.27986Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-28T13:47:20.281862Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d1606b245347dc08","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T13:47:20.282057Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d1606b245347dc08","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T13:47:20.282083Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:47:20.282266Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:47:20.282297Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-28T13:47:20.284514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=(15087176555451374600)"} {"level":"info","ts":"2026-04-28T13:47:20.284699Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e68e205b85faf98a","local-member-id":"d1606b245347dc08","added-peer-id":"d1606b245347dc08","added-peer-peer-urls":["https://199.19.213.35:2380"]} {"level":"info","ts":"2026-04-28T13:47:20.286375Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-28T13:47:20.286517Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.35:2380"} {"level":"info","ts":"2026-04-28T13:47:20.286577Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.35:2380"} {"level":"info","ts":"2026-04-28T13:47:20.286752Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d1606b245347dc08","initial-advertise-peer-urls":["https://199.19.213.35:2380"],"listen-peer-urls":["https://199.19.213.35:2380"],"advertise-client-urls":["https://199.19.213.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T13:47:20.286814Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T13:47:20.867219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T13:47:20.867317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T13:47:20.867364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 received MsgPreVoteResp from d1606b245347dc08 at term 1"} {"level":"info","ts":"2026-04-28T13:47:20.867392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became candidate at term 2"} {"level":"info","ts":"2026-04-28T13:47:20.867415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 received MsgVoteResp from d1606b245347dc08 at term 2"} {"level":"info","ts":"2026-04-28T13:47:20.867444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became leader at term 2"} {"level":"info","ts":"2026-04-28T13:47:20.86748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d1606b245347dc08 elected leader d1606b245347dc08 at term 2"} {"level":"info","ts":"2026-04-28T13:47:20.868931Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d1606b245347dc08","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.35:2379]}","request-path":"/0/members/d1606b245347dc08/attributes","cluster-id":"e68e205b85faf98a","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T13:47:20.869077Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T13:47:20.869144Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T13:47:20.869317Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T13:47:20.869408Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T13:47:20.869591Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:47:20.870749Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e68e205b85faf98a","local-member-id":"d1606b245347dc08","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:47:20.870982Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:47:20.871062Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:47:20.873189Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-28T13:47:20.87409Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.35:2379"} {"level":"warn","ts":"2026-04-28T13:47:25.350685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.529622ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:47:25.350847Z","caller":"traceutil/trace.go:171","msg":"trace[412977234] linearizableReadLoop","detail":"{readStateIndex:227; appliedIndex:226; }","duration":"343.782713ms","start":"2026-04-28T13:47:25.007047Z","end":"2026-04-28T13:47:25.350829Z","steps":["trace[412977234] 'read index received' (duration: 57.5696ms)","trace[412977234] 'applied index is now lower than readState.Index' (duration: 286.212093ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:25.350934Z","caller":"traceutil/trace.go:171","msg":"trace[1334594268] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"345.833461ms","start":"2026-04-28T13:47:25.005091Z","end":"2026-04-28T13:47:25.350925Z","steps":["trace[1334594268] 'process raft request' (duration: 59.582908ms)","trace[1334594268] 'compare' (duration: 285.354657ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:25.350981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:25.005062Z","time spent":"345.900843ms","remote":"127.0.0.1:43290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:47:25.351359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.257463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:47:25.351388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.245781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"warn","ts":"2026-04-28T13:47:25.351399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.331239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:47:25.351487Z","caller":"traceutil/trace.go:171","msg":"trace[1335984457] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:221; }","duration":"294.457527ms","start":"2026-04-28T13:47:25.05701Z","end":"2026-04-28T13:47:25.351468Z","steps":["trace[1335984457] 'agreement among raft nodes before linearized reading' (duration: 294.160049ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:25.35159Z","caller":"traceutil/trace.go:171","msg":"trace[19123208] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:0; response_revision:221; }","duration":"344.543644ms","start":"2026-04-28T13:47:25.007019Z","end":"2026-04-28T13:47:25.351563Z","steps":["trace[19123208] 'agreement among raft nodes before linearized reading' (duration: 344.114492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:25.351707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:25.00701Z","time spent":"344.682388ms","remote":"127.0.0.1:43390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"info","ts":"2026-04-28T13:47:25.351601Z","caller":"traceutil/trace.go:171","msg":"trace[415256479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:221; }","duration":"135.473088ms","start":"2026-04-28T13:47:25.215985Z","end":"2026-04-28T13:47:25.351458Z","steps":["trace[415256479] 'agreement among raft nodes before linearized reading' (duration: 135.227581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:27.000886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.37023954s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:47:27.0012Z","caller":"traceutil/trace.go:171","msg":"trace[735239497] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"1.642207488s","start":"2026-04-28T13:47:25.358916Z","end":"2026-04-28T13:47:27.001124Z","steps":["trace[735239497] 'process raft request' (duration: 271.650028ms)","trace[735239497] 'compare' (duration: 1.369644753s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:27.001389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:25.358907Z","time spent":"1.642384832s","remote":"127.0.0.1:43390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:47:27.00148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.635686872s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-28T13:47:27.001586Z","caller":"traceutil/trace.go:171","msg":"trace[1187752195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:224; }","duration":"1.635840696s","start":"2026-04-28T13:47:25.365732Z","end":"2026-04-28T13:47:27.001573Z","steps":["trace[1187752195] 'agreement among raft nodes before linearized reading' (duration: 1.635547748s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:27.001835Z","caller":"traceutil/trace.go:171","msg":"trace[1333282862] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"1.642719093s","start":"2026-04-28T13:47:25.359104Z","end":"2026-04-28T13:47:27.001823Z","steps":["trace[1333282862] 'process raft request' (duration: 1.641903749s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:27.001969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:25.359076Z","time spent":"1.642869837s","remote":"127.0.0.1:43290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11432,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:47:27.00121Z","caller":"traceutil/trace.go:171","msg":"trace[1602152154] linearizableReadLoop","detail":"{readStateIndex:230; appliedIndex:228; }","duration":"1.635406334s","start":"2026-04-28T13:47:25.365781Z","end":"2026-04-28T13:47:27.001188Z","steps":["trace[1602152154] 'read index received' (duration: 264.762462ms)","trace[1602152154] 'applied index is now lower than readState.Index' (duration: 1.370642252s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:27.002369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.477181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:47:27.002428Z","caller":"traceutil/trace.go:171","msg":"trace[882140106] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:224; }","duration":"534.551392ms","start":"2026-04-28T13:47:26.467859Z","end":"2026-04-28T13:47:27.00241Z","steps":["trace[882140106] 'agreement among raft nodes before linearized reading' (duration: 534.418329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:27.002445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.131481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:47:27.002468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:26.467792Z","time spent":"534.666086ms","remote":"127.0.0.1:43452","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-04-28T13:47:27.001688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:25.365715Z","time spent":"1.635943038s","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T13:47:27.002472Z","caller":"traceutil/trace.go:171","msg":"trace[1687009363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:224; }","duration":"385.215624ms","start":"2026-04-28T13:47:26.617248Z","end":"2026-04-28T13:47:27.002464Z","steps":["trace[1687009363] 'agreement among raft nodes before linearized reading' (duration: 385.172263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:27.002593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:26.61722Z","time spent":"385.362548ms","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T13:47:27.512204Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15855096023495429168,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:47:28.542773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.681404ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:47:28.542893Z","caller":"traceutil/trace.go:171","msg":"trace[402989622] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"1.536367806s","start":"2026-04-28T13:47:27.006505Z","end":"2026-04-28T13:47:28.542873Z","steps":["trace[402989622] 'process raft request' (duration: 602.518216ms)","trace[402989622] 'compare' (duration: 933.52252ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:28.542966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:27.006494Z","time spent":"1.536430017s","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:47:28.714457Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.105006139s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T13:47:28.740167Z","caller":"traceutil/trace.go:171","msg":"trace[399276523] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"1.733041352s","start":"2026-04-28T13:47:27.007095Z","end":"2026-04-28T13:47:28.740137Z","steps":["trace[399276523] 'process raft request' (duration: 1.707977836s)","trace[399276523] 'compare' (duration: 24.648575ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:28.740297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:27.007076Z","time spent":"1.733162897s","remote":"127.0.0.1:43506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":324,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:47:28.740602Z","caller":"traceutil/trace.go:171","msg":"trace[148697646] linearizableReadLoop","detail":"{readStateIndex:235; appliedIndex:230; }","duration":"1.729061781s","start":"2026-04-28T13:47:27.011531Z","end":"2026-04-28T13:47:28.740592Z","steps":["trace[148697646] 'read index received' (duration: 597.442854ms)","trace[148697646] 'applied index is now lower than readState.Index' (duration: 1.131618057s)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:28.740746Z","caller":"traceutil/trace.go:171","msg":"trace[2027349784] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"1.731604692s","start":"2026-04-28T13:47:27.009134Z","end":"2026-04-28T13:47:28.740739Z","steps":["trace[2027349784] 'process raft request' (duration: 1.730945014s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:28.740961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:27.009113Z","time spent":"1.731649103s","remote":"127.0.0.1:43452","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-04-28T13:47:28.741082Z","caller":"traceutil/trace.go:171","msg":"trace[87932787] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"1.730516302s","start":"2026-04-28T13:47:27.010554Z","end":"2026-04-28T13:47:28.74107Z","steps":["trace[87932787] 'process raft request' (duration: 1.729974027s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:28.741136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:27.010541Z","time spent":"1.730567163s","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:47:28.741248Z","caller":"traceutil/trace.go:171","msg":"trace[232959977] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"1.729006509s","start":"2026-04-28T13:47:27.012232Z","end":"2026-04-28T13:47:28.741239Z","steps":["trace[232959977] 'process raft request' (duration: 1.728335861s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:28.741289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:27.012225Z","time spent":"1.729044671s","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:47:28.74139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.729857153s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-28T13:47:28.74166Z","caller":"traceutil/trace.go:171","msg":"trace[160528368] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"115.622436ms","start":"2026-04-28T13:47:28.626002Z","end":"2026-04-28T13:47:28.741625Z","steps":["trace[160528368] 'process raft request' (duration: 115.46434ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:28.741748Z","caller":"traceutil/trace.go:171","msg":"trace[473634757] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:229; }","duration":"1.729915895s","start":"2026-04-28T13:47:27.011491Z","end":"2026-04-28T13:47:28.741407Z","steps":["trace[473634757] 'agreement among raft nodes before linearized reading' (duration: 1.729867554s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:28.741952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:27.011481Z","time spent":"1.730318346s","remote":"127.0.0.1:43308","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":"warn","ts":"2026-04-28T13:47:28.758943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.476469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:47:28.759043Z","caller":"traceutil/trace.go:171","msg":"trace[2138274159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:231; }","duration":"211.627743ms","start":"2026-04-28T13:47:28.547392Z","end":"2026-04-28T13:47:28.75902Z","steps":["trace[2138274159] 'agreement among raft nodes before linearized reading' (duration: 211.359166ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:28.879539Z","caller":"traceutil/trace.go:171","msg":"trace[110571630] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"131.577128ms","start":"2026-04-28T13:47:28.747944Z","end":"2026-04-28T13:47:28.879522Z","steps":["trace[110571630] 'process raft request' (duration: 131.467634ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:28.879581Z","caller":"traceutil/trace.go:171","msg":"trace[1959573411] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"115.528512ms","start":"2026-04-28T13:47:28.764037Z","end":"2026-04-28T13:47:28.879566Z","steps":["trace[1959573411] 'process raft request' (duration: 115.46747ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:28.879754Z","caller":"traceutil/trace.go:171","msg":"trace[1280460889] linearizableReadLoop","detail":"{readStateIndex:240; appliedIndex:237; }","duration":"121.112007ms","start":"2026-04-28T13:47:28.75863Z","end":"2026-04-28T13:47:28.879742Z","steps":["trace[1280460889] 'read index received' (duration: 113.471314ms)","trace[1280460889] 'applied index is now lower than readState.Index' (duration: 7.639163ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:28.879866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.282585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-28T13:47:28.87987Z","caller":"traceutil/trace.go:171","msg":"trace[1261794375] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"131.803384ms","start":"2026-04-28T13:47:28.748046Z","end":"2026-04-28T13:47:28.879849Z","steps":["trace[1261794375] 'process raft request' (duration: 131.407293ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:28.879904Z","caller":"traceutil/trace.go:171","msg":"trace[262598819] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:235; }","duration":"133.375657ms","start":"2026-04-28T13:47:28.746517Z","end":"2026-04-28T13:47:28.879893Z","steps":["trace[262598819] 'agreement among raft nodes before linearized reading' (duration: 133.264304ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:28.879526Z","caller":"traceutil/trace.go:171","msg":"trace[958972728] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"131.808016ms","start":"2026-04-28T13:47:28.747683Z","end":"2026-04-28T13:47:28.879491Z","steps":["trace[958972728] 'process raft request' (duration: 124.481721ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:29.058722Z","caller":"traceutil/trace.go:171","msg":"trace[1585451144] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"107.856495ms","start":"2026-04-28T13:47:28.950827Z","end":"2026-04-28T13:47:29.058684Z","steps":["trace[1585451144] 'process raft request' (duration: 47.427099ms)","trace[1585451144] 'compare' (duration: 60.125508ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:29.720495Z","caller":"traceutil/trace.go:171","msg":"trace[1248631504] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"207.870113ms","start":"2026-04-28T13:47:29.512595Z","end":"2026-04-28T13:47:29.720465Z","steps":["trace[1248631504] 'process raft request' (duration: 207.687167ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:29.771519Z","caller":"traceutil/trace.go:171","msg":"trace[1149078416] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"257.717929ms","start":"2026-04-28T13:47:29.513762Z","end":"2026-04-28T13:47:29.77148Z","steps":["trace[1149078416] 'process raft request' (duration: 257.516142ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:29.874582Z","caller":"traceutil/trace.go:171","msg":"trace[1864103986] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"148.672795ms","start":"2026-04-28T13:47:29.725873Z","end":"2026-04-28T13:47:29.874545Z","steps":["trace[1864103986] 'process raft request' (duration: 144.971043ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:30.598857Z","caller":"traceutil/trace.go:171","msg":"trace[1992709716] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"217.151131ms","start":"2026-04-28T13:47:30.381667Z","end":"2026-04-28T13:47:30.598818Z","steps":["trace[1992709716] 'process raft request' (duration: 164.721837ms)","trace[1992709716] 'compare' (duration: 52.25258ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:30.599912Z","caller":"traceutil/trace.go:171","msg":"trace[543987291] transaction","detail":"{read_only:false; number_of_response:0; response_revision:319; }","duration":"115.738666ms","start":"2026-04-28T13:47:30.484147Z","end":"2026-04-28T13:47:30.599886Z","steps":["trace[543987291] 'process raft request' (duration: 115.705015ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:30.599925Z","caller":"traceutil/trace.go:171","msg":"trace[986527849] transaction","detail":"{read_only:false; number_of_response:0; response_revision:319; }","duration":"118.322637ms","start":"2026-04-28T13:47:30.48157Z","end":"2026-04-28T13:47:30.599893Z","steps":["trace[986527849] 'process raft request' (duration: 118.168363ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:30.600006Z","caller":"traceutil/trace.go:171","msg":"trace[899298212] transaction","detail":"{read_only:false; number_of_response:0; response_revision:319; }","duration":"116.387904ms","start":"2026-04-28T13:47:30.483611Z","end":"2026-04-28T13:47:30.599999Z","steps":["trace[899298212] 'process raft request' (duration: 116.189839ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:30.600132Z","caller":"traceutil/trace.go:171","msg":"trace[755131298] transaction","detail":"{read_only:false; number_of_response:0; response_revision:319; }","duration":"116.571649ms","start":"2026-04-28T13:47:30.483555Z","end":"2026-04-28T13:47:30.600126Z","steps":["trace[755131298] 'process raft request' (duration: 116.2246ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:30.600154Z","caller":"traceutil/trace.go:171","msg":"trace[1363179922] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"215.016923ms","start":"2026-04-28T13:47:30.385127Z","end":"2026-04-28T13:47:30.600144Z","steps":["trace[1363179922] 'process raft request' (duration: 214.51594ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:30.600197Z","caller":"traceutil/trace.go:171","msg":"trace[1430122501] transaction","detail":"{read_only:false; number_of_response:0; response_revision:319; }","duration":"116.094017ms","start":"2026-04-28T13:47:30.484094Z","end":"2026-04-28T13:47:30.600188Z","steps":["trace[1430122501] 'process raft request' (duration: 115.734938ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:30.599916Z","caller":"traceutil/trace.go:171","msg":"trace[1322007396] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"217.625625ms","start":"2026-04-28T13:47:30.382248Z","end":"2026-04-28T13:47:30.599873Z","steps":["trace[1322007396] 'process raft request' (duration: 217.277765ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:30.600813Z","caller":"traceutil/trace.go:171","msg":"trace[742230842] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"187.194311ms","start":"2026-04-28T13:47:30.413585Z","end":"2026-04-28T13:47:30.600779Z","steps":["trace[742230842] 'process raft request' (duration: 186.095892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:31.22196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.128887ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:47:31.222044Z","caller":"traceutil/trace.go:171","msg":"trace[518781250] linearizableReadLoop","detail":"{readStateIndex:348; appliedIndex:347; }","duration":"258.744173ms","start":"2026-04-28T13:47:30.963286Z","end":"2026-04-28T13:47:31.222031Z","steps":["trace[518781250] 'read index received' (duration: 12.471911ms)","trace[518781250] 'applied index is now lower than readState.Index' (duration: 246.271222ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:31.222245Z","caller":"traceutil/trace.go:171","msg":"trace[832723567] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"265.874658ms","start":"2026-04-28T13:47:30.956358Z","end":"2026-04-28T13:47:31.222232Z","steps":["trace[832723567] 'process raft request' (duration: 19.396981ms)","trace[832723567] 'compare' (duration: 246.041425ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:47:31.222343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.01714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-28T13:47:31.22243Z","caller":"traceutil/trace.go:171","msg":"trace[1183944750] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:336; }","duration":"259.163894ms","start":"2026-04-28T13:47:30.963246Z","end":"2026-04-28T13:47:31.22241Z","steps":["trace[1183944750] 'agreement among raft nodes before linearized reading' (duration: 258.946699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:31.222412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.808222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-04-28T13:47:31.222488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.599431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-28T13:47:31.222504Z","caller":"traceutil/trace.go:171","msg":"trace[1829285452] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:336; }","duration":"207.988986ms","start":"2026-04-28T13:47:31.014492Z","end":"2026-04-28T13:47:31.222481Z","steps":["trace[1829285452] 'agreement among raft nodes before linearized reading' (duration: 207.784491ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:31.222518Z","caller":"traceutil/trace.go:171","msg":"trace[1321153985] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:336; }","duration":"107.661163ms","start":"2026-04-28T13:47:31.114847Z","end":"2026-04-28T13:47:31.222509Z","steps":["trace[1321153985] 'agreement among raft nodes before linearized reading' (duration: 107.605691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:31.22264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.129162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-28T13:47:31.222657Z","caller":"traceutil/trace.go:171","msg":"trace[701148639] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:336; }","duration":"158.182394ms","start":"2026-04-28T13:47:31.064468Z","end":"2026-04-28T13:47:31.22265Z","steps":["trace[701148639] 'agreement among raft nodes before linearized reading' (duration: 158.150114ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:31.5867Z","caller":"traceutil/trace.go:171","msg":"trace[1232973645] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"129.252329ms","start":"2026-04-28T13:47:31.457422Z","end":"2026-04-28T13:47:31.586675Z","steps":["trace[1232973645] 'process raft request' (duration: 120.914272ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:31.612475Z","caller":"traceutil/trace.go:171","msg":"trace[640659362] linearizableReadLoop","detail":"{readStateIndex:355; appliedIndex:353; }","duration":"148.961854ms","start":"2026-04-28T13:47:31.463485Z","end":"2026-04-28T13:47:31.612447Z","steps":["trace[640659362] 'read index received' (duration: 114.92333ms)","trace[640659362] 'applied index is now lower than readState.Index' (duration: 34.037504ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:31.61261Z","caller":"traceutil/trace.go:171","msg":"trace[1640710077] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"154.167646ms","start":"2026-04-28T13:47:31.458431Z","end":"2026-04-28T13:47:31.612599Z","steps":["trace[1640710077] 'process raft request' (duration: 153.667323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:31.612808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.284524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-28T13:47:31.612973Z","caller":"traceutil/trace.go:171","msg":"trace[1797765381] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:339; }","duration":"149.469148ms","start":"2026-04-28T13:47:31.463453Z","end":"2026-04-28T13:47:31.612922Z","steps":["trace[1797765381] 'agreement among raft nodes before linearized reading' (duration: 149.211071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:31.61579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.979211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-28T13:47:31.615839Z","caller":"traceutil/trace.go:171","msg":"trace[1481071455] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:340; }","duration":"101.093234ms","start":"2026-04-28T13:47:31.514735Z","end":"2026-04-28T13:47:31.615828Z","steps":["trace[1481071455] 'agreement among raft nodes before linearized reading' (duration: 100.895579ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:31.762578Z","caller":"traceutil/trace.go:171","msg":"trace[2138163130] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"111.57109ms","start":"2026-04-28T13:47:31.650969Z","end":"2026-04-28T13:47:31.76254Z","steps":["trace[2138163130] 'process raft request' (duration: 89.164202ms)","trace[2138163130] 'compare' (duration: 22.103499ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:31.762849Z","caller":"traceutil/trace.go:171","msg":"trace[1858109792] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"109.110232ms","start":"2026-04-28T13:47:31.653713Z","end":"2026-04-28T13:47:31.762823Z","steps":["trace[1858109792] 'process raft request' (duration: 108.936558ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:31.76296Z","caller":"traceutil/trace.go:171","msg":"trace[971759426] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"111.62315ms","start":"2026-04-28T13:47:31.651275Z","end":"2026-04-28T13:47:31.762898Z","steps":["trace[971759426] 'process raft request' (duration: 111.121936ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:31.931842Z","caller":"traceutil/trace.go:171","msg":"trace[326590923] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"157.024593ms","start":"2026-04-28T13:47:31.774785Z","end":"2026-04-28T13:47:31.93181Z","steps":["trace[326590923] 'process raft request' (duration: 156.859868ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:31.932108Z","caller":"traceutil/trace.go:171","msg":"trace[527238864] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"157.441764ms","start":"2026-04-28T13:47:31.774652Z","end":"2026-04-28T13:47:31.932093Z","steps":["trace[527238864] 'process raft request' (duration: 144.644407ms)","trace[527238864] 'compare' (duration: 11.972125ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:31.932069Z","caller":"traceutil/trace.go:171","msg":"trace[1700635764] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:374; }","duration":"156.244212ms","start":"2026-04-28T13:47:31.775802Z","end":"2026-04-28T13:47:31.932046Z","steps":["trace[1700635764] 'read index received' (duration: 33.224942ms)","trace[1700635764] 'applied index is now lower than readState.Index' (duration: 123.01636ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:31.932462Z","caller":"traceutil/trace.go:171","msg":"trace[1989106482] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"153.736023ms","start":"2026-04-28T13:47:31.778716Z","end":"2026-04-28T13:47:31.932452Z","steps":["trace[1989106482] 'process raft request' (duration: 153.001343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:31.932577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.691215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-04-28T13:47:31.932662Z","caller":"traceutil/trace.go:171","msg":"trace[1873097445] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:364; }","duration":"117.906152ms","start":"2026-04-28T13:47:31.814739Z","end":"2026-04-28T13:47:31.932645Z","steps":["trace[1873097445] 'agreement among raft nodes before linearized reading' (duration: 117.707476ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:31.932672Z","caller":"traceutil/trace.go:171","msg":"trace[1083403798] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"116.38401ms","start":"2026-04-28T13:47:31.816278Z","end":"2026-04-28T13:47:31.932662Z","steps":["trace[1083403798] 'process raft request' (duration: 115.505036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:31.932538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.712723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-04-28T13:47:31.933047Z","caller":"traceutil/trace.go:171","msg":"trace[872469348] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:364; }","duration":"157.256409ms","start":"2026-04-28T13:47:31.775755Z","end":"2026-04-28T13:47:31.933011Z","steps":["trace[872469348] 'agreement among raft nodes before linearized reading' (duration: 156.653833ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:47:31.933469Z","caller":"traceutil/trace.go:171","msg":"trace[592295600] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"112.888634ms","start":"2026-04-28T13:47:31.818997Z","end":"2026-04-28T13:47:31.931886Z","steps":["trace[592295600] 'process raft request' (duration: 112.826743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:32.31499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.313346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:47:32.31524Z","caller":"traceutil/trace.go:171","msg":"trace[105786522] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"344.003952ms","start":"2026-04-28T13:47:31.9712Z","end":"2026-04-28T13:47:32.315204Z","steps":["trace[105786522] 'process raft request' (duration: 208.378729ms)","trace[105786522] 'compare' (duration: 135.12514ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:32.315336Z","caller":"traceutil/trace.go:171","msg":"trace[1370978103] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"340.628461ms","start":"2026-04-28T13:47:31.974667Z","end":"2026-04-28T13:47:32.315295Z","steps":["trace[1370978103] 'process raft request' (duration: 340.509538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:32.315489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:31.97466Z","time spent":"340.712843ms","remote":"127.0.0.1:43272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:47:32.315493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:31.971191Z","time spent":"344.178797ms","remote":"127.0.0.1:43372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4447,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:47:32.315593Z","caller":"traceutil/trace.go:171","msg":"trace[30290522] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"340.719483ms","start":"2026-04-28T13:47:31.974619Z","end":"2026-04-28T13:47:32.315339Z","steps":["trace[30290522] 'process raft request' (duration: 340.482977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:32.315725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:31.974609Z","time spent":"341.071503ms","remote":"127.0.0.1:43272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:47:32.315754Z","caller":"traceutil/trace.go:171","msg":"trace[272852539] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"340.943629ms","start":"2026-04-28T13:47:31.974769Z","end":"2026-04-28T13:47:32.315713Z","steps":["trace[272852539] 'process raft request' (duration: 340.430615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:32.316969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:31.974761Z","time spent":"342.031529ms","remote":"127.0.0.1:43372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:47:32.315986Z","caller":"traceutil/trace.go:171","msg":"trace[1548968448] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"317.01287ms","start":"2026-04-28T13:47:31.998964Z","end":"2026-04-28T13:47:32.315977Z","steps":["trace[1548968448] 'process raft request' (duration: 316.977529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:32.317595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:31.998953Z","time spent":"318.599373ms","remote":"127.0.0.1:43516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:47:32.316015Z","caller":"traceutil/trace.go:171","msg":"trace[159698979] linearizableReadLoop","detail":"{readStateIndex:394; appliedIndex:389; }","duration":"317.117623ms","start":"2026-04-28T13:47:31.998891Z","end":"2026-04-28T13:47:32.316008Z","steps":["trace[159698979] 'read index received' (duration: 180.851843ms)","trace[159698979] 'applied index is now lower than readState.Index' (duration: 136.26524ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:47:32.31603Z","caller":"traceutil/trace.go:171","msg":"trace[299539761] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"335.593464ms","start":"2026-04-28T13:47:31.98042Z","end":"2026-04-28T13:47:32.316013Z","steps":["trace[299539761] 'process raft request' (duration: 334.809833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:32.316079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.184384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:3475"} {"level":"info","ts":"2026-04-28T13:47:32.3184Z","caller":"traceutil/trace.go:171","msg":"trace[1046973884] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:379; }","duration":"319.525078ms","start":"2026-04-28T13:47:31.998854Z","end":"2026-04-28T13:47:32.318379Z","steps":["trace[1046973884] 'agreement among raft nodes before linearized reading' (duration: 317.175264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:32.318452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:31.998838Z","time spent":"319.595831ms","remote":"127.0.0.1:43516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":3499,"request content":"key:\"/registry/clusterroles/edit\" "} {"level":"warn","ts":"2026-04-28T13:47:32.317788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:31.980405Z","time spent":"337.358893ms","remote":"127.0.0.1:43372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:47:39.132733Z","caller":"traceutil/trace.go:171","msg":"trace[2054154968] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"112.520175ms","start":"2026-04-28T13:47:39.020184Z","end":"2026-04-28T13:47:39.132704Z","steps":["trace[2054154968] 'process raft request' (duration: 112.29598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:47:54.788918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:47:54.258377Z","time spent":"530.536277ms","remote":"127.0.0.1:43232","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-28T13:48:00.831534Z","caller":"traceutil/trace.go:171","msg":"trace[250372919] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"131.364526ms","start":"2026-04-28T13:48:00.700137Z","end":"2026-04-28T13:48:00.831501Z","steps":["trace[250372919] 'process raft request' (duration: 131.06542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:00.831939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.566249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"info","ts":"2026-04-28T13:48:00.831992Z","caller":"traceutil/trace.go:171","msg":"trace[556113690] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:602; }","duration":"130.669011ms","start":"2026-04-28T13:48:00.701311Z","end":"2026-04-28T13:48:00.83198Z","steps":["trace[556113690] 'agreement among raft nodes before linearized reading' (duration: 130.495517ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:00.831766Z","caller":"traceutil/trace.go:171","msg":"trace[1654550102] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"130.073448ms","start":"2026-04-28T13:48:00.701348Z","end":"2026-04-28T13:48:00.831422Z","steps":["trace[1654550102] 'read index received' (duration: 129.808473ms)","trace[1654550102] 'applied index is now lower than readState.Index' (duration: 263.845µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:48:01.16954Z","caller":"traceutil/trace.go:171","msg":"trace[1462768416] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"115.070519ms","start":"2026-04-28T13:48:01.054439Z","end":"2026-04-28T13:48:01.169509Z","steps":["trace[1462768416] 'process raft request' (duration: 114.855834ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:01.170134Z","caller":"traceutil/trace.go:171","msg":"trace[690585131] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:632; }","duration":"108.713178ms","start":"2026-04-28T13:48:01.061411Z","end":"2026-04-28T13:48:01.170125Z","steps":["trace[690585131] 'read index received' (duration: 108.708828ms)","trace[690585131] 'applied index is now lower than readState.Index' (duration: 3.74µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:48:01.170361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.925203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-28T13:48:01.170416Z","caller":"traceutil/trace.go:171","msg":"trace[1157818567] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:603; }","duration":"109.040576ms","start":"2026-04-28T13:48:01.061365Z","end":"2026-04-28T13:48:01.170405Z","steps":["trace[1157818567] 'agreement among raft nodes before linearized reading' (duration: 108.844512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:01.172935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.547581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:01.173021Z","caller":"traceutil/trace.go:171","msg":"trace[1213586950] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:604; }","duration":"106.671684ms","start":"2026-04-28T13:48:01.06633Z","end":"2026-04-28T13:48:01.173001Z","steps":["trace[1213586950] 'agreement among raft nodes before linearized reading' (duration: 106.513631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:01.174638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.134986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:01.174757Z","caller":"traceutil/trace.go:171","msg":"trace[1804503046] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:604; }","duration":"108.31185ms","start":"2026-04-28T13:48:01.066413Z","end":"2026-04-28T13:48:01.174725Z","steps":["trace[1804503046] 'agreement among raft nodes before linearized reading' (duration: 108.134636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:01.174835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.187078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:01.17578Z","caller":"traceutil/trace.go:171","msg":"trace[1226055922] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:604; }","duration":"108.512995ms","start":"2026-04-28T13:48:01.06648Z","end":"2026-04-28T13:48:01.174993Z","steps":["trace[1226055922] 'agreement among raft nodes before linearized reading' (duration: 108.285559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.519795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.799058ms","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":"warn","ts":"2026-04-28T13:48:02.519943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.90967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.519959Z","caller":"traceutil/trace.go:171","msg":"trace[1355962611] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:607; }","duration":"610.078385ms","start":"2026-04-28T13:48:01.909858Z","end":"2026-04-28T13:48:02.519936Z","steps":["trace[1355962611] 'range keys from in-memory index tree' (duration: 609.714767ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:02.519983Z","caller":"traceutil/trace.go:171","msg":"trace[865806115] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:607; }","duration":"609.960452ms","start":"2026-04-28T13:48:01.910004Z","end":"2026-04-28T13:48:02.519964Z","steps":["trace[865806115] 'range keys from in-memory index tree' (duration: 609.88038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.52002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.909991Z","time spent":"610.020643ms","remote":"127.0.0.1:54988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:48:02.52004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.909836Z","time spent":"610.187767ms","remote":"127.0.0.1:54984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:48:02.520207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.168157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.520235Z","caller":"traceutil/trace.go:171","msg":"trace[85716861] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:607; }","duration":"596.222738ms","start":"2026-04-28T13:48:01.924004Z","end":"2026-04-28T13:48:02.520227Z","steps":["trace[85716861] 'range keys from in-memory index tree' (duration: 596.108045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.520257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.923987Z","time spent":"596.263429ms","remote":"127.0.0.1:55004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:48:02.520374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.208489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.520398Z","caller":"traceutil/trace.go:171","msg":"trace[45968669] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:607; }","duration":"596.2405ms","start":"2026-04-28T13:48:01.924151Z","end":"2026-04-28T13:48:02.520392Z","steps":["trace[45968669] 'count revisions from in-memory index tree' (duration: 596.189967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.520419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.924148Z","time spent":"596.26426ms","remote":"127.0.0.1:55004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:48:02.520505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.163648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.520539Z","caller":"traceutil/trace.go:171","msg":"trace[2123138719] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:607; }","duration":"596.212018ms","start":"2026-04-28T13:48:01.924321Z","end":"2026-04-28T13:48:02.520533Z","steps":["trace[2123138719] 'range keys from in-memory index tree' (duration: 596.141908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.520559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.924318Z","time spent":"596.234029ms","remote":"127.0.0.1:55004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:48:02.520496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.218499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:48:02.520626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.218728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.520709Z","caller":"traceutil/trace.go:171","msg":"trace[1335933335] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:607; }","duration":"896.385172ms","start":"2026-04-28T13:48:01.624302Z","end":"2026-04-28T13:48:02.520687Z","steps":["trace[1335933335] 'count revisions from in-memory index tree' (duration: 896.110687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.52075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.223031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:48:02.520755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.624273Z","time spent":"896.474364ms","remote":"127.0.0.1:54936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:48:02.520773Z","caller":"traceutil/trace.go:171","msg":"trace[2109699589] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:607; }","duration":"544.281662ms","start":"2026-04-28T13:48:01.976485Z","end":"2026-04-28T13:48:02.520767Z","steps":["trace[2109699589] 'range keys from in-memory index tree' (duration: 544.082328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.520792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.976463Z","time spent":"544.322723ms","remote":"127.0.0.1:55008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:48:02.520999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.096358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.520683Z","caller":"traceutil/trace.go:171","msg":"trace[184501763] 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:607; }","duration":"848.436464ms","start":"2026-04-28T13:48:01.672232Z","end":"2026-04-28T13:48:02.520669Z","steps":["trace[184501763] 'range keys from in-memory index tree' (duration: 848.086107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.520905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.259992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.521068Z","caller":"traceutil/trace.go:171","msg":"trace[959815756] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:607; }","duration":"544.479616ms","start":"2026-04-28T13:48:01.976582Z","end":"2026-04-28T13:48:02.521062Z","steps":["trace[959815756] 'count revisions from in-memory index tree' (duration: 544.18443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.521096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.976559Z","time spent":"544.530168ms","remote":"127.0.0.1:55008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:48:02.521182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.59571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:48:02.521069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.672213Z","time spent":"848.838792ms","remote":"127.0.0.1:54952","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":"info","ts":"2026-04-28T13:48:02.521201Z","caller":"traceutil/trace.go:171","msg":"trace[2125490264] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:607; }","duration":"544.710192ms","start":"2026-04-28T13:48:01.976485Z","end":"2026-04-28T13:48:02.521195Z","steps":["trace[2125490264] 'range keys from in-memory index tree' (duration: 544.480857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.52122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.976457Z","time spent":"544.757282ms","remote":"127.0.0.1:55008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:48:02.521302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.597416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.521321Z","caller":"traceutil/trace.go:171","msg":"trace[1273069138] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:607; }","duration":"518.647087ms","start":"2026-04-28T13:48:02.002667Z","end":"2026-04-28T13:48:02.521315Z","steps":["trace[1273069138] 'range keys from in-memory index tree' (duration: 518.535185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.521345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:02.002646Z","time spent":"518.692338ms","remote":"127.0.0.1:55018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:48:02.521457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.647357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:48:02.521329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.077339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.521481Z","caller":"traceutil/trace.go:171","msg":"trace[2122434710] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:607; }","duration":"518.712119ms","start":"2026-04-28T13:48:02.002763Z","end":"2026-04-28T13:48:02.521475Z","steps":["trace[2122434710] 'count revisions from in-memory index tree' (duration: 518.506194ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:02.521493Z","caller":"traceutil/trace.go:171","msg":"trace[1270394750] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:607; }","duration":"912.256222ms","start":"2026-04-28T13:48:01.609224Z","end":"2026-04-28T13:48:02.521481Z","steps":["trace[1270394750] 'range keys from in-memory index tree' (duration: 912.007457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.521664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.609216Z","time spent":"912.433635ms","remote":"127.0.0.1:54930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:48:02.521684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.10689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.521708Z","caller":"traceutil/trace.go:171","msg":"trace[1127961033] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:607; }","duration":"283.12905ms","start":"2026-04-28T13:48:02.23857Z","end":"2026-04-28T13:48:02.521699Z","steps":["trace[1127961033] 'count revisions from in-memory index tree' (duration: 283.048449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.521805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.529079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.521829Z","caller":"traceutil/trace.go:171","msg":"trace[841436441] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:607; }","duration":"283.584791ms","start":"2026-04-28T13:48:02.238239Z","end":"2026-04-28T13:48:02.521824Z","steps":["trace[841436441] 'range keys from in-memory index tree' (duration: 283.115591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.521768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.555561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:48:02.521889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"897.26853ms","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-04-28T13:48:02.522013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.624266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.522041Z","caller":"traceutil/trace.go:171","msg":"trace[808992265] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:607; }","duration":"135.658676ms","start":"2026-04-28T13:48:02.386374Z","end":"2026-04-28T13:48:02.522032Z","steps":["trace[808992265] 'count revisions from in-memory index tree' (duration: 135.562964ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:02.521933Z","caller":"traceutil/trace.go:171","msg":"trace[371215581] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:607; }","duration":"874.750746ms","start":"2026-04-28T13:48:01.647152Z","end":"2026-04-28T13:48:02.521903Z","steps":["trace[371215581] 'range keys from in-memory index tree' (duration: 874.456068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.522077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.647081Z","time spent":"874.98176ms","remote":"127.0.0.1:54940","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:48:02.522142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.842029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.522188Z","caller":"traceutil/trace.go:171","msg":"trace[794504317] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:607; }","duration":"135.921731ms","start":"2026-04-28T13:48:02.386261Z","end":"2026-04-28T13:48:02.522183Z","steps":["trace[794504317] 'range keys from in-memory index tree' (duration: 135.669366ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:02.522142Z","caller":"traceutil/trace.go:171","msg":"trace[1402150025] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:607; }","duration":"897.66108ms","start":"2026-04-28T13:48:01.624353Z","end":"2026-04-28T13:48:02.522014Z","steps":["trace[1402150025] 'range keys from in-memory index tree' (duration: 897.187269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.522276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.54793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.522299Z","caller":"traceutil/trace.go:171","msg":"trace[1682952556] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:607; }","duration":"118.616752ms","start":"2026-04-28T13:48:02.403677Z","end":"2026-04-28T13:48:02.522294Z","steps":["trace[1682952556] 'count revisions from in-memory index tree' (duration: 118.446208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.521052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.270292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.52235Z","caller":"traceutil/trace.go:171","msg":"trace[126269219] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:607; }","duration":"913.647813ms","start":"2026-04-28T13:48:01.608696Z","end":"2026-04-28T13:48:02.522343Z","steps":["trace[126269219] 'range keys from in-memory index tree' (duration: 912.059827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.522372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.608651Z","time spent":"913.714714ms","remote":"127.0.0.1:54930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:48:02.522384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"897.184129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:48:02.522419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.271074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.52244Z","caller":"traceutil/trace.go:171","msg":"trace[172215615] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:607; }","duration":"118.289304ms","start":"2026-04-28T13:48:02.404142Z","end":"2026-04-28T13:48:02.522432Z","steps":["trace[172215615] 'range keys from in-memory index tree' (duration: 118.210142ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:02.522448Z","caller":"traceutil/trace.go:171","msg":"trace[664734283] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:607; }","duration":"897.24265ms","start":"2026-04-28T13:48:01.625172Z","end":"2026-04-28T13:48:02.522415Z","steps":["trace[664734283] 'range keys from in-memory index tree' (duration: 897.121568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.522483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.625162Z","time spent":"897.311252ms","remote":"127.0.0.1:54936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:48:02.522493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.624333Z","time spent":"897.995967ms","remote":"127.0.0.1:54936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:48:02.522592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.031434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.522628Z","caller":"traceutil/trace.go:171","msg":"trace[352877794] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:607; }","duration":"876.093154ms","start":"2026-04-28T13:48:01.64653Z","end":"2026-04-28T13:48:02.522623Z","steps":["trace[352877794] 'range keys from in-memory index tree' (duration: 875.934991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.522643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.646516Z","time spent":"876.122516ms","remote":"127.0.0.1:54940","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:48:02.522396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.531239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.522703Z","caller":"traceutil/trace.go:171","msg":"trace[1939599015] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:607; }","duration":"118.849098ms","start":"2026-04-28T13:48:02.403842Z","end":"2026-04-28T13:48:02.522691Z","steps":["trace[1939599015] 'range keys from in-memory index tree' (duration: 118.471538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.5215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:02.002737Z","time spent":"518.757369ms","remote":"127.0.0.1:55018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:48:02.521522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.645285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.522951Z","caller":"traceutil/trace.go:171","msg":"trace[1172173244] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:607; }","duration":"519.061985ms","start":"2026-04-28T13:48:02.003854Z","end":"2026-04-28T13:48:02.522916Z","steps":["trace[1172173244] 'range keys from in-memory index tree' (duration: 517.559783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.522998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:02.003842Z","time spent":"519.140957ms","remote":"127.0.0.1:55018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:48:02.523202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.345431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.5233Z","caller":"traceutil/trace.go:171","msg":"trace[1801142655] 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:607; }","duration":"852.466193ms","start":"2026-04-28T13:48:01.670816Z","end":"2026-04-28T13:48:02.523282Z","steps":["trace[1801142655] 'range keys from in-memory index tree' (duration: 852.29949ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:02.521032Z","caller":"traceutil/trace.go:171","msg":"trace[1669833498] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:607; }","duration":"912.128919ms","start":"2026-04-28T13:48:01.608897Z","end":"2026-04-28T13:48:02.521026Z","steps":["trace[1669833498] 'count revisions from in-memory index tree' (duration: 912.032197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.522573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.000363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:48:02.521983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.208348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:48:02.52341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.300604ms","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":"info","ts":"2026-04-28T13:48:02.523676Z","caller":"traceutil/trace.go:171","msg":"trace[320334235] 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:607; }","duration":"748.599091ms","start":"2026-04-28T13:48:01.775067Z","end":"2026-04-28T13:48:02.523666Z","steps":["trace[320334235] 'range keys from in-memory index tree' (duration: 748.242623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.519878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.826259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:48:02.523694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.775047Z","time spent":"748.640711ms","remote":"127.0.0.1:54960","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-04-28T13:48:02.523666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.670806Z","time spent":"852.84879ms","remote":"127.0.0.1:54952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-04-28T13:48:02.523707Z","caller":"traceutil/trace.go:171","msg":"trace[462328388] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:607; }","duration":"613.699293ms","start":"2026-04-28T13:48:01.909999Z","end":"2026-04-28T13:48:02.523698Z","steps":["trace[462328388] 'count revisions from in-memory index tree' (duration: 609.776968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.52373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.909991Z","time spent":"613.732314ms","remote":"127.0.0.1:54988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:48:02.523766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.608871Z","time spent":"914.889139ms","remote":"127.0.0.1:54930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:48:02.523821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.143887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.52384Z","caller":"traceutil/trace.go:171","msg":"trace[1263512380] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:607; }","duration":"138.098959ms","start":"2026-04-28T13:48:02.385736Z","end":"2026-04-28T13:48:02.523835Z","steps":["trace[1263512380] 'range keys from in-memory index tree' (duration: 136.137267ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:02.523842Z","caller":"traceutil/trace.go:171","msg":"trace[1635800084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"630.228618ms","start":"2026-04-28T13:48:01.893605Z","end":"2026-04-28T13:48:02.523834Z","steps":["trace[1635800084] 'range keys from in-memory index tree' (duration: 630.053415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.523859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.893581Z","time spent":"630.27266ms","remote":"127.0.0.1:43190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:48:02.523425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.354841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.523907Z","caller":"traceutil/trace.go:171","msg":"trace[91156055] 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:607; }","duration":"852.846961ms","start":"2026-04-28T13:48:01.671053Z","end":"2026-04-28T13:48:02.5239Z","steps":["trace[91156055] 'count revisions from in-memory index tree' (duration: 852.243038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.523436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.523205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.523946Z","caller":"traceutil/trace.go:171","msg":"trace[813619209] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:607; }","duration":"771.043956ms","start":"2026-04-28T13:48:01.752896Z","end":"2026-04-28T13:48:02.52394Z","steps":["trace[813619209] 'count revisions from in-memory index tree' (duration: 770.490785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.523971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.752891Z","time spent":"771.073827ms","remote":"127.0.0.1:54956","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:48:02.523457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.627617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.523823Z","caller":"traceutil/trace.go:171","msg":"trace[2006736505] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:607; }","duration":"877.27702ms","start":"2026-04-28T13:48:01.646541Z","end":"2026-04-28T13:48:02.523818Z","steps":["trace[2006736505] 'count revisions from in-memory index tree' (duration: 875.856269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.524118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.646525Z","time spent":"877.586777ms","remote":"127.0.0.1:54940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:48:02.52412Z","caller":"traceutil/trace.go:171","msg":"trace[357900876] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:607; }","duration":"771.294952ms","start":"2026-04-28T13:48:01.752788Z","end":"2026-04-28T13:48:02.524083Z","steps":["trace[357900876] 'range keys from in-memory index tree' (duration: 770.493224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.523474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.268924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.524178Z","caller":"traceutil/trace.go:171","msg":"trace[344464852] 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:607; }","duration":"749.02358ms","start":"2026-04-28T13:48:01.775142Z","end":"2026-04-28T13:48:02.524166Z","steps":["trace[344464852] 'count revisions from in-memory index tree' (duration: 748.217982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.524164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.752767Z","time spent":"771.383014ms","remote":"127.0.0.1:54956","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:48:02.52421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.77513Z","time spent":"749.070981ms","remote":"127.0.0.1:54960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"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\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:48:02.523541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.669995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.524266Z","caller":"traceutil/trace.go:171","msg":"trace[360134087] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:607; }","duration":"944.439582ms","start":"2026-04-28T13:48:01.579821Z","end":"2026-04-28T13:48:02.52426Z","steps":["trace[360134087] 'count revisions from in-memory index tree' (duration: 943.641944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.524285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.579796Z","time spent":"944.482543ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:48:02.523478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.4002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:48:02.523561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.780787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.524352Z","caller":"traceutil/trace.go:171","msg":"trace[1065046219] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:607; }","duration":"944.610816ms","start":"2026-04-28T13:48:01.579736Z","end":"2026-04-28T13:48:02.524347Z","steps":["trace[1065046219] 'range keys from in-memory index tree' (duration: 943.710386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.524371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.579715Z","time spent":"944.648226ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"info","ts":"2026-04-28T13:48:02.52437Z","caller":"traceutil/trace.go:171","msg":"trace[487510446] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:607; }","duration":"770.258588ms","start":"2026-04-28T13:48:01.754072Z","end":"2026-04-28T13:48:02.52433Z","steps":["trace[487510446] 'range keys from in-memory index tree' (duration: 769.269967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.523608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.898252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.524413Z","caller":"traceutil/trace.go:171","msg":"trace[1046418778] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:607; }","duration":"655.721901ms","start":"2026-04-28T13:48:01.868686Z","end":"2026-04-28T13:48:02.524408Z","steps":["trace[1046418778] 'count revisions from in-memory index tree' (duration: 654.853461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.524429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.868679Z","time spent":"655.744411ms","remote":"127.0.0.1:54984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:48:02.524407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.753983Z","time spent":"770.413262ms","remote":"127.0.0.1:54956","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:48:02.523639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.024345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.524484Z","caller":"traceutil/trace.go:171","msg":"trace[773542430] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:607; }","duration":"655.909915ms","start":"2026-04-28T13:48:01.86857Z","end":"2026-04-28T13:48:02.52448Z","steps":["trace[773542430] 'range keys from in-memory index tree' (duration: 654.860592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.524504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.868546Z","time spent":"655.952926ms","remote":"127.0.0.1:54984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:48:02.523556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.937105ms","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":"warn","ts":"2026-04-28T13:48:02.52364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.678961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.524551Z","caller":"traceutil/trace.go:171","msg":"trace[216337929] 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:607; }","duration":"748.965228ms","start":"2026-04-28T13:48:01.775578Z","end":"2026-04-28T13:48:02.524543Z","steps":["trace[216337929] 'range keys from in-memory index tree' (duration: 747.778562ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:02.524569Z","caller":"traceutil/trace.go:171","msg":"trace[969776908] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:607; }","duration":"700.621561ms","start":"2026-04-28T13:48:01.823941Z","end":"2026-04-28T13:48:02.524563Z","steps":["trace[969776908] 'range keys from in-memory index tree' (duration: 699.6484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.524577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.775542Z","time spent":"749.02704ms","remote":"127.0.0.1:54960","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-04-28T13:48:02.524586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.823938Z","time spent":"700.641942ms","remote":"127.0.0.1:54968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:48:02.524034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.024472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.525413Z","caller":"traceutil/trace.go:171","msg":"trace[1196461546] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:607; }","duration":"945.769541ms","start":"2026-04-28T13:48:01.579585Z","end":"2026-04-28T13:48:02.525354Z","steps":["trace[1196461546] 'range keys from in-memory index tree' (duration: 941.320623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.523929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.671047Z","time spent":"852.875742ms","remote":"127.0.0.1:54952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:48:02.52341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.609569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.525725Z","caller":"traceutil/trace.go:171","msg":"trace[1428146854] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:607; }","duration":"701.962772ms","start":"2026-04-28T13:48:01.823747Z","end":"2026-04-28T13:48:02.52571Z","steps":["trace[1428146854] 'range keys from in-memory index tree' (duration: 699.423475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.525799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.823728Z","time spent":"702.055213ms","remote":"127.0.0.1:54968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-28T13:48:02.525682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.579547Z","time spent":"946.110489ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-28T13:48:02.523589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.698981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:02.526215Z","caller":"traceutil/trace.go:171","msg":"trace[143410479] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:607; }","duration":"702.256617ms","start":"2026-04-28T13:48:01.823883Z","end":"2026-04-28T13:48:02.526139Z","steps":["trace[143410479] 'count revisions from in-memory index tree' (duration: 699.67103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:02.527667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:01.823867Z","time spent":"703.77372ms","remote":"127.0.0.1:54968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T13:48:03.685984Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15855096023495429956,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T13:48:03.880351Z","caller":"traceutil/trace.go:171","msg":"trace[761533697] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"696.416816ms","start":"2026-04-28T13:48:03.183898Z","end":"2026-04-28T13:48:03.880315Z","steps":["trace[761533697] 'process raft request' (duration: 695.68873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:03.880632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:03.183818Z","time spent":"696.712782ms","remote":"127.0.0.1:43452","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-04-28T13:48:04.351526Z","caller":"traceutil/trace.go:171","msg":"trace[1902154287] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.152915766s","start":"2026-04-28T13:48:03.198565Z","end":"2026-04-28T13:48:04.351481Z","steps":["trace[1902154287] 'process raft request' (duration: 1.15220796s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:04.351737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:03.198516Z","time spent":"1.153111489s","remote":"127.0.0.1:43290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:48:04.366701Z","caller":"traceutil/trace.go:171","msg":"trace[105466510] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:639; }","duration":"1.181407675s","start":"2026-04-28T13:48:03.185253Z","end":"2026-04-28T13:48:04.366661Z","steps":["trace[105466510] 'read index received' (duration: 694.369661ms)","trace[105466510] 'applied index is now lower than readState.Index' (duration: 487.037004ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:48:04.36674Z","caller":"traceutil/trace.go:171","msg":"trace[1195048033] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.104348136s","start":"2026-04-28T13:48:03.262348Z","end":"2026-04-28T13:48:04.366696Z","steps":["trace[1195048033] 'process raft request' (duration: 1.088927031s)","trace[1195048033] 'compare' (duration: 15.21614ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:48:04.366931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:03.262308Z","time spent":"1.104523179s","remote":"127.0.0.1:43452","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-04-28T13:48:04.36704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.181759463s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-28T13:48:04.367081Z","caller":"traceutil/trace.go:171","msg":"trace[622388578] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"1.181898005s","start":"2026-04-28T13:48:03.18517Z","end":"2026-04-28T13:48:04.367068Z","steps":["trace[622388578] 'agreement among raft nodes before linearized reading' (duration: 1.181673721s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:04.36709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040458351s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-28T13:48:04.367121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:03.185123Z","time spent":"1.181988317s","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T13:48:04.367091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.027884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:04.367161Z","caller":"traceutil/trace.go:171","msg":"trace[714747302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"1.040578384s","start":"2026-04-28T13:48:03.326563Z","end":"2026-04-28T13:48:04.367141Z","steps":["trace[714747302] 'agreement among raft nodes before linearized reading' (duration: 1.040315019s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:04.367187Z","caller":"traceutil/trace.go:171","msg":"trace[1642963344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"476.169816ms","start":"2026-04-28T13:48:03.89099Z","end":"2026-04-28T13:48:04.36716Z","steps":["trace[1642963344] 'agreement among raft nodes before linearized reading' (duration: 476.022283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:04.367211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:03.32654Z","time spent":"1.040657106s","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T13:48:04.367236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:03.890971Z","time spent":"476.25637ms","remote":"127.0.0.1:43190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:48:04.367252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.931274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.35\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-28T13:48:04.367276Z","caller":"traceutil/trace.go:171","msg":"trace[1840673941] range","detail":"{range_begin:/registry/masterleases/199.19.213.35; range_end:; response_count:1; response_revision:613; }","duration":"104.005725ms","start":"2026-04-28T13:48:04.263263Z","end":"2026-04-28T13:48:04.367269Z","steps":["trace[1840673941] 'agreement among raft nodes before linearized reading' (duration: 103.958725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:04.367413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.670869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:48:04.367455Z","caller":"traceutil/trace.go:171","msg":"trace[100342752] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:613; }","duration":"892.755831ms","start":"2026-04-28T13:48:03.474686Z","end":"2026-04-28T13:48:04.367442Z","steps":["trace[100342752] 'agreement among raft nodes before linearized reading' (duration: 892.629788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:04.36749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:03.474657Z","time spent":"892.823642ms","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T13:48:04.66218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.619339ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-04-28T13:48:04.662472Z","caller":"traceutil/trace.go:171","msg":"trace[1307641236] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:642; }","duration":"219.712413ms","start":"2026-04-28T13:48:04.442744Z","end":"2026-04-28T13:48:04.662456Z","steps":["trace[1307641236] 'read index received' (duration: 18.800818ms)","trace[1307641236] 'applied index is now lower than readState.Index' (duration: 200.910795ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:48:04.662542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.789685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:04.66256Z","caller":"traceutil/trace.go:171","msg":"trace[2034188688] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:616; }","duration":"219.855746ms","start":"2026-04-28T13:48:04.442695Z","end":"2026-04-28T13:48:04.66255Z","steps":["trace[2034188688] 'agreement among raft nodes before linearized reading' (duration: 219.800765ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:04.662576Z","caller":"traceutil/trace.go:171","msg":"trace[1959375419] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"289.093217ms","start":"2026-04-28T13:48:04.373429Z","end":"2026-04-28T13:48:04.662522Z","steps":["trace[1959375419] 'process raft request' (duration: 288.984475ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:04.662566Z","caller":"traceutil/trace.go:171","msg":"trace[2135378605] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"289.074276ms","start":"2026-04-28T13:48:04.373466Z","end":"2026-04-28T13:48:04.662541Z","steps":["trace[2135378605] 'process raft request' (duration: 288.967524ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:04.662687Z","caller":"traceutil/trace.go:171","msg":"trace[592188189] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"289.233549ms","start":"2026-04-28T13:48:04.373347Z","end":"2026-04-28T13:48:04.662581Z","steps":["trace[592188189] 'process raft request' (duration: 288.943233ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:05.83273Z","caller":"traceutil/trace.go:171","msg":"trace[1192721838] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"109.287435ms","start":"2026-04-28T13:48:05.723406Z","end":"2026-04-28T13:48:05.832693Z","steps":["trace[1192721838] 'process raft request' (duration: 79.497713ms)","trace[1192721838] 'compare' (duration: 28.970474ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:48:10.800959Z","caller":"traceutil/trace.go:171","msg":"trace[1720161410] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"155.737713ms","start":"2026-04-28T13:48:10.645172Z","end":"2026-04-28T13:48:10.80091Z","steps":["trace[1720161410] 'process raft request' (duration: 155.10187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:11.392175Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15855096023495430035,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:48:12.591356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.948485ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:48:12.591486Z","caller":"traceutil/trace.go:171","msg":"trace[1803154625] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"1.786087849s","start":"2026-04-28T13:48:10.805377Z","end":"2026-04-28T13:48:12.591465Z","steps":["trace[1803154625] 'process raft request' (duration: 890.91774ms)","trace[1803154625] 'compare' (duration: 894.777261ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:48:12.591559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:10.805353Z","time spent":"1.786176701s","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:48:12.891812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000085015s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-28T13:48:12.891947Z","caller":"traceutil/trace.go:171","msg":"trace[1316147941] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000289709s","start":"2026-04-28T13:48:10.891627Z","end":"2026-04-28T13:48:12.891917Z","steps":["trace[1316147941] 'agreement among raft nodes before linearized reading' (duration: 2.000126446s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:12.892023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:10.891603Z","time spent":"2.000401512s","remote":"127.0.0.1:43200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/28 13:48:12 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-28T13:48:14.074037Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.377674524s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-28T13:48:14.234268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.842098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:48:14.234553Z","caller":"traceutil/trace.go:171","msg":"trace[1996598132] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"3.428626856s","start":"2026-04-28T13:48:10.805905Z","end":"2026-04-28T13:48:14.234532Z","steps":["trace[1996598132] 'process raft request' (duration: 3.428485793s)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:14.234594Z","caller":"traceutil/trace.go:171","msg":"trace[1502866885] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"3.428936552s","start":"2026-04-28T13:48:10.805603Z","end":"2026-04-28T13:48:14.23454Z","steps":["trace[1502866885] 'process raft request' (duration: 3.268691665s)","trace[1502866885] 'compare' (duration: 158.290247ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:48:14.234654Z","caller":"traceutil/trace.go:171","msg":"trace[217614930] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:680; }","duration":"3.342917429s","start":"2026-04-28T13:48:10.891691Z","end":"2026-04-28T13:48:14.234608Z","steps":["trace[217614930] 'read index received' (duration: 804.649232ms)","trace[217614930] 'applied index is now lower than readState.Index' (duration: 2.538265387s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:48:14.234841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:10.805578Z","time spent":"3.429139897s","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:48:14.234631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:10.805896Z","time spent":"3.428699557s","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:48:14.234842Z","caller":"traceutil/trace.go:171","msg":"trace[2016043309] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"2.774740235s","start":"2026-04-28T13:48:11.46006Z","end":"2026-04-28T13:48:14.234801Z","steps":["trace[2016043309] 'process raft request' (duration: 2.774429889s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:14.235275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:11.46003Z","time spent":"2.775188395s","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:48:14.491732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.945343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:48:14.491874Z","caller":"traceutil/trace.go:171","msg":"trace[1694480381] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"257.120943ms","start":"2026-04-28T13:48:14.234733Z","end":"2026-04-28T13:48:14.491854Z","steps":["trace[1694480381] 'read index received' (duration: 109.864034ms)","trace[1694480381] 'applied index is now lower than readState.Index' (duration: 147.255289ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:48:14.491978Z","caller":"traceutil/trace.go:171","msg":"trace[1648305494] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"1.595856363s","start":"2026-04-28T13:48:12.89611Z","end":"2026-04-28T13:48:14.491966Z","steps":["trace[1648305494] 'process raft request' (duration: 1.448589893s)","trace[1648305494] 'compare' (duration: 146.759339ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:48:14.492039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:12.896075Z","time spent":"1.595939845s","remote":"127.0.0.1:43272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:48:14.49228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.592158166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:14.492385Z","caller":"traceutil/trace.go:171","msg":"trace[1400194598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:654; }","duration":"1.592328659s","start":"2026-04-28T13:48:12.900029Z","end":"2026-04-28T13:48:14.492358Z","steps":["trace[1400194598] 'agreement among raft nodes before linearized reading' (duration: 1.592147676s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:14.492397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.921527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.35\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-28T13:48:14.492468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:12.900006Z","time spent":"1.592442771s","remote":"127.0.0.1:43190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T13:48:14.492287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.572267491s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:48:14.492517Z","caller":"traceutil/trace.go:171","msg":"trace[1409655378] range","detail":"{range_begin:/registry/masterleases/199.19.213.35; range_end:; response_count:1; response_revision:654; }","duration":"234.102201ms","start":"2026-04-28T13:48:14.258383Z","end":"2026-04-28T13:48:14.492486Z","steps":["trace[1409655378] 'agreement among raft nodes before linearized reading' (duration: 233.707803ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:14.492533Z","caller":"traceutil/trace.go:171","msg":"trace[621806291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:654; }","duration":"2.572640007s","start":"2026-04-28T13:48:11.919877Z","end":"2026-04-28T13:48:14.492517Z","steps":["trace[621806291] 'agreement among raft nodes before linearized reading' (duration: 2.572152038s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:14.492598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:11.919852Z","time spent":"2.57272075s","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T13:48:14.624155Z","caller":"traceutil/trace.go:171","msg":"trace[785330017] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:686; }","duration":"122.610264ms","start":"2026-04-28T13:48:14.501516Z","end":"2026-04-28T13:48:14.624126Z","steps":["trace[785330017] 'read index received' (duration: 76.782595ms)","trace[785330017] 'applied index is now lower than readState.Index' (duration: 45.826639ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:48:14.624491Z","caller":"traceutil/trace.go:171","msg":"trace[332151330] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"126.590356ms","start":"2026-04-28T13:48:14.497891Z","end":"2026-04-28T13:48:14.624481Z","steps":["trace[332151330] 'process raft request' (duration: 126.014984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:14.625089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.513803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:14.625661Z","caller":"traceutil/trace.go:171","msg":"trace[1488866865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:656; }","duration":"124.131095ms","start":"2026-04-28T13:48:14.50145Z","end":"2026-04-28T13:48:14.625581Z","steps":["trace[1488866865] 'agreement among raft nodes before linearized reading' (duration: 123.316858ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:16.390872Z","caller":"traceutil/trace.go:171","msg":"trace[1064060463] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"144.964032ms","start":"2026-04-28T13:48:16.245878Z","end":"2026-04-28T13:48:16.390842Z","steps":["trace[1064060463] 'process raft request' (duration: 144.777839ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:16.400962Z","caller":"traceutil/trace.go:171","msg":"trace[1102557353] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"154.645999ms","start":"2026-04-28T13:48:16.246288Z","end":"2026-04-28T13:48:16.400934Z","steps":["trace[1102557353] 'process raft request' (duration: 154.489146ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:16.737795Z","caller":"traceutil/trace.go:171","msg":"trace[1296272325] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"102.932409ms","start":"2026-04-28T13:48:16.634817Z","end":"2026-04-28T13:48:16.73775Z","steps":["trace[1296272325] 'process raft request' (duration: 102.721225ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:16.862559Z","caller":"traceutil/trace.go:171","msg":"trace[675625559] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:701; }","duration":"124.844114ms","start":"2026-04-28T13:48:16.737685Z","end":"2026-04-28T13:48:16.862529Z","steps":["trace[675625559] 'read index received' (duration: 124.762462ms)","trace[675625559] 'applied index is now lower than readState.Index' (duration: 80.522µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:48:16.862607Z","caller":"traceutil/trace.go:171","msg":"trace[291654058] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"192.456135ms","start":"2026-04-28T13:48:16.670108Z","end":"2026-04-28T13:48:16.862564Z","steps":["trace[291654058] 'process raft request' (duration: 192.259321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:16.862899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.09938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-28T13:48:16.863036Z","caller":"traceutil/trace.go:171","msg":"trace[1671815993] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:670; }","duration":"131.315174ms","start":"2026-04-28T13:48:16.731692Z","end":"2026-04-28T13:48:16.863007Z","steps":["trace[1671815993] 'agreement among raft nodes before linearized reading' (duration: 130.948977ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:16.961118Z","caller":"traceutil/trace.go:171","msg":"trace[19430593] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"209.43445ms","start":"2026-04-28T13:48:16.751645Z","end":"2026-04-28T13:48:16.961079Z","steps":["trace[19430593] 'process raft request' (duration: 208.958471ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:17.747745Z","caller":"traceutil/trace.go:171","msg":"trace[948089959] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"581.516772ms","start":"2026-04-28T13:48:17.166206Z","end":"2026-04-28T13:48:17.747722Z","steps":["trace[948089959] 'process raft request' (duration: 580.93291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:17.747868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:17.166147Z","time spent":"581.662715ms","remote":"127.0.0.1:43272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:48:19.849786Z","caller":"traceutil/trace.go:171","msg":"trace[2117905313] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"137.108441ms","start":"2026-04-28T13:48:19.712641Z","end":"2026-04-28T13:48:19.849749Z","steps":["trace[2117905313] 'process raft request' (duration: 83.381837ms)","trace[2117905313] 'compare' (duration: 53.346506ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:48:20.250073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.587371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:48:20.250237Z","caller":"traceutil/trace.go:171","msg":"trace[199878681] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:722; }","duration":"184.769615ms","start":"2026-04-28T13:48:20.065437Z","end":"2026-04-28T13:48:20.250207Z","steps":["trace[199878681] 'range keys from in-memory index tree' (duration: 184.338565ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:21.703644Z","caller":"traceutil/trace.go:171","msg":"trace[831302621] linearizableReadLoop","detail":"{readStateIndex:770; appliedIndex:769; }","duration":"160.721132ms","start":"2026-04-28T13:48:21.542881Z","end":"2026-04-28T13:48:21.703602Z","steps":["trace[831302621] 'read index received' (duration: 94.95016ms)","trace[831302621] 'applied index is now lower than readState.Index' (duration: 65.769572ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:48:21.703872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.944587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:21.703846Z","caller":"traceutil/trace.go:171","msg":"trace[1797351072] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"161.576709ms","start":"2026-04-28T13:48:21.542234Z","end":"2026-04-28T13:48:21.703811Z","steps":["trace[1797351072] 'process raft request' (duration: 95.564563ms)","trace[1797351072] 'compare' (duration: 65.633648ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:48:21.703919Z","caller":"traceutil/trace.go:171","msg":"trace[229152636] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:737; }","duration":"161.057568ms","start":"2026-04-28T13:48:21.542849Z","end":"2026-04-28T13:48:21.703907Z","steps":["trace[229152636] 'agreement among raft nodes before linearized reading' (duration: 160.934746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:21.715826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.836612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:21.715937Z","caller":"traceutil/trace.go:171","msg":"trace[1938983935] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:738; }","duration":"173.024395ms","start":"2026-04-28T13:48:21.542885Z","end":"2026-04-28T13:48:21.715909Z","steps":["trace[1938983935] 'agreement among raft nodes before linearized reading' (duration: 172.75121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:21.716176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.192878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:21.71629Z","caller":"traceutil/trace.go:171","msg":"trace[424075189] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:738; }","duration":"172.338402ms","start":"2026-04-28T13:48:21.543898Z","end":"2026-04-28T13:48:21.716237Z","steps":["trace[424075189] 'agreement among raft nodes before linearized reading' (duration: 172.179239ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:21.844745Z","caller":"traceutil/trace.go:171","msg":"trace[1841261190] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"106.953016ms","start":"2026-04-28T13:48:21.737758Z","end":"2026-04-28T13:48:21.844711Z","steps":["trace[1841261190] 'process raft request' (duration: 105.877896ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:21.849964Z","caller":"traceutil/trace.go:171","msg":"trace[1056310460] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"107.244724ms","start":"2026-04-28T13:48:21.742704Z","end":"2026-04-28T13:48:21.849948Z","steps":["trace[1056310460] 'process raft request' (duration: 106.630821ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:24.828637Z","caller":"traceutil/trace.go:171","msg":"trace[641428489] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"205.668793ms","start":"2026-04-28T13:48:24.622921Z","end":"2026-04-28T13:48:24.82859Z","steps":["trace[641428489] 'process raft request' (duration: 205.431969ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:32.393587Z","caller":"traceutil/trace.go:171","msg":"trace[1260735629] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"740.491373ms","start":"2026-04-28T13:48:31.653062Z","end":"2026-04-28T13:48:32.393553Z","steps":["trace[1260735629] 'process raft request' (duration: 739.685728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:32.393866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:31.653037Z","time spent":"740.650805ms","remote":"127.0.0.1:43370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4904,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:48:32.409902Z","caller":"traceutil/trace.go:171","msg":"trace[88514813] linearizableReadLoop","detail":"{readStateIndex:854; appliedIndex:852; }","duration":"349.887172ms","start":"2026-04-28T13:48:32.059993Z","end":"2026-04-28T13:48:32.40988Z","steps":["trace[88514813] 'read index received' (duration: 332.75063ms)","trace[88514813] 'applied index is now lower than readState.Index' (duration: 17.135662ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:48:32.410044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.037434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:32.410075Z","caller":"traceutil/trace.go:171","msg":"trace[656186527] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:817; }","duration":"350.129328ms","start":"2026-04-28T13:48:32.059939Z","end":"2026-04-28T13:48:32.410068Z","steps":["trace[656186527] 'agreement among raft nodes before linearized reading' (duration: 350.055566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:32.410101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:32.059916Z","time spent":"350.177819ms","remote":"127.0.0.1:43582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":29,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:48:32.41003Z","caller":"traceutil/trace.go:171","msg":"trace[1692460998] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"581.129809ms","start":"2026-04-28T13:48:31.82886Z","end":"2026-04-28T13:48:32.40999Z","steps":["trace[1692460998] 'process raft request' (duration: 580.907355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:32.410293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.115989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:48:32.410352Z","caller":"traceutil/trace.go:171","msg":"trace[1436599425] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:817; }","duration":"214.222931ms","start":"2026-04-28T13:48:32.19612Z","end":"2026-04-28T13:48:32.410343Z","steps":["trace[1436599425] 'agreement among raft nodes before linearized reading' (duration: 213.916606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:48:32.4107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:48:31.828838Z","time spent":"581.371605ms","remote":"127.0.0.1:43432","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-04-28T13:48:40.435008Z","caller":"traceutil/trace.go:171","msg":"trace[1309580771] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"167.977349ms","start":"2026-04-28T13:48:40.267004Z","end":"2026-04-28T13:48:40.434982Z","steps":["trace[1309580771] 'process raft request' (duration: 167.817816ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:43.215603Z","caller":"traceutil/trace.go:171","msg":"trace[943146318] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"140.731212ms","start":"2026-04-28T13:48:43.074827Z","end":"2026-04-28T13:48:43.215559Z","steps":["trace[943146318] 'process raft request' (duration: 71.631779ms)","trace[943146318] 'compare' (duration: 68.713346ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:48:43.215814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.680334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-28T13:48:43.215885Z","caller":"traceutil/trace.go:171","msg":"trace[1068623448] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:941; }","duration":"119.803695ms","start":"2026-04-28T13:48:43.096066Z","end":"2026-04-28T13:48:43.21587Z","steps":["trace[1068623448] 'agreement among raft nodes before linearized reading' (duration: 119.617162ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:48:43.215434Z","caller":"traceutil/trace.go:171","msg":"trace[1383371790] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:979; }","duration":"119.280047ms","start":"2026-04-28T13:48:43.096123Z","end":"2026-04-28T13:48:43.215404Z","steps":["trace[1383371790] 'read index received' (duration: 50.232664ms)","trace[1383371790] 'applied index is now lower than readState.Index' (duration: 69.043073ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:49:13.501419Z","caller":"traceutil/trace.go:171","msg":"trace[1000440092] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"101.893708ms","start":"2026-04-28T13:49:13.399485Z","end":"2026-04-28T13:49:13.501378Z","steps":["trace[1000440092] 'process raft request' (duration: 97.007038ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:23.751658Z","caller":"traceutil/trace.go:171","msg":"trace[927263920] linearizableReadLoop","detail":"{readStateIndex:1168; appliedIndex:1167; }","duration":"205.497601ms","start":"2026-04-28T13:49:23.546133Z","end":"2026-04-28T13:49:23.751631Z","steps":["trace[927263920] 'read index received' (duration: 205.202846ms)","trace[927263920] 'applied index is now lower than readState.Index' (duration: 293.625µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:49:23.751782Z","caller":"traceutil/trace.go:171","msg":"trace[1791037628] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"247.803417ms","start":"2026-04-28T13:49:23.503951Z","end":"2026-04-28T13:49:23.751754Z","steps":["trace[1791037628] 'process raft request' (duration: 247.526452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:49:23.751876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.720835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-28T13:49:23.751915Z","caller":"traceutil/trace.go:171","msg":"trace[71108226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1120; }","duration":"205.824797ms","start":"2026-04-28T13:49:23.54608Z","end":"2026-04-28T13:49:23.751905Z","steps":["trace[71108226] 'agreement among raft nodes before linearized reading' (duration: 205.653454ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:36.601217Z","caller":"traceutil/trace.go:171","msg":"trace[34435192] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"120.97773ms","start":"2026-04-28T13:49:36.480215Z","end":"2026-04-28T13:49:36.601193Z","steps":["trace[34435192] 'process raft request' (duration: 120.864057ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:47.441613Z","caller":"traceutil/trace.go:171","msg":"trace[2058469132] linearizableReadLoop","detail":"{readStateIndex:1251; appliedIndex:1250; }","duration":"162.594737ms","start":"2026-04-28T13:49:47.278991Z","end":"2026-04-28T13:49:47.441586Z","steps":["trace[2058469132] 'read index received' (duration: 162.368814ms)","trace[2058469132] 'applied index is now lower than readState.Index' (duration: 225.033µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:49:47.441676Z","caller":"traceutil/trace.go:171","msg":"trace[975097571] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"163.914398ms","start":"2026-04-28T13:49:47.277721Z","end":"2026-04-28T13:49:47.441636Z","steps":["trace[975097571] 'process raft request' (duration: 163.707565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:49:47.441893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.888241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:49:47.441969Z","caller":"traceutil/trace.go:171","msg":"trace[485255105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1198; }","duration":"163.012744ms","start":"2026-04-28T13:49:47.278941Z","end":"2026-04-28T13:49:47.441954Z","steps":["trace[485255105] 'agreement among raft nodes before linearized reading' (duration: 162.75874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:49:47.442005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.104288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:49:47.442055Z","caller":"traceutil/trace.go:171","msg":"trace[628573253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1198; }","duration":"156.1936ms","start":"2026-04-28T13:49:47.285849Z","end":"2026-04-28T13:49:47.442043Z","steps":["trace[628573253] 'agreement among raft nodes before linearized reading' (duration: 155.901705ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:48.04799Z","caller":"traceutil/trace.go:171","msg":"trace[2135353113] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"130.407126ms","start":"2026-04-28T13:49:47.917553Z","end":"2026-04-28T13:49:48.04796Z","steps":["trace[2135353113] 'process raft request' (duration: 130.240534ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:53.379244Z","caller":"traceutil/trace.go:171","msg":"trace[1183529669] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"110.404346ms","start":"2026-04-28T13:49:53.268817Z","end":"2026-04-28T13:49:53.379221Z","steps":["trace[1183529669] 'process raft request' (duration: 110.260284ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:53.602003Z","caller":"traceutil/trace.go:171","msg":"trace[2134738040] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1269; }","duration":"127.23848ms","start":"2026-04-28T13:49:53.474735Z","end":"2026-04-28T13:49:53.601974Z","steps":["trace[2134738040] 'read index received' (duration: 126.916216ms)","trace[2134738040] 'applied index is now lower than readState.Index' (duration: 321.004µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:49:53.602073Z","caller":"traceutil/trace.go:171","msg":"trace[1281531923] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"139.941613ms","start":"2026-04-28T13:49:53.462086Z","end":"2026-04-28T13:49:53.602027Z","steps":["trace[1281531923] 'process raft request' (duration: 139.705309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:49:53.602279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.577686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T13:49:53.602329Z","caller":"traceutil/trace.go:171","msg":"trace[892276426] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1216; }","duration":"127.710417ms","start":"2026-04-28T13:49:53.474607Z","end":"2026-04-28T13:49:53.602318Z","steps":["trace[892276426] 'agreement among raft nodes before linearized reading' (duration: 127.511234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:49:53.602557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.895145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:49:53.602627Z","caller":"traceutil/trace.go:171","msg":"trace[306720541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1216; }","duration":"127.007237ms","start":"2026-04-28T13:49:53.475602Z","end":"2026-04-28T13:49:53.602609Z","steps":["trace[306720541] 'agreement among raft nodes before linearized reading' (duration: 126.814784ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:54.533337Z","caller":"traceutil/trace.go:171","msg":"trace[58112423] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"106.947372ms","start":"2026-04-28T13:49:54.426354Z","end":"2026-04-28T13:49:54.533301Z","steps":["trace[58112423] 'process raft request' (duration: 106.487635ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:49:56.257267Z","caller":"traceutil/trace.go:171","msg":"trace[496858619] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"122.845556ms","start":"2026-04-28T13:49:56.134386Z","end":"2026-04-28T13:49:56.257232Z","steps":["trace[496858619] 'process raft request' (duration: 122.642103ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:01.872098Z","caller":"traceutil/trace.go:171","msg":"trace[1199734304] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"164.401723ms","start":"2026-04-28T13:50:01.707675Z","end":"2026-04-28T13:50:01.872077Z","steps":["trace[1199734304] 'process raft request' (duration: 163.929726ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:01.882651Z","caller":"traceutil/trace.go:171","msg":"trace[975073746] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"173.269435ms","start":"2026-04-28T13:50:01.709354Z","end":"2026-04-28T13:50:01.882623Z","steps":["trace[975073746] 'process raft request' (duration: 173.124383ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:02.448078Z","caller":"traceutil/trace.go:171","msg":"trace[326087055] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"143.680432ms","start":"2026-04-28T13:50:02.304366Z","end":"2026-04-28T13:50:02.448047Z","steps":["trace[326087055] 'process raft request' (duration: 91.755628ms)","trace[326087055] 'compare' (duration: 51.789692ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:04.021227Z","caller":"traceutil/trace.go:171","msg":"trace[648772532] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1304; }","duration":"166.072602ms","start":"2026-04-28T13:50:03.85512Z","end":"2026-04-28T13:50:04.021193Z","steps":["trace[648772532] 'read index received' (duration: 165.725377ms)","trace[648772532] 'applied index is now lower than readState.Index' (duration: 345.785µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:04.021661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.344454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-28T13:50:04.021717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.429387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:04.021759Z","caller":"traceutil/trace.go:171","msg":"trace[1305562631] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1249; }","duration":"143.510086ms","start":"2026-04-28T13:50:03.878224Z","end":"2026-04-28T13:50:04.021734Z","steps":["trace[1305562631] 'agreement among raft nodes before linearized reading' (duration: 143.224022ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:04.021835Z","caller":"traceutil/trace.go:171","msg":"trace[1592588337] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1249; }","duration":"127.530468ms","start":"2026-04-28T13:50:03.894252Z","end":"2026-04-28T13:50:04.021783Z","steps":["trace[1592588337] 'agreement among raft nodes before linearized reading' (duration: 127.425796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:04.021906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.152302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:50:04.022004Z","caller":"traceutil/trace.go:171","msg":"trace[2063142683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1249; }","duration":"135.279653ms","start":"2026-04-28T13:50:03.886705Z","end":"2026-04-28T13:50:04.021985Z","steps":["trace[2063142683] 'agreement among raft nodes before linearized reading' (duration: 135.02168ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:04.022244Z","caller":"traceutil/trace.go:171","msg":"trace[755533093] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"313.307365ms","start":"2026-04-28T13:50:03.708915Z","end":"2026-04-28T13:50:04.022223Z","steps":["trace[755533093] 'process raft request' (duration: 312.022745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:04.022358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:03.708894Z","time spent":"313.393875ms","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:50:04.021532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.393937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T13:50:04.022573Z","caller":"traceutil/trace.go:171","msg":"trace[699831292] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1249; }","duration":"167.507793ms","start":"2026-04-28T13:50:03.855053Z","end":"2026-04-28T13:50:04.02256Z","steps":["trace[699831292] 'agreement among raft nodes before linearized reading' (duration: 166.347876ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:04.427812Z","caller":"traceutil/trace.go:171","msg":"trace[2089946748] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"146.630721ms","start":"2026-04-28T13:50:04.281069Z","end":"2026-04-28T13:50:04.4277Z","steps":["trace[2089946748] 'process raft request' (duration: 84.430696ms)","trace[2089946748] 'compare' (duration: 61.979152ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:25.377985Z","caller":"traceutil/trace.go:171","msg":"trace[887324480] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"147.732126ms","start":"2026-04-28T13:50:25.23023Z","end":"2026-04-28T13:50:25.377962Z","steps":["trace[887324480] 'process raft request' (duration: 147.578824ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:26.871131Z","caller":"traceutil/trace.go:171","msg":"trace[1939255252] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"110.044007ms","start":"2026-04-28T13:50:26.761053Z","end":"2026-04-28T13:50:26.871097Z","steps":["trace[1939255252] 'process raft request' (duration: 109.841814ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:29.236149Z","caller":"traceutil/trace.go:171","msg":"trace[1539396505] linearizableReadLoop","detail":"{readStateIndex:1427; appliedIndex:1426; }","duration":"342.206983ms","start":"2026-04-28T13:50:28.89392Z","end":"2026-04-28T13:50:29.236127Z","steps":["trace[1539396505] 'read index received' (duration: 342.060751ms)","trace[1539396505] 'applied index is now lower than readState.Index' (duration: 145.732µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:29.236224Z","caller":"traceutil/trace.go:171","msg":"trace[659170701] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"354.119186ms","start":"2026-04-28T13:50:28.882079Z","end":"2026-04-28T13:50:29.236198Z","steps":["trace[659170701] 'process raft request' (duration: 353.892103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:29.236438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:28.882039Z","time spent":"354.314969ms","remote":"127.0.0.1:43452","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-04-28T13:50:29.236423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.470898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:50:29.236478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.951376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T13:50:29.236569Z","caller":"traceutil/trace.go:171","msg":"trace[795015559] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1365; }","duration":"214.157509ms","start":"2026-04-28T13:50:29.022392Z","end":"2026-04-28T13:50:29.236549Z","steps":["trace[795015559] 'agreement among raft nodes before linearized reading' (duration: 213.981896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:29.23655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.448249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T13:50:29.236643Z","caller":"traceutil/trace.go:171","msg":"trace[681042899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1365; }","duration":"342.661911ms","start":"2026-04-28T13:50:28.893862Z","end":"2026-04-28T13:50:29.236524Z","steps":["trace[681042899] 'agreement among raft nodes before linearized reading' (duration: 342.416246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:29.236693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:28.893838Z","time spent":"342.846294ms","remote":"127.0.0.1:43190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-28T13:50:29.236664Z","caller":"traceutil/trace.go:171","msg":"trace[1964157495] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1365; }","duration":"177.61237ms","start":"2026-04-28T13:50:29.059035Z","end":"2026-04-28T13:50:29.236648Z","steps":["trace[1964157495] 'agreement among raft nodes before linearized reading' (duration: 177.345296ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:36.431017Z","caller":"traceutil/trace.go:171","msg":"trace[24961670] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"127.970081ms","start":"2026-04-28T13:50:36.303023Z","end":"2026-04-28T13:50:36.430993Z","steps":["trace[24961670] 'process raft request' (duration: 127.664827ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:36.436617Z","caller":"traceutil/trace.go:171","msg":"trace[864058924] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"131.963038ms","start":"2026-04-28T13:50:36.304628Z","end":"2026-04-28T13:50:36.436591Z","steps":["trace[864058924] 'process raft request' (duration: 131.777016ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:37.052387Z","caller":"traceutil/trace.go:171","msg":"trace[1111667400] transaction","detail":"{read_only:false; response_revision:1397; number_of_response:1; }","duration":"158.259826ms","start":"2026-04-28T13:50:36.894094Z","end":"2026-04-28T13:50:37.052354Z","steps":["trace[1111667400] 'process raft request' (duration: 158.065012ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:37.052933Z","caller":"traceutil/trace.go:171","msg":"trace[1913269022] linearizableReadLoop","detail":"{readStateIndex:1461; appliedIndex:1461; }","duration":"156.478431ms","start":"2026-04-28T13:50:36.896436Z","end":"2026-04-28T13:50:37.052914Z","steps":["trace[1913269022] 'read index received' (duration: 156.466581ms)","trace[1913269022] 'applied index is now lower than readState.Index' (duration: 9.34µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:37.053052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.600493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:37.053092Z","caller":"traceutil/trace.go:171","msg":"trace[1022611059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1397; }","duration":"156.712814ms","start":"2026-04-28T13:50:36.896369Z","end":"2026-04-28T13:50:37.053081Z","steps":["trace[1022611059] 'agreement among raft nodes before linearized reading' (duration: 156.620443ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:45.459123Z","caller":"traceutil/trace.go:171","msg":"trace[361873593] linearizableReadLoop","detail":"{readStateIndex:1494; appliedIndex:1493; }","duration":"134.601373ms","start":"2026-04-28T13:50:45.324498Z","end":"2026-04-28T13:50:45.4591Z","steps":["trace[361873593] 'read index received' (duration: 134.472422ms)","trace[361873593] 'applied index is now lower than readState.Index' (duration: 127.431µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:45.459245Z","caller":"traceutil/trace.go:171","msg":"trace[85490670] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"138.687002ms","start":"2026-04-28T13:50:45.320514Z","end":"2026-04-28T13:50:45.459201Z","steps":["trace[85490670] 'process raft request' (duration: 138.407678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:45.459353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.805066ms","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-04-28T13:50:45.459459Z","caller":"traceutil/trace.go:171","msg":"trace[463989210] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1428; }","duration":"134.957168ms","start":"2026-04-28T13:50:45.324478Z","end":"2026-04-28T13:50:45.459435Z","steps":["trace[463989210] 'agreement among raft nodes before linearized reading' (duration: 134.757495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:45.459575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.702716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient\" ","response":"range_response_count:1 size:718"} {"level":"info","ts":"2026-04-28T13:50:45.459614Z","caller":"traceutil/trace.go:171","msg":"trace[2078635173] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient; range_end:; response_count:1; response_revision:1428; }","duration":"132.762598ms","start":"2026-04-28T13:50:45.326841Z","end":"2026-04-28T13:50:45.459604Z","steps":["trace[2078635173] 'agreement among raft nodes before linearized reading' (duration: 132.449983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:47.484594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.88275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:generic-garbage-collector\" ","response":"range_response_count:1 size:693"} {"level":"info","ts":"2026-04-28T13:50:47.484701Z","caller":"traceutil/trace.go:171","msg":"trace[460682409] range","detail":"{range_begin:/registry/clusterroles/system:controller:generic-garbage-collector; range_end:; response_count:1; response_revision:1434; }","duration":"134.069683ms","start":"2026-04-28T13:50:47.350606Z","end":"2026-04-28T13:50:47.484675Z","steps":["trace[460682409] 'range keys from in-memory index tree' (duration: 133.706058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:47.484966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.895171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cluster-admin\" ","response":"range_response_count:1 size:679"} {"level":"info","ts":"2026-04-28T13:50:47.485054Z","caller":"traceutil/trace.go:171","msg":"trace[732654878] range","detail":"{range_begin:/registry/clusterrolebindings/cluster-admin; range_end:; response_count:1; response_revision:1434; }","duration":"176.040142ms","start":"2026-04-28T13:50:47.308995Z","end":"2026-04-28T13:50:47.485035Z","steps":["trace[732654878] 'range keys from in-memory index tree' (duration: 175.421024ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:48.238119Z","caller":"traceutil/trace.go:171","msg":"trace[1652241205] linearizableReadLoop","detail":"{readStateIndex:1502; appliedIndex:1501; }","duration":"263.435587ms","start":"2026-04-28T13:50:47.974646Z","end":"2026-04-28T13:50:48.238082Z","steps":["trace[1652241205] 'read index received' (duration: 263.067642ms)","trace[1652241205] 'applied index is now lower than readState.Index' (duration: 366.405µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:48.23824Z","caller":"traceutil/trace.go:171","msg":"trace[432163899] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"276.96212ms","start":"2026-04-28T13:50:47.961186Z","end":"2026-04-28T13:50:48.238148Z","steps":["trace[432163899] 'process raft request' (duration: 276.653345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:48.238387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.043242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T13:50:48.238385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.720431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:job-controller\" ","response":"range_response_count:1 size:780"} {"level":"info","ts":"2026-04-28T13:50:48.238501Z","caller":"traceutil/trace.go:171","msg":"trace[1571567585] range","detail":"{range_begin:/registry/clusterroles/system:controller:job-controller; range_end:; response_count:1; response_revision:1436; }","duration":"263.860073ms","start":"2026-04-28T13:50:47.974626Z","end":"2026-04-28T13:50:48.238487Z","steps":["trace[1571567585] 'agreement among raft nodes before linearized reading' (duration: 263.6746ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:48.23845Z","caller":"traceutil/trace.go:171","msg":"trace[1763902040] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1436; }","duration":"249.184383ms","start":"2026-04-28T13:50:47.989249Z","end":"2026-04-28T13:50:48.238433Z","steps":["trace[1763902040] 'agreement among raft nodes before linearized reading' (duration: 249.064062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:48.238623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.377918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:50:48.239106Z","caller":"traceutil/trace.go:171","msg":"trace[377727690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1436; }","duration":"226.905665ms","start":"2026-04-28T13:50:48.012157Z","end":"2026-04-28T13:50:48.239063Z","steps":["trace[377727690] 'agreement among raft nodes before linearized reading' (duration: 226.228065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:48.238626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.055975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:kubelet-bootstrap\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-28T13:50:48.239288Z","caller":"traceutil/trace.go:171","msg":"trace[451429669] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:kubelet-bootstrap; range_end:; response_count:1; response_revision:1436; }","duration":"203.757076ms","start":"2026-04-28T13:50:48.035503Z","end":"2026-04-28T13:50:48.23926Z","steps":["trace[451429669] 'agreement among raft nodes before linearized reading' (duration: 202.835683ms)"],"step_count":1}