{"level":"warn","ts":"2026-04-27T16:02:15.382668Z","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-27T16:02:15.382749Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-27T16:02:15.382813Z","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-27T16:02:15.382823Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-04-27T16:02:15.38284Z","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-27T16:02:15.383435Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-04-27T16:02:15.38351Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-27T16:02:16.718768Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.335044113s"} {"level":"info","ts":"2026-04-27T16:02:16.923402Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-04-27T16:02:16.923534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T16:02:16.923569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-04-27T16:02:16.923585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T16:02:16.923598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-04-27T16:02:16.923767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-04-27T16:02:17.074832Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T16:02:17.093067Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T16:02:17.099781Z","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-27T16:02:17.136257Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T16:02:17.13648Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T16:02:17.136555Z","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-27T16:02:17.136618Z","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-27T16:02:17.136627Z","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-27T16:02:17.148012Z","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-27T16:02:17.148322Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T16:02:17.148377Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T16:02:17.14848Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-04-27T16:02:17.148505Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-04-27T16:02:17.155695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-04-27T16:02:17.155859Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-04-27T16:02:17.155912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T16:02:17.155926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T16:02:17.155943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-04-27T16:02:17.155958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-04-27T16:02:17.155966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-04-27T16:02:17.155975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-04-27T16:02:17.155985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-04-27T16:02:17.163127Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:02:17.163395Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T16:02:17.163651Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T16:02:17.163808Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T16:02:17.166192Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T16:02:17.166347Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-04-27T16:02:17.16686Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T16:02:17.166918Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T16:02:17.170334Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:02:17.170439Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:02:17.170469Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T16:02:19.049538Z","caller":"traceutil/trace.go:171","msg":"trace[294922020] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"166.738333ms","start":"2026-04-27T16:02:18.882767Z","end":"2026-04-27T16:02:19.049505Z","steps":["trace[294922020] 'process raft request' (duration: 166.400514ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.067159Z","caller":"traceutil/trace.go:171","msg":"trace[1408089252] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"184.298984ms","start":"2026-04-27T16:02:18.882837Z","end":"2026-04-27T16:02:19.067136Z","steps":["trace[1408089252] 'process raft request' (duration: 184.012635ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.067197Z","caller":"traceutil/trace.go:171","msg":"trace[886289532] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"104.830814ms","start":"2026-04-27T16:02:18.962326Z","end":"2026-04-27T16:02:19.067157Z","steps":["trace[886289532] 'process raft request' (duration: 104.715944ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.067463Z","caller":"traceutil/trace.go:171","msg":"trace[246616762] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"104.995862ms","start":"2026-04-27T16:02:18.962431Z","end":"2026-04-27T16:02:19.067427Z","steps":["trace[246616762] 'process raft request' (duration: 104.650623ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.067698Z","caller":"traceutil/trace.go:171","msg":"trace[768040689] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"105.140527ms","start":"2026-04-27T16:02:18.962546Z","end":"2026-04-27T16:02:19.067687Z","steps":["trace[768040689] 'process raft request' (duration: 104.555547ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.067972Z","caller":"traceutil/trace.go:171","msg":"trace[674827712] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"105.389429ms","start":"2026-04-27T16:02:18.962566Z","end":"2026-04-27T16:02:19.067956Z","steps":["trace[674827712] 'process raft request' (duration: 105.000883ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.068063Z","caller":"traceutil/trace.go:171","msg":"trace[1784862392] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"105.357373ms","start":"2026-04-27T16:02:18.962676Z","end":"2026-04-27T16:02:19.068033Z","steps":["trace[1784862392] 'process raft request' (duration: 105.190185ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.068084Z","caller":"traceutil/trace.go:171","msg":"trace[1205934075] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"176.33734ms","start":"2026-04-27T16:02:18.891734Z","end":"2026-04-27T16:02:19.068071Z","steps":["trace[1205934075] 'read index received' (duration: 157.495819ms)","trace[1205934075] 'applied index is now lower than readState.Index' (duration: 18.8407ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:19.068126Z","caller":"traceutil/trace.go:171","msg":"trace[2098993237] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"105.311655ms","start":"2026-04-27T16:02:18.962709Z","end":"2026-04-27T16:02:19.068021Z","steps":["trace[2098993237] 'process raft request' (duration: 105.195895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:19.068536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.892929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-27T16:02:19.068573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.126825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-27T16:02:19.068582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.766673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T16:02:19.068612Z","caller":"traceutil/trace.go:171","msg":"trace[1818702475] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"107.21648ms","start":"2026-04-27T16:02:18.961386Z","end":"2026-04-27T16:02:19.068602Z","steps":["trace[1818702475] 'agreement among raft nodes before linearized reading' (duration: 106.884464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:19.068655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.170922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T16:02:19.068666Z","caller":"traceutil/trace.go:171","msg":"trace[360128078] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"105.892864ms","start":"2026-04-27T16:02:18.962739Z","end":"2026-04-27T16:02:19.068632Z","steps":["trace[360128078] 'agreement among raft nodes before linearized reading' (duration: 105.491296ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.068686Z","caller":"traceutil/trace.go:171","msg":"trace[1229518435] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:0; response_revision:11; }","duration":"108.242494ms","start":"2026-04-27T16:02:18.960436Z","end":"2026-04-27T16:02:19.068679Z","steps":["trace[1229518435] 'agreement among raft nodes before linearized reading' (duration: 108.197396ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.068613Z","caller":"traceutil/trace.go:171","msg":"trace[688520539] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"135.001437ms","start":"2026-04-27T16:02:18.933595Z","end":"2026-04-27T16:02:19.068597Z","steps":["trace[688520539] 'agreement among raft nodes before linearized reading' (duration: 134.628294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:19.069155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.392741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T16:02:19.069259Z","caller":"traceutil/trace.go:171","msg":"trace[276240347] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"177.525933ms","start":"2026-04-27T16:02:18.89171Z","end":"2026-04-27T16:02:19.069236Z","steps":["trace[276240347] 'agreement among raft nodes before linearized reading' (duration: 176.423484ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.284676Z","caller":"traceutil/trace.go:171","msg":"trace[67938861] linearizableReadLoop","detail":"{readStateIndex:45; appliedIndex:44; }","duration":"110.120772ms","start":"2026-04-27T16:02:19.174528Z","end":"2026-04-27T16:02:19.284649Z","steps":["trace[67938861] 'read index received' (duration: 46.351293ms)","trace[67938861] 'applied index is now lower than readState.Index' (duration: 63.768489ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:19.284737Z","caller":"traceutil/trace.go:171","msg":"trace[476728248] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"141.072272ms","start":"2026-04-27T16:02:19.143637Z","end":"2026-04-27T16:02:19.28471Z","steps":["trace[476728248] 'process raft request' (duration: 77.246843ms)","trace[476728248] 'compare' (duration: 63.315412ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:19.284929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.372266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-27T16:02:19.284949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.34169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T16:02:19.284989Z","caller":"traceutil/trace.go:171","msg":"trace[2035275933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:41; }","duration":"110.425425ms","start":"2026-04-27T16:02:19.174551Z","end":"2026-04-27T16:02:19.284976Z","steps":["trace[2035275933] 'agreement among raft nodes before linearized reading' (duration: 110.269778ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.284986Z","caller":"traceutil/trace.go:171","msg":"trace[1948203647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:41; }","duration":"110.474354ms","start":"2026-04-27T16:02:19.174494Z","end":"2026-04-27T16:02:19.284968Z","steps":["trace[1948203647] 'agreement among raft nodes before linearized reading' (duration: 110.290231ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.627245Z","caller":"traceutil/trace.go:171","msg":"trace[1356725178] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"127.888839ms","start":"2026-04-27T16:02:19.499289Z","end":"2026-04-27T16:02:19.627178Z","steps":["trace[1356725178] 'process raft request' (duration: 127.822558ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:19.627262Z","caller":"traceutil/trace.go:171","msg":"trace[851055281] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"128.932647ms","start":"2026-04-27T16:02:19.498298Z","end":"2026-04-27T16:02:19.627231Z","steps":["trace[851055281] 'process raft request' (duration: 29.134379ms)","trace[851055281] 'compare' (duration: 99.505258ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:19.836517Z","caller":"traceutil/trace.go:171","msg":"trace[508011506] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"204.050615ms","start":"2026-04-27T16:02:19.632427Z","end":"2026-04-27T16:02:19.836478Z","steps":["trace[508011506] 'process raft request' (duration: 140.310772ms)","trace[508011506] 'compare' (duration: 63.517995ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:19.836676Z","caller":"traceutil/trace.go:171","msg":"trace[757694562] transaction","detail":"{read_only:false; response_revision:68; number_of_response:1; }","duration":"143.39892ms","start":"2026-04-27T16:02:19.693248Z","end":"2026-04-27T16:02:19.836647Z","steps":["trace[757694562] 'process raft request' (duration: 143.138195ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:20.1484Z","caller":"traceutil/trace.go:171","msg":"trace[1928118751] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"122.19766ms","start":"2026-04-27T16:02:20.026166Z","end":"2026-04-27T16:02:20.148364Z","steps":["trace[1928118751] 'process raft request' (duration: 88.381874ms)","trace[1928118751] 'compare' (duration: 33.406996ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:20.802697Z","caller":"traceutil/trace.go:171","msg":"trace[794997156] transaction","detail":"{read_only:false; response_revision:138; number_of_response:1; }","duration":"100.973307ms","start":"2026-04-27T16:02:20.701694Z","end":"2026-04-27T16:02:20.802667Z","steps":["trace[794997156] 'process raft request' (duration: 73.128935ms)","trace[794997156] 'compare' (duration: 27.708018ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:23.350932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.429316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:02:23.351136Z","caller":"traceutil/trace.go:171","msg":"trace[799003675] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"163.171683ms","start":"2026-04-27T16:02:23.187924Z","end":"2026-04-27T16:02:23.351095Z","steps":["trace[799003675] 'process raft request' (duration: 14.738772ms)","trace[799003675] 'compare' (duration: 146.968316ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:23.351208Z","caller":"traceutil/trace.go:171","msg":"trace[116215938] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:301; }","duration":"162.92457ms","start":"2026-04-27T16:02:23.188259Z","end":"2026-04-27T16:02:23.351183Z","steps":["trace[116215938] 'read index received' (duration: 14.414165ms)","trace[116215938] 'applied index is now lower than readState.Index' (duration: 148.507095ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:23.351251Z","caller":"traceutil/trace.go:171","msg":"trace[221476875] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"162.174831ms","start":"2026-04-27T16:02:23.189051Z","end":"2026-04-27T16:02:23.351226Z","steps":["trace[221476875] 'process raft request' (duration: 162.046258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:23.351408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.122345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:115"} {"level":"info","ts":"2026-04-27T16:02:23.351441Z","caller":"traceutil/trace.go:171","msg":"trace[1800848001] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:297; }","duration":"163.187696ms","start":"2026-04-27T16:02:23.188241Z","end":"2026-04-27T16:02:23.351429Z","steps":["trace[1800848001] 'agreement among raft nodes before linearized reading' (duration: 163.063384ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.354218Z","caller":"traceutil/trace.go:171","msg":"trace[430174291] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"114.641408ms","start":"2026-04-27T16:02:23.239558Z","end":"2026-04-27T16:02:23.3542Z","steps":["trace[430174291] 'process raft request' (duration: 114.42216ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.354387Z","caller":"traceutil/trace.go:171","msg":"trace[69650751] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"109.101565ms","start":"2026-04-27T16:02:23.245269Z","end":"2026-04-27T16:02:23.354371Z","steps":["trace[69650751] 'process raft request' (duration: 108.824787ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.354567Z","caller":"traceutil/trace.go:171","msg":"trace[89348003] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"109.213415ms","start":"2026-04-27T16:02:23.245343Z","end":"2026-04-27T16:02:23.354556Z","steps":["trace[89348003] 'process raft request' (duration: 108.78444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:23.354578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.269218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:23.354645Z","caller":"traceutil/trace.go:171","msg":"trace[653983231] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:0; response_revision:298; }","duration":"157.385148ms","start":"2026-04-27T16:02:23.197243Z","end":"2026-04-27T16:02:23.354628Z","steps":["trace[653983231] 'agreement among raft nodes before linearized reading' (duration: 157.252305ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.354667Z","caller":"traceutil/trace.go:171","msg":"trace[1326127348] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"108.979424ms","start":"2026-04-27T16:02:23.245678Z","end":"2026-04-27T16:02:23.354658Z","steps":["trace[1326127348] 'process raft request' (duration: 108.588026ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.354754Z","caller":"traceutil/trace.go:171","msg":"trace[2098444065] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"108.526136ms","start":"2026-04-27T16:02:23.246221Z","end":"2026-04-27T16:02:23.354747Z","steps":["trace[2098444065] 'process raft request' (duration: 108.220053ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.354846Z","caller":"traceutil/trace.go:171","msg":"trace[1376350202] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"109.112377ms","start":"2026-04-27T16:02:23.245721Z","end":"2026-04-27T16:02:23.354833Z","steps":["trace[1376350202] 'process raft request' (duration: 108.582325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:23.574214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.566381ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:02:23.574564Z","caller":"traceutil/trace.go:171","msg":"trace[1719891777] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"149.269859ms","start":"2026-04-27T16:02:23.425278Z","end":"2026-04-27T16:02:23.574548Z","steps":["trace[1719891777] 'process raft request' (duration: 149.234442ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.574668Z","caller":"traceutil/trace.go:171","msg":"trace[1127904749] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"154.838066ms","start":"2026-04-27T16:02:23.419806Z","end":"2026-04-27T16:02:23.574644Z","steps":["trace[1127904749] 'process raft request' (duration: 154.645963ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.574714Z","caller":"traceutil/trace.go:171","msg":"trace[958028954] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"153.48385ms","start":"2026-04-27T16:02:23.421223Z","end":"2026-04-27T16:02:23.574707Z","steps":["trace[958028954] 'process raft request' (duration: 153.264682ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.574668Z","caller":"traceutil/trace.go:171","msg":"trace[2033207528] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"156.363561ms","start":"2026-04-27T16:02:23.418282Z","end":"2026-04-27T16:02:23.574645Z","steps":["trace[2033207528] 'process raft request' (duration: 156.146173ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.574813Z","caller":"traceutil/trace.go:171","msg":"trace[182240429] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"173.480446ms","start":"2026-04-27T16:02:23.401321Z","end":"2026-04-27T16:02:23.574801Z","steps":["trace[182240429] 'process raft request' (duration: 172.983388ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.574872Z","caller":"traceutil/trace.go:171","msg":"trace[862417269] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"173.296574ms","start":"2026-04-27T16:02:23.401566Z","end":"2026-04-27T16:02:23.574862Z","steps":["trace[862417269] 'process raft request' (duration: 172.815261ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.574949Z","caller":"traceutil/trace.go:171","msg":"trace[1657301397] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:314; }","duration":"160.890368ms","start":"2026-04-27T16:02:23.41405Z","end":"2026-04-27T16:02:23.57494Z","steps":["trace[1657301397] 'read index received' (duration: 38.460045ms)","trace[1657301397] 'applied index is now lower than readState.Index' (duration: 122.429372ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:23.575061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.242732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T16:02:23.575087Z","caller":"traceutil/trace.go:171","msg":"trace[1103244290] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:310; }","duration":"175.319896ms","start":"2026-04-27T16:02:23.399759Z","end":"2026-04-27T16:02:23.575079Z","steps":["trace[1103244290] 'agreement among raft nodes before linearized reading' (duration: 175.238322ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:23.574602Z","caller":"traceutil/trace.go:171","msg":"trace[29004744] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"173.207269ms","start":"2026-04-27T16:02:23.401226Z","end":"2026-04-27T16:02:23.574433Z","steps":["trace[29004744] 'process raft request' (duration: 51.357327ms)","trace[29004744] 'compare' (duration: 121.446671ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:24.441986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.392908ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:02:24.442066Z","caller":"traceutil/trace.go:171","msg":"trace[765059383] linearizableReadLoop","detail":"{readStateIndex:340; appliedIndex:339; }","duration":"194.099649ms","start":"2026-04-27T16:02:24.247956Z","end":"2026-04-27T16:02:24.442056Z","steps":["trace[765059383] 'read index received' (duration: 62.500256ms)","trace[765059383] 'applied index is now lower than readState.Index' (duration: 131.598633ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:24.442104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.152859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:24.442118Z","caller":"traceutil/trace.go:171","msg":"trace[632342479] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:0; response_revision:326; }","duration":"194.191645ms","start":"2026-04-27T16:02:24.247921Z","end":"2026-04-27T16:02:24.442112Z","steps":["trace[632342479] 'agreement among raft nodes before linearized reading' (duration: 194.16249ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:24.442143Z","caller":"traceutil/trace.go:171","msg":"trace[1842659197] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"200.341239ms","start":"2026-04-27T16:02:24.241763Z","end":"2026-04-27T16:02:24.442104Z","steps":["trace[1842659197] 'process raft request' (duration: 68.695687ms)","trace[1842659197] 'compare' (duration: 131.299551ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:27.544029Z","caller":"traceutil/trace.go:171","msg":"trace[209332447] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"183.242321ms","start":"2026-04-27T16:02:27.360761Z","end":"2026-04-27T16:02:27.544003Z","steps":["trace[209332447] 'process raft request' (duration: 121.501581ms)","trace[209332447] 'compare' (duration: 61.62823ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:27.544667Z","caller":"traceutil/trace.go:171","msg":"trace[854933090] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:385; }","duration":"146.188806ms","start":"2026-04-27T16:02:27.398459Z","end":"2026-04-27T16:02:27.544648Z","steps":["trace[854933090] 'read index received' (duration: 83.84925ms)","trace[854933090] 'applied index is now lower than readState.Index' (duration: 62.338796ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:27.544696Z","caller":"traceutil/trace.go:171","msg":"trace[573150849] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"181.113856ms","start":"2026-04-27T16:02:27.36356Z","end":"2026-04-27T16:02:27.544674Z","steps":["trace[573150849] 'process raft request' (duration: 180.906688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:27.544775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.308027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-27T16:02:27.544798Z","caller":"traceutil/trace.go:171","msg":"trace[1937830455] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:375; }","duration":"146.381961ms","start":"2026-04-27T16:02:27.398409Z","end":"2026-04-27T16:02:27.544791Z","steps":["trace[1937830455] 'agreement among raft nodes before linearized reading' (duration: 146.315929ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:27.54481Z","caller":"traceutil/trace.go:171","msg":"trace[1912079148] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"182.501151ms","start":"2026-04-27T16:02:27.362269Z","end":"2026-04-27T16:02:27.54477Z","steps":["trace[1912079148] 'process raft request' (duration: 182.1062ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:27.545032Z","caller":"traceutil/trace.go:171","msg":"trace[1342399380] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"178.451667ms","start":"2026-04-27T16:02:27.366561Z","end":"2026-04-27T16:02:27.545013Z","steps":["trace[1342399380] 'process raft request' (duration: 178.050876ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.309484Z","caller":"traceutil/trace.go:171","msg":"trace[1335068345] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"239.440909ms","start":"2026-04-27T16:02:49.07002Z","end":"2026-04-27T16:02:49.309461Z","steps":["trace[1335068345] 'process raft request' (duration: 239.31511ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.323517Z","caller":"traceutil/trace.go:171","msg":"trace[923871100] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"235.602067ms","start":"2026-04-27T16:02:49.087893Z","end":"2026-04-27T16:02:49.323495Z","steps":["trace[923871100] 'process raft request' (duration: 235.284307ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.323731Z","caller":"traceutil/trace.go:171","msg":"trace[150841261] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"206.300105ms","start":"2026-04-27T16:02:49.117408Z","end":"2026-04-27T16:02:49.323708Z","steps":["trace[150841261] 'process raft request' (duration: 205.946875ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.323828Z","caller":"traceutil/trace.go:171","msg":"trace[1134427740] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"237.052774ms","start":"2026-04-27T16:02:49.086764Z","end":"2026-04-27T16:02:49.323816Z","steps":["trace[1134427740] 'process raft request' (duration: 236.375618ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.323828Z","caller":"traceutil/trace.go:171","msg":"trace[316506749] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"247.175079ms","start":"2026-04-27T16:02:49.076624Z","end":"2026-04-27T16:02:49.323799Z","steps":["trace[316506749] 'process raft request' (duration: 246.456797ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.323885Z","caller":"traceutil/trace.go:171","msg":"trace[165554754] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"226.911328ms","start":"2026-04-27T16:02:49.096968Z","end":"2026-04-27T16:02:49.323879Z","steps":["trace[165554754] 'process raft request' (duration: 226.264985ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.323907Z","caller":"traceutil/trace.go:171","msg":"trace[1291300159] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"200.170323ms","start":"2026-04-27T16:02:49.123711Z","end":"2026-04-27T16:02:49.323881Z","steps":["trace[1291300159] 'process raft request' (duration: 199.697222ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.323929Z","caller":"traceutil/trace.go:171","msg":"trace[2022339129] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"225.024218ms","start":"2026-04-27T16:02:49.098892Z","end":"2026-04-27T16:02:49.323916Z","steps":["trace[2022339129] 'process raft request' (duration: 224.414464ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.323846Z","caller":"traceutil/trace.go:171","msg":"trace[592363933] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"226.796193ms","start":"2026-04-27T16:02:49.097017Z","end":"2026-04-27T16:02:49.323814Z","steps":["trace[592363933] 'process raft request' (duration: 226.257649ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.323971Z","caller":"traceutil/trace.go:171","msg":"trace[551853354] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"253.032056ms","start":"2026-04-27T16:02:49.070932Z","end":"2026-04-27T16:02:49.323964Z","steps":["trace[551853354] 'process raft request' (duration: 251.934939ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.32406Z","caller":"traceutil/trace.go:171","msg":"trace[1338969976] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"183.528766ms","start":"2026-04-27T16:02:49.140473Z","end":"2026-04-27T16:02:49.324001Z","steps":["trace[1338969976] 'process raft request' (duration: 182.986144ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:49.664909Z","caller":"traceutil/trace.go:171","msg":"trace[386882113] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"101.66593ms","start":"2026-04-27T16:02:49.563217Z","end":"2026-04-27T16:02:49.664883Z","steps":["trace[386882113] 'process raft request' (duration: 101.416112ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:50.44286Z","caller":"traceutil/trace.go:171","msg":"trace[392102310] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"171.75205ms","start":"2026-04-27T16:02:50.271084Z","end":"2026-04-27T16:02:50.442836Z","steps":["trace[392102310] 'process raft request' (duration: 106.617599ms)","trace[392102310] 'compare' (duration: 65.012619ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:55.377415Z","caller":"traceutil/trace.go:171","msg":"trace[60272073] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"245.049826ms","start":"2026-04-27T16:02:55.132205Z","end":"2026-04-27T16:02:55.377255Z","steps":["trace[60272073] 'process raft request' (duration: 243.774922ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:56.017196Z","caller":"traceutil/trace.go:171","msg":"trace[761661101] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"216.416286ms","start":"2026-04-27T16:02:55.800742Z","end":"2026-04-27T16:02:56.017158Z","steps":["trace[761661101] 'process raft request' (duration: 196.841694ms)","trace[761661101] 'compare' (duration: 19.253431ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:56.017505Z","caller":"traceutil/trace.go:171","msg":"trace[1933863141] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:650; }","duration":"176.149415ms","start":"2026-04-27T16:02:55.841342Z","end":"2026-04-27T16:02:56.017491Z","steps":["trace[1933863141] 'read index received' (duration: 25.247078ms)","trace[1933863141] 'applied index is now lower than readState.Index' (duration: 150.901727ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:56.017591Z","caller":"traceutil/trace.go:171","msg":"trace[1766495044] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"162.850948ms","start":"2026-04-27T16:02:55.854717Z","end":"2026-04-27T16:02:56.017568Z","steps":["trace[1766495044] 'process raft request' (duration: 162.432486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:56.017653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.295832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T16:02:56.017677Z","caller":"traceutil/trace.go:171","msg":"trace[82979121] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:629; }","duration":"176.362219ms","start":"2026-04-27T16:02:55.841307Z","end":"2026-04-27T16:02:56.017669Z","steps":["trace[82979121] 'agreement among raft nodes before linearized reading' (duration: 176.254183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:56.017704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.630155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:56.017772Z","caller":"traceutil/trace.go:171","msg":"trace[1958115926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"101.743479ms","start":"2026-04-27T16:02:55.916009Z","end":"2026-04-27T16:02:56.017753Z","steps":["trace[1958115926] 'agreement among raft nodes before linearized reading' (duration: 101.621449ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:56.259197Z","caller":"traceutil/trace.go:171","msg":"trace[1703094912] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"237.9796ms","start":"2026-04-27T16:02:56.020964Z","end":"2026-04-27T16:02:56.258943Z","steps":["trace[1703094912] 'process raft request' (duration: 185.498974ms)","trace[1703094912] 'compare' (duration: 52.237877ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:02:56.280328Z","caller":"traceutil/trace.go:171","msg":"trace[433649754] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"210.860019ms","start":"2026-04-27T16:02:56.069449Z","end":"2026-04-27T16:02:56.280309Z","steps":["trace[433649754] 'process raft request' (duration: 210.67628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.42268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.19248ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T16:02:57.422824Z","caller":"traceutil/trace.go:171","msg":"trace[717737617] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"1.126765342s","start":"2026-04-27T16:02:56.296031Z","end":"2026-04-27T16:02:57.422796Z","steps":["trace[717737617] 'process raft request' (duration: 227.382303ms)","trace[717737617] 'compare' (duration: 899.049191ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:57.423007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.296013Z","time spent":"1.126881585s","remote":"127.0.0.1:34486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:02:57.423085Z","caller":"traceutil/trace.go:171","msg":"trace[1483093344] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"829.300076ms","start":"2026-04-27T16:02:56.593721Z","end":"2026-04-27T16:02:57.423021Z","steps":["trace[1483093344] 'read index received' (duration: 33.663µs)","trace[1483093344] 'applied index is now lower than readState.Index' (duration: 829.264924ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:57.46132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.652511ms","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-27T16:02:57.461377Z","caller":"traceutil/trace.go:171","msg":"trace[1447754494] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:632; }","duration":"867.756171ms","start":"2026-04-27T16:02:56.593608Z","end":"2026-04-27T16:02:57.461364Z","steps":["trace[1447754494] 'agreement among raft nodes before linearized reading' (duration: 829.576131ms)","trace[1447754494] 'range keys from in-memory index tree' (duration: 38.090434ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T16:02:57.461408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.593593Z","time spent":"867.806016ms","remote":"127.0.0.1:36690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T16:02:57.4622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.327724ms","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-27T16:02:57.462267Z","caller":"traceutil/trace.go:171","msg":"trace[2096698400] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"767.769577ms","start":"2026-04-27T16:02:56.694489Z","end":"2026-04-27T16:02:57.462259Z","steps":["trace[2096698400] 'process raft request' (duration: 766.932124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.462305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.317198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:02:57.462382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.426894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:02:57.462398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.694466Z","time spent":"767.842931ms","remote":"127.0.0.1:34372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:02:57.462389Z","caller":"traceutil/trace.go:171","msg":"trace[1313832424] 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:633; }","duration":"337.485326ms","start":"2026-04-27T16:02:57.124815Z","end":"2026-04-27T16:02:57.4623Z","steps":["trace[1313832424] 'agreement among raft nodes before linearized reading' (duration: 337.295909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.462459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.648138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:02:57.462491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.951203ms","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":"warn","ts":"2026-04-27T16:02:57.462517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:57.124805Z","time spent":"337.697234ms","remote":"127.0.0.1:36768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T16:02:57.4626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.360217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:02:57.462616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.079802ms","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-27T16:02:57.462665Z","caller":"traceutil/trace.go:171","msg":"trace[620149984] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:633; }","duration":"682.41566ms","start":"2026-04-27T16:02:56.780208Z","end":"2026-04-27T16:02:57.462624Z","steps":["trace[620149984] 'agreement among raft nodes before linearized reading' (duration: 682.367903ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:57.462677Z","caller":"traceutil/trace.go:171","msg":"trace[878250493] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:633; }","duration":"364.165189ms","start":"2026-04-27T16:02:57.098498Z","end":"2026-04-27T16:02:57.462663Z","steps":["trace[878250493] 'agreement among raft nodes before linearized reading' (duration: 364.086098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.462709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.780194Z","time spent":"682.503657ms","remote":"127.0.0.1:36716","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T16:02:57.462704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.368613ms","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":"warn","ts":"2026-04-27T16:02:57.462728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:57.098481Z","time spent":"364.232607ms","remote":"127.0.0.1:36760","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-27T16:02:57.462771Z","caller":"traceutil/trace.go:171","msg":"trace[517275649] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:633; }","duration":"682.448225ms","start":"2026-04-27T16:02:56.780304Z","end":"2026-04-27T16:02:57.462752Z","steps":["trace[517275649] 'agreement among raft nodes before linearized reading' (duration: 682.229612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.462808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.483269ms","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":"warn","ts":"2026-04-27T16:02:57.462819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.7803Z","time spent":"682.510765ms","remote":"127.0.0.1:36716","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-04-27T16:02:57.46284Z","caller":"traceutil/trace.go:171","msg":"trace[1720040142] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"721.535723ms","start":"2026-04-27T16:02:56.741294Z","end":"2026-04-27T16:02:57.46283Z","steps":["trace[1720040142] 'agreement among raft nodes before linearized reading' (duration: 721.495283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.462862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.741285Z","time spent":"721.570926ms","remote":"127.0.0.1:36700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T16:02:57.462959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.797732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.462984Z","caller":"traceutil/trace.go:171","msg":"trace[1183105483] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:633; }","duration":"649.844668ms","start":"2026-04-27T16:02:56.813133Z","end":"2026-04-27T16:02:57.462978Z","steps":["trace[1183105483] 'agreement among raft nodes before linearized reading' (duration: 649.805297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.462977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.98128ms","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":"warn","ts":"2026-04-27T16:02:57.463011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.770268ms","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-27T16:02:57.463036Z","caller":"traceutil/trace.go:171","msg":"trace[649683350] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"721.820814ms","start":"2026-04-27T16:02:56.741209Z","end":"2026-04-27T16:02:57.46303Z","steps":["trace[649683350] 'agreement among raft nodes before linearized reading' (duration: 721.784591ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:57.463038Z","caller":"traceutil/trace.go:171","msg":"trace[28454962] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:633; }","duration":"492.064959ms","start":"2026-04-27T16:02:56.970955Z","end":"2026-04-27T16:02:57.46302Z","steps":["trace[28454962] 'agreement among raft nodes before linearized reading' (duration: 491.985587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.463058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.741193Z","time spent":"721.859904ms","remote":"127.0.0.1:36700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T16:02:57.4631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.970934Z","time spent":"492.151766ms","remote":"127.0.0.1:36756","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-27T16:02:57.463138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.320511ms","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":"warn","ts":"2026-04-27T16:02:57.463115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.327039ms","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-27T16:02:57.463157Z","caller":"traceutil/trace.go:171","msg":"trace[2100995542] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"869.352195ms","start":"2026-04-27T16:02:56.593799Z","end":"2026-04-27T16:02:57.463152Z","steps":["trace[2100995542] 'agreement among raft nodes before linearized reading' (duration: 869.323309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.463179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.299006ms","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-27T16:02:57.463129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.515086ms","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-27T16:02:57.463278Z","caller":"traceutil/trace.go:171","msg":"trace[1314219749] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:633; }","duration":"237.706963ms","start":"2026-04-27T16:02:57.225559Z","end":"2026-04-27T16:02:57.463266Z","steps":["trace[1314219749] 'agreement among raft nodes before linearized reading' (duration: 237.526221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.463004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.81312Z","time spent":"649.878422ms","remote":"127.0.0.1:36726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T16:02:57.463325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.968043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.463349Z","caller":"traceutil/trace.go:171","msg":"trace[2141646358] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:633; }","duration":"621.012161ms","start":"2026-04-27T16:02:56.84233Z","end":"2026-04-27T16:02:57.463342Z","steps":["trace[2141646358] 'agreement among raft nodes before linearized reading' (duration: 620.978918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.463374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.842326Z","time spent":"621.041707ms","remote":"127.0.0.1:36734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-27T16:02:57.463388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.996459ms","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-27T16:02:57.463451Z","caller":"traceutil/trace.go:171","msg":"trace[60787534] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:633; }","duration":"704.070333ms","start":"2026-04-27T16:02:56.75937Z","end":"2026-04-27T16:02:57.463441Z","steps":["trace[60787534] 'agreement among raft nodes before linearized reading' (duration: 703.960346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.462766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.633362ms","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":"info","ts":"2026-04-27T16:02:57.463516Z","caller":"traceutil/trace.go:171","msg":"trace[1067999842] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"721.392341ms","start":"2026-04-27T16:02:56.742107Z","end":"2026-04-27T16:02:57.463499Z","steps":["trace[1067999842] 'agreement among raft nodes before linearized reading' (duration: 720.630143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.463572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.759366Z","time spent":"704.110013ms","remote":"127.0.0.1:36702","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-27T16:02:57.463579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.7421Z","time spent":"721.460877ms","remote":"127.0.0.1:36690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-27T16:02:57.463632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.777115ms","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-27T16:02:57.463664Z","caller":"traceutil/trace.go:171","msg":"trace[267805459] 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:633; }","duration":"299.844643ms","start":"2026-04-27T16:02:57.163811Z","end":"2026-04-27T16:02:57.463656Z","steps":["trace[267805459] 'agreement among raft nodes before linearized reading' (duration: 299.798245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.463726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.85916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.463792Z","caller":"traceutil/trace.go:171","msg":"trace[99017178] 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:633; }","duration":"332.989377ms","start":"2026-04-27T16:02:57.130791Z","end":"2026-04-27T16:02:57.463781Z","steps":["trace[99017178] 'agreement among raft nodes before linearized reading' (duration: 332.856711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.463824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.856043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.463846Z","caller":"traceutil/trace.go:171","msg":"trace[887403702] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:633; }","duration":"259.888528ms","start":"2026-04-27T16:02:57.203952Z","end":"2026-04-27T16:02:57.46384Z","steps":["trace[887403702] 'agreement among raft nodes before linearized reading' (duration: 259.858103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.463887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:57.130768Z","time spent":"333.067839ms","remote":"127.0.0.1:36768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-27T16:02:57.463962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.25218ms","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-27T16:02:57.463985Z","caller":"traceutil/trace.go:171","msg":"trace[1097348418] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:633; }","duration":"260.382136ms","start":"2026-04-27T16:02:57.203596Z","end":"2026-04-27T16:02:57.463978Z","steps":["trace[1097348418] 'agreement among raft nodes before linearized reading' (duration: 260.349023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.464064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.569686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.464096Z","caller":"traceutil/trace.go:171","msg":"trace[2049504601] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:633; }","duration":"260.636423ms","start":"2026-04-27T16:02:57.203454Z","end":"2026-04-27T16:02:57.464091Z","steps":["trace[2049504601] 'agreement among raft nodes before linearized reading' (duration: 260.591854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.464145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.295175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:02:57.464204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.443742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.464227Z","caller":"traceutil/trace.go:171","msg":"trace[899456083] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:633; }","duration":"276.48851ms","start":"2026-04-27T16:02:57.187732Z","end":"2026-04-27T16:02:57.46422Z","steps":["trace[899456083] 'agreement among raft nodes before linearized reading' (duration: 276.458895ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:57.46421Z","caller":"traceutil/trace.go:171","msg":"trace[1589477371] 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:633; }","duration":"339.383901ms","start":"2026-04-27T16:02:57.124814Z","end":"2026-04-27T16:02:57.464198Z","steps":["trace[1589477371] 'agreement among raft nodes before linearized reading' (duration: 339.258412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.464305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:57.124798Z","time spent":"339.493128ms","remote":"127.0.0.1:36768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-04-27T16:02:57.464647Z","caller":"traceutil/trace.go:171","msg":"trace[622817619] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"547.711408ms","start":"2026-04-27T16:02:56.914769Z","end":"2026-04-27T16:02:57.46248Z","steps":["trace[622817619] 'agreement among raft nodes before linearized reading' (duration: 547.66622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.466695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.91475Z","time spent":"551.93237ms","remote":"127.0.0.1:34298","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-27T16:02:57.46418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.392137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.466923Z","caller":"traceutil/trace.go:171","msg":"trace[335750360] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:633; }","duration":"279.119249ms","start":"2026-04-27T16:02:57.187772Z","end":"2026-04-27T16:02:57.466891Z","steps":["trace[335750360] 'agreement among raft nodes before linearized reading' (duration: 276.390478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.463153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.315808ms","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-27T16:02:57.46713Z","caller":"traceutil/trace.go:171","msg":"trace[825691723] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:633; }","duration":"497.31344ms","start":"2026-04-27T16:02:56.969803Z","end":"2026-04-27T16:02:57.467116Z","steps":["trace[825691723] 'agreement among raft nodes before linearized reading' (duration: 493.329531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.467193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.969787Z","time spent":"497.367693ms","remote":"127.0.0.1:36756","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-27T16:02:57.463295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.706466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.467323Z","caller":"traceutil/trace.go:171","msg":"trace[2069540045] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:633; }","duration":"625.780301ms","start":"2026-04-27T16:02:56.841529Z","end":"2026-04-27T16:02:57.46731Z","steps":["trace[2069540045] 'agreement among raft nodes before linearized reading' (duration: 621.724147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.467385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.841514Z","time spent":"625.853185ms","remote":"127.0.0.1:36734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T16:02:57.463181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.593792Z","time spent":"869.384129ms","remote":"127.0.0.1:36690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T16:02:57.462552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.217728ms","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-27T16:02:57.467564Z","caller":"traceutil/trace.go:171","msg":"trace[450344929] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:633; }","duration":"708.246518ms","start":"2026-04-27T16:02:56.759302Z","end":"2026-04-27T16:02:57.467549Z","steps":["trace[450344929] 'agreement among raft nodes before linearized reading' (duration: 703.207252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.467616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.759291Z","time spent":"708.308777ms","remote":"127.0.0.1:36702","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-27T16:02:57.462439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.197721ms","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-27T16:02:57.467712Z","caller":"traceutil/trace.go:171","msg":"trace[1680897733] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:633; }","duration":"368.481687ms","start":"2026-04-27T16:02:57.099217Z","end":"2026-04-27T16:02:57.467698Z","steps":["trace[1680897733] 'agreement among raft nodes before linearized reading' (duration: 363.184867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.467747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:57.099213Z","time spent":"368.522637ms","remote":"127.0.0.1:36760","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-27T16:02:57.462337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.381392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.46784Z","caller":"traceutil/trace.go:171","msg":"trace[546104778] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:633; }","duration":"523.916725ms","start":"2026-04-27T16:02:56.943916Z","end":"2026-04-27T16:02:57.467833Z","steps":["trace[546104778] 'agreement among raft nodes before linearized reading' (duration: 518.339782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.467864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.94391Z","time spent":"523.945671ms","remote":"127.0.0.1:36740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-27T16:02:57.464326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.021391ms","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-27T16:02:57.467971Z","caller":"traceutil/trace.go:171","msg":"trace[103581630] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:633; }","duration":"280.693313ms","start":"2026-04-27T16:02:57.187272Z","end":"2026-04-27T16:02:57.467965Z","steps":["trace[103581630] 'agreement among raft nodes before linearized reading' (duration: 277.038673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.463797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.257954ms","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-27T16:02:57.468154Z","caller":"traceutil/trace.go:171","msg":"trace[692189863] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:633; }","duration":"242.658351ms","start":"2026-04-27T16:02:57.225489Z","end":"2026-04-27T16:02:57.468147Z","steps":["trace[692189863] 'agreement among raft nodes before linearized reading' (duration: 238.28642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.463036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.636411ms","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-27T16:02:57.468339Z","caller":"traceutil/trace.go:171","msg":"trace[1034758287] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:633; }","duration":"687.001556ms","start":"2026-04-27T16:02:56.78133Z","end":"2026-04-27T16:02:57.468331Z","steps":["trace[1034758287] 'agreement among raft nodes before linearized reading' (duration: 681.686315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.468366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.781313Z","time spent":"687.043526ms","remote":"127.0.0.1:36716","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"info","ts":"2026-04-27T16:02:57.462417Z","caller":"traceutil/trace.go:171","msg":"trace[660898315] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:633; }","duration":"519.482007ms","start":"2026-04-27T16:02:56.942925Z","end":"2026-04-27T16:02:57.462407Z","steps":["trace[660898315] 'agreement among raft nodes before linearized reading' (duration: 519.409132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.469788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.94291Z","time spent":"526.86314ms","remote":"127.0.0.1:36740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T16:02:57.46225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.030666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.470838Z","caller":"traceutil/trace.go:171","msg":"trace[955837640] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:633; }","duration":"657.628628ms","start":"2026-04-27T16:02:56.813198Z","end":"2026-04-27T16:02:57.470827Z","steps":["trace[955837640] 'agreement among raft nodes before linearized reading' (duration: 648.998052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.470881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.813195Z","time spent":"657.674625ms","remote":"127.0.0.1:36726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-27T16:02:57.462553Z","caller":"traceutil/trace.go:171","msg":"trace[325089672] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:633; }","duration":"364.024608ms","start":"2026-04-27T16:02:57.098511Z","end":"2026-04-27T16:02:57.462535Z","steps":["trace[325089672] 'agreement among raft nodes before linearized reading' (duration: 363.953922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.470989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:57.098504Z","time spent":"372.47885ms","remote":"127.0.0.1:36760","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":"info","ts":"2026-04-27T16:02:57.46323Z","caller":"traceutil/trace.go:171","msg":"trace[820665256] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:633; }","duration":"493.334939ms","start":"2026-04-27T16:02:56.969862Z","end":"2026-04-27T16:02:57.463197Z","steps":["trace[820665256] 'agreement among raft nodes before linearized reading' (duration: 493.302175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.471097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.969856Z","time spent":"501.23485ms","remote":"127.0.0.1:36756","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":"info","ts":"2026-04-27T16:02:57.463306Z","caller":"traceutil/trace.go:171","msg":"trace[798009486] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:633; }","duration":"703.393946ms","start":"2026-04-27T16:02:56.759774Z","end":"2026-04-27T16:02:57.463168Z","steps":["trace[798009486] 'agreement among raft nodes before linearized reading' (duration: 703.231296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.471256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.759769Z","time spent":"711.47323ms","remote":"127.0.0.1:36702","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-27T16:02:57.46435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.492047ms","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-27T16:02:57.471421Z","caller":"traceutil/trace.go:171","msg":"trace[1083685466] 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:633; }","duration":"307.592129ms","start":"2026-04-27T16:02:57.163819Z","end":"2026-04-27T16:02:57.471411Z","steps":["trace[1083685466] 'agreement among raft nodes before linearized reading' (duration: 300.519724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.471442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:57.163802Z","time spent":"307.632699ms","remote":"127.0.0.1:36772","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-27T16:02:57.464348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.037881ms","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-27T16:02:57.47156Z","caller":"traceutil/trace.go:171","msg":"trace[844043613] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:633; }","duration":"192.287919ms","start":"2026-04-27T16:02:57.279266Z","end":"2026-04-27T16:02:57.471554Z","steps":["trace[844043613] 'agreement among raft nodes before linearized reading' (duration: 185.03964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.464382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.52702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.471702Z","caller":"traceutil/trace.go:171","msg":"trace[1147689489] 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:633; }","duration":"307.891952ms","start":"2026-04-27T16:02:57.163793Z","end":"2026-04-27T16:02:57.471685Z","steps":["trace[1147689489] 'agreement among raft nodes before linearized reading' (duration: 300.568809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.471724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:57.163764Z","time spent":"307.952403ms","remote":"127.0.0.1:36772","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-27T16:02:57.462208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.261687ms","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-27T16:02:57.471833Z","caller":"traceutil/trace.go:171","msg":"trace[421014722] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:633; }","duration":"245.901321ms","start":"2026-04-27T16:02:57.225926Z","end":"2026-04-27T16:02:57.471827Z","steps":["trace[421014722] 'agreement among raft nodes before linearized reading' (duration: 236.253272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.464407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.253099ms","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-27T16:02:57.471928Z","caller":"traceutil/trace.go:171","msg":"trace[343769108] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:633; }","duration":"144.801561ms","start":"2026-04-27T16:02:57.32712Z","end":"2026-04-27T16:02:57.471921Z","steps":["trace[343769108] 'agreement among raft nodes before linearized reading' (duration: 137.260924ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:02:57.464438Z","caller":"traceutil/trace.go:171","msg":"trace[727844059] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:633; }","duration":"519.353409ms","start":"2026-04-27T16:02:56.942978Z","end":"2026-04-27T16:02:57.462331Z","steps":["trace[727844059] 'agreement among raft nodes before linearized reading' (duration: 519.295457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.472052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.942956Z","time spent":"529.088786ms","remote":"127.0.0.1:36740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-27T16:02:57.464436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.134023ms","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-27T16:02:57.472147Z","caller":"traceutil/trace.go:171","msg":"trace[1333883794] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:633; }","duration":"192.868395ms","start":"2026-04-27T16:02:57.279272Z","end":"2026-04-27T16:02:57.472141Z","steps":["trace[1333883794] 'agreement among raft nodes before linearized reading' (duration: 185.137201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.464464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.51583ms","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-27T16:02:57.472386Z","caller":"traceutil/trace.go:171","msg":"trace[725227826] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:633; }","duration":"145.4613ms","start":"2026-04-27T16:02:57.326918Z","end":"2026-04-27T16:02:57.472379Z","steps":["trace[725227826] 'agreement among raft nodes before linearized reading' (duration: 137.512752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.464514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.760665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.472571Z","caller":"traceutil/trace.go:171","msg":"trace[550741391] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:633; }","duration":"192.801588ms","start":"2026-04-27T16:02:57.279743Z","end":"2026-04-27T16:02:57.472544Z","steps":["trace[550741391] 'agreement among raft nodes before linearized reading' (duration: 184.744733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.464595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.507173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:02:57.472777Z","caller":"traceutil/trace.go:171","msg":"trace[1389707856] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:633; }","duration":"631.715945ms","start":"2026-04-27T16:02:56.841052Z","end":"2026-04-27T16:02:57.472767Z","steps":["trace[1389707856] 'agreement among raft nodes before linearized reading' (duration: 623.524465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:02:57.474035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:02:56.841031Z","time spent":"632.992743ms","remote":"127.0.0.1:36734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-04-27T16:03:15.507495Z","caller":"traceutil/trace.go:171","msg":"trace[1004548136] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"327.100138ms","start":"2026-04-27T16:03:15.180368Z","end":"2026-04-27T16:03:15.507468Z","steps":["trace[1004548136] 'process raft request' (duration: 326.862579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:15.507666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:15.180343Z","time spent":"327.237832ms","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:03:15.604273Z","caller":"traceutil/trace.go:171","msg":"trace[373750092] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"209.338193ms","start":"2026-04-27T16:03:15.39491Z","end":"2026-04-27T16:03:15.604248Z","steps":["trace[373750092] 'process raft request' (duration: 209.178676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:18.136984Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725889352563095,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T16:03:18.637453Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725889352563095,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T16:03:18.86289Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.347213874s","expected-duration":"1s"} {"level":"info","ts":"2026-04-27T16:03:18.863199Z","caller":"traceutil/trace.go:171","msg":"trace[1656777713] linearizableReadLoop","detail":"{readStateIndex:843; appliedIndex:842; }","duration":"1.226401149s","start":"2026-04-27T16:03:17.636779Z","end":"2026-04-27T16:03:18.86318Z","steps":["trace[1656777713] 'read index received' (duration: 1.226237071s)","trace[1656777713] 'applied index is now lower than readState.Index' (duration: 163.328µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:03:18.863253Z","caller":"traceutil/trace.go:171","msg":"trace[1776888002] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"1.347631131s","start":"2026-04-27T16:03:17.515597Z","end":"2026-04-27T16:03:18.863228Z","steps":["trace[1776888002] 'process raft request' (duration: 1.347463044s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:18.863359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.226574544s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-27T16:03:18.863369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:17.515581Z","time spent":"1.347723371s","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:03:18.863389Z","caller":"traceutil/trace.go:171","msg":"trace[821285114] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:810; }","duration":"1.226654428s","start":"2026-04-27T16:03:17.636727Z","end":"2026-04-27T16:03:18.863381Z","steps":["trace[821285114] 'agreement among raft nodes before linearized reading' (duration: 1.226535936s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:18.863417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:17.636705Z","time spent":"1.226705941s","remote":"127.0.0.1:34558","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-27T16:03:18.863472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.249979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T16:03:18.863499Z","caller":"traceutil/trace.go:171","msg":"trace[1896452848] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:810; }","duration":"481.311099ms","start":"2026-04-27T16:03:18.382181Z","end":"2026-04-27T16:03:18.863492Z","steps":["trace[1896452848] 'agreement among raft nodes before linearized reading' (duration: 481.230885ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:18.863546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.687658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-27T16:03:18.863566Z","caller":"traceutil/trace.go:171","msg":"trace[1951040351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:810; }","duration":"744.751158ms","start":"2026-04-27T16:03:18.118809Z","end":"2026-04-27T16:03:18.86356Z","steps":["trace[1951040351] 'agreement among raft nodes before linearized reading' (duration: 744.685639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:18.863531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.246391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-27T16:03:18.863589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:18.118786Z","time spent":"744.798823ms","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-27T16:03:18.86361Z","caller":"traceutil/trace.go:171","msg":"trace[1814418224] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:810; }","duration":"273.369431ms","start":"2026-04-27T16:03:18.590226Z","end":"2026-04-27T16:03:18.863595Z","steps":["trace[1814418224] 'agreement among raft nodes before linearized reading' (duration: 273.241722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:18.863614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.269894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T16:03:18.863562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:18.382162Z","time spent":"481.394213ms","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T16:03:18.863732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.744393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-27T16:03:18.86375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.844163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T16:03:18.863878Z","caller":"traceutil/trace.go:171","msg":"trace[1055279471] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"948.417517ms","start":"2026-04-27T16:03:17.915283Z","end":"2026-04-27T16:03:18.863701Z","steps":["trace[1055279471] 'agreement among raft nodes before linearized reading' (duration: 948.122371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:18.863927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:17.915261Z","time spent":"948.6584ms","remote":"127.0.0.1:34298","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-27T16:03:18.863941Z","caller":"traceutil/trace.go:171","msg":"trace[1592328011] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:810; }","duration":"444.086707ms","start":"2026-04-27T16:03:18.419827Z","end":"2026-04-27T16:03:18.863914Z","steps":["trace[1592328011] 'agreement among raft nodes before linearized reading' (duration: 443.767738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:18.864036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:18.419808Z","time spent":"444.211457ms","remote":"127.0.0.1:34816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":31,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-04-27T16:03:18.864449Z","caller":"traceutil/trace.go:171","msg":"trace[1208351541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:810; }","duration":"906.798567ms","start":"2026-04-27T16:03:17.956952Z","end":"2026-04-27T16:03:18.863751Z","steps":["trace[1208351541] 'agreement among raft nodes before linearized reading' (duration: 906.677286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:18.864481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:17.956932Z","time spent":"907.54137ms","remote":"127.0.0.1:34558","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-27T16:03:19.437643Z","caller":"traceutil/trace.go:171","msg":"trace[193928000] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"571.238211ms","start":"2026-04-27T16:03:18.866382Z","end":"2026-04-27T16:03:19.43762Z","steps":["trace[193928000] 'process raft request' (duration: 571.100094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:19.43782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:18.866369Z","time spent":"571.344548ms","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:03:19.440074Z","caller":"traceutil/trace.go:171","msg":"trace[1691304022] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"572.767259ms","start":"2026-04-27T16:03:18.867289Z","end":"2026-04-27T16:03:19.440056Z","steps":["trace[1691304022] 'process raft request' (duration: 572.645107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:19.440182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:18.86727Z","time spent":"572.852922ms","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:03:19.440305Z","caller":"traceutil/trace.go:171","msg":"trace[1555901224] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"572.947503ms","start":"2026-04-27T16:03:18.867346Z","end":"2026-04-27T16:03:19.440294Z","steps":["trace[1555901224] 'process raft request' (duration: 572.678147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:19.440382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:18.867323Z","time spent":"573.026358ms","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T16:03:19.44047Z","caller":"traceutil/trace.go:171","msg":"trace[311007237] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:843; }","duration":"433.158846ms","start":"2026-04-27T16:03:19.007294Z","end":"2026-04-27T16:03:19.440453Z","steps":["trace[311007237] 'read index received' (duration: 430.146486ms)","trace[311007237] 'applied index is now lower than readState.Index' (duration: 3.01166ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:03:19.440515Z","caller":"traceutil/trace.go:171","msg":"trace[502321750] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"572.442015ms","start":"2026-04-27T16:03:18.868022Z","end":"2026-04-27T16:03:19.440464Z","steps":["trace[502321750] 'process raft request' (duration: 572.219035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:19.44056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.268582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T16:03:19.440596Z","caller":"traceutil/trace.go:171","msg":"trace[1009843119] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:814; }","duration":"433.350926ms","start":"2026-04-27T16:03:19.007234Z","end":"2026-04-27T16:03:19.440585Z","steps":["trace[1009843119] 'agreement among raft nodes before linearized reading' (duration: 433.278338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:19.440635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:19.00721Z","time spent":"433.414906ms","remote":"127.0.0.1:34396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-04-27T16:03:19.440643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:03:18.868006Z","time spent":"572.538296ms","remote":"127.0.0.1:34558","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-27T16:03:24.652488Z","caller":"traceutil/trace.go:171","msg":"trace[960714647] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"107.575027ms","start":"2026-04-27T16:03:24.544896Z","end":"2026-04-27T16:03:24.652471Z","steps":["trace[960714647] 'process raft request' (duration: 107.473654ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:03:24.840437Z","caller":"traceutil/trace.go:171","msg":"trace[926536827] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"160.361955ms","start":"2026-04-27T16:03:24.68002Z","end":"2026-04-27T16:03:24.840382Z","steps":["trace[926536827] 'process raft request' (duration: 140.722194ms)","trace[926536827] 'compare' (duration: 19.394469ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:03:31.746287Z","caller":"traceutil/trace.go:171","msg":"trace[1085565232] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"116.28178ms","start":"2026-04-27T16:03:31.629983Z","end":"2026-04-27T16:03:31.746265Z","steps":["trace[1085565232] 'process raft request' (duration: 96.279516ms)","trace[1085565232] 'compare' (duration: 19.914345ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T16:03:34.815053Z","caller":"traceutil/trace.go:171","msg":"trace[1248113686] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"179.368914ms","start":"2026-04-27T16:03:34.635618Z","end":"2026-04-27T16:03:34.814987Z","steps":["trace[1248113686] 'process raft request' (duration: 179.177677ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:03:34.830557Z","caller":"traceutil/trace.go:171","msg":"trace[846518867] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"134.010984ms","start":"2026-04-27T16:03:34.696524Z","end":"2026-04-27T16:03:34.830535Z","steps":["trace[846518867] 'process raft request' (duration: 133.791713ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:03:35.048422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.303901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T16:03:35.048501Z","caller":"traceutil/trace.go:171","msg":"trace[915971768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:989; }","duration":"133.423804ms","start":"2026-04-27T16:03:34.915056Z","end":"2026-04-27T16:03:35.04848Z","steps":["trace[915971768] 'range keys from in-memory index tree' (duration: 133.21924ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:03:45.098182Z","caller":"traceutil/trace.go:171","msg":"trace[622013465] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"110.381561ms","start":"2026-04-27T16:03:44.987777Z","end":"2026-04-27T16:03:45.098158Z","steps":["trace[622013465] 'process raft request' (duration: 110.254533ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:04:19.163179Z","caller":"traceutil/trace.go:171","msg":"trace[130228014] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"120.842197ms","start":"2026-04-27T16:04:19.042312Z","end":"2026-04-27T16:04:19.163154Z","steps":["trace[130228014] 'process raft request' (duration: 120.662837ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T16:05:12.653597Z","caller":"traceutil/trace.go:171","msg":"trace[1584400602] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"320.705748ms","start":"2026-04-27T16:05:12.332864Z","end":"2026-04-27T16:05:12.65357Z","steps":["trace[1584400602] 'process raft request' (duration: 317.389228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T16:05:12.653812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T16:05:12.332851Z","time spent":"320.845983ms","remote":"127.0.0.1:34558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"}