{"level":"warn","ts":"2026-05-19T15:42:51.409482Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T15:42:51.40957Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.152:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.152:2380","--initial-cluster=instance=https://199.19.213.152:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.152:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.152: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-05-19T15:42:51.409633Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T15:42:51.409648Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.152:2380"]} {"level":"info","ts":"2026-05-19T15:42:51.409667Z","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-05-19T15:42:51.410278Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.152:2379"]} {"level":"info","ts":"2026-05-19T15:42:51.410448Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.152:2380"],"listen-peer-urls":["https://199.19.213.152:2380"],"advertise-client-urls":["https://199.19.213.152:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.152:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.152: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-05-19T15:42:51.557685Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"146.943735ms"} {"level":"info","ts":"2026-05-19T15:42:51.63598Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"68d6d88687e6b830","cluster-id":"8a5d84e8c26d99a1"} {"level":"info","ts":"2026-05-19T15:42:51.636118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T15:42:51.636151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became follower at term 0"} {"level":"info","ts":"2026-05-19T15:42:51.63617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 68d6d88687e6b830 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T15:42:51.636213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became follower at term 1"} {"level":"info","ts":"2026-05-19T15:42:51.636286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 switched to configuration voters=(7554463497277847600)"} {"level":"warn","ts":"2026-05-19T15:42:51.658233Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T15:42:51.660571Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T15:42:51.662088Z","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-05-19T15:42:51.69765Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"68d6d88687e6b830","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T15:42:51.697949Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"68d6d88687e6b830","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T15:42:51.698107Z","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-05-19T15:42:51.698264Z","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-05-19T15:42:51.698279Z","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-05-19T15:42:51.700627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 switched to configuration voters=(7554463497277847600)"} {"level":"info","ts":"2026-05-19T15:42:51.701715Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8a5d84e8c26d99a1","local-member-id":"68d6d88687e6b830","added-peer-id":"68d6d88687e6b830","added-peer-peer-urls":["https://199.19.213.152:2380"]} {"level":"info","ts":"2026-05-19T15:42:51.704315Z","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-05-19T15:42:51.704462Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.152:2380"} {"level":"info","ts":"2026-05-19T15:42:51.70452Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.152:2380"} {"level":"info","ts":"2026-05-19T15:42:51.704581Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"68d6d88687e6b830","initial-advertise-peer-urls":["https://199.19.213.152:2380"],"listen-peer-urls":["https://199.19.213.152:2380"],"advertise-client-urls":["https://199.19.213.152:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.152:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T15:42:51.704627Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T15:42:51.937485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T15:42:51.937566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T15:42:51.93763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 received MsgPreVoteResp from 68d6d88687e6b830 at term 1"} {"level":"info","ts":"2026-05-19T15:42:51.937988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became candidate at term 2"} {"level":"info","ts":"2026-05-19T15:42:51.938034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 received MsgVoteResp from 68d6d88687e6b830 at term 2"} {"level":"info","ts":"2026-05-19T15:42:51.938052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68d6d88687e6b830 became leader at term 2"} {"level":"info","ts":"2026-05-19T15:42:51.93807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 68d6d88687e6b830 elected leader 68d6d88687e6b830 at term 2"} {"level":"info","ts":"2026-05-19T15:42:51.958098Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T15:42:51.976596Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T15:42:51.976584Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"68d6d88687e6b830","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.152:2379]}","request-path":"/0/members/68d6d88687e6b830/attributes","cluster-id":"8a5d84e8c26d99a1","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T15:42:51.976633Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T15:42:51.977001Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T15:42:51.977039Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T15:42:51.980977Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T15:42:51.981745Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.152:2379"} {"level":"info","ts":"2026-05-19T15:42:51.999691Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8a5d84e8c26d99a1","local-member-id":"68d6d88687e6b830","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T15:42:51.999852Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T15:42:51.999892Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T15:42:54.025807Z","caller":"traceutil/trace.go:171","msg":"trace[604216011] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"213.577592ms","start":"2026-05-19T15:42:53.812199Z","end":"2026-05-19T15:42:54.025777Z","steps":["trace[604216011] 'process raft request' (duration: 122.520795ms)","trace[604216011] 'compare' (duration: 90.743429ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:42:54.026093Z","caller":"traceutil/trace.go:171","msg":"trace[921745539] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"189.262814ms","start":"2026-05-19T15:42:53.836806Z","end":"2026-05-19T15:42:54.026069Z","steps":["trace[921745539] 'process raft request' (duration: 189.175682ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:54.026121Z","caller":"traceutil/trace.go:171","msg":"trace[1983968885] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"212.301591ms","start":"2026-05-19T15:42:53.813772Z","end":"2026-05-19T15:42:54.026074Z","steps":["trace[1983968885] 'process raft request' (duration: 211.928091ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:54.026161Z","caller":"traceutil/trace.go:171","msg":"trace[872676358] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"210.273909ms","start":"2026-05-19T15:42:53.815825Z","end":"2026-05-19T15:42:54.026099Z","steps":["trace[872676358] 'process raft request' (duration: 209.955001ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:54.027631Z","caller":"traceutil/trace.go:171","msg":"trace[1219039727] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"184.879194ms","start":"2026-05-19T15:42:53.842731Z","end":"2026-05-19T15:42:54.02761Z","steps":["trace[1219039727] 'process raft request' (duration: 184.850853ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:54.027685Z","caller":"traceutil/trace.go:171","msg":"trace[1277824999] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"185.348396ms","start":"2026-05-19T15:42:53.842321Z","end":"2026-05-19T15:42:54.027669Z","steps":["trace[1277824999] 'process raft request' (duration: 185.08424ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:54.02775Z","caller":"traceutil/trace.go:171","msg":"trace[820879128] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"185.059869ms","start":"2026-05-19T15:42:53.842672Z","end":"2026-05-19T15:42:54.027732Z","steps":["trace[820879128] 'process raft request' (duration: 184.860204ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:54.027777Z","caller":"traceutil/trace.go:171","msg":"trace[1765660621] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"185.052668ms","start":"2026-05-19T15:42:53.842712Z","end":"2026-05-19T15:42:54.027764Z","steps":["trace[1765660621] 'process raft request' (duration: 184.848284ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:54.027665Z","caller":"traceutil/trace.go:171","msg":"trace[1351862235] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"185.023328ms","start":"2026-05-19T15:42:53.842626Z","end":"2026-05-19T15:42:54.027649Z","steps":["trace[1351862235] 'process raft request' (duration: 184.878214ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:54.590585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.178976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-19T15:42:54.590801Z","caller":"traceutil/trace.go:171","msg":"trace[922475734] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"532.757643ms","start":"2026-05-19T15:42:54.058029Z","end":"2026-05-19T15:42:54.590787Z","steps":["trace[922475734] 'process raft request' (duration: 532.729273ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:54.590813Z","caller":"traceutil/trace.go:171","msg":"trace[1894178630] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"557.298707ms","start":"2026-05-19T15:42:54.0335Z","end":"2026-05-19T15:42:54.590799Z","steps":["trace[1894178630] 'process raft request' (duration: 314.341771ms)","trace[1894178630] 'compare' (duration: 241.990492ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T15:42:54.59084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:54.058015Z","time spent":"532.808734ms","remote":"127.0.0.1:48192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":647,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T15:42:54.590892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:54.033484Z","time spent":"557.353818ms","remote":"127.0.0.1:48294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T15:42:54.591007Z","caller":"traceutil/trace.go:171","msg":"trace[1819590466] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"557.222945ms","start":"2026-05-19T15:42:54.033777Z","end":"2026-05-19T15:42:54.591Z","steps":["trace[1819590466] 'process raft request' (duration: 556.925377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:54.591042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:54.033772Z","time spent":"557.249726ms","remote":"127.0.0.1:48294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T15:42:54.590858Z","caller":"traceutil/trace.go:171","msg":"trace[1697895113] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"557.133962ms","start":"2026-05-19T15:42:54.033653Z","end":"2026-05-19T15:42:54.590787Z","steps":["trace[1697895113] 'process raft request' (duration: 557.02108ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:54.591109Z","caller":"traceutil/trace.go:171","msg":"trace[992899126] linearizableReadLoop","detail":"{readStateIndex:34; appliedIndex:31; }","duration":"557.012299ms","start":"2026-05-19T15:42:54.03404Z","end":"2026-05-19T15:42:54.591052Z","steps":["trace[992899126] 'read index received' (duration: 20.847411ms)","trace[992899126] 'applied index is now lower than readState.Index' (duration: 536.154268ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:42:54.591204Z","caller":"traceutil/trace.go:171","msg":"trace[1282044829] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"556.936868ms","start":"2026-05-19T15:42:54.034258Z","end":"2026-05-19T15:42:54.591195Z","steps":["trace[1282044829] 'process raft request' (duration: 556.465096ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:54.591238Z","caller":"traceutil/trace.go:171","msg":"trace[806985549] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"556.556349ms","start":"2026-05-19T15:42:54.034672Z","end":"2026-05-19T15:42:54.591228Z","steps":["trace[806985549] 'process raft request' (duration: 556.064516ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:54.591252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:54.034251Z","time spent":"556.978119ms","remote":"127.0.0.1:48294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T15:42:54.59127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:54.034662Z","time spent":"556.593569ms","remote":"127.0.0.1:48294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T15:42:54.591275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:54.033647Z","time spent":"557.538273ms","remote":"127.0.0.1:48294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T15:42:54.591396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.714126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T15:42:54.59142Z","caller":"traceutil/trace.go:171","msg":"trace[1558040427] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:33; }","duration":"545.764858ms","start":"2026-05-19T15:42:54.045649Z","end":"2026-05-19T15:42:54.591414Z","steps":["trace[1558040427] 'agreement among raft nodes before linearized reading' (duration: 545.673956ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:54.591447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:54.045636Z","time spent":"545.797548ms","remote":"127.0.0.1:48146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-19T15:42:54.591532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.44509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T15:42:54.591586Z","caller":"traceutil/trace.go:171","msg":"trace[1133073721] range","detail":"{range_begin:/registry/resourcequotas/default/; range_end:/registry/resourcequotas/default0; response_count:0; response_revision:33; }","duration":"557.551683ms","start":"2026-05-19T15:42:54.034014Z","end":"2026-05-19T15:42:54.591566Z","steps":["trace[1133073721] 'agreement among raft nodes before linearized reading' (duration: 557.290956ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:54.591632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:54.034007Z","time spent":"557.615185ms","remote":"127.0.0.1:47842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" "} {"level":"warn","ts":"2026-05-19T15:42:58.215991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.615272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:42:58.216122Z","caller":"traceutil/trace.go:171","msg":"trace[848495676] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:0; response_revision:262; }","duration":"526.809667ms","start":"2026-05-19T15:42:57.689288Z","end":"2026-05-19T15:42:58.216098Z","steps":["trace[848495676] 'range keys from in-memory index tree' (duration: 526.52998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:58.216173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:57.689268Z","time spent":"526.8945ms","remote":"127.0.0.1:47972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" "} {"level":"warn","ts":"2026-05-19T15:42:58.216485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.769235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-05-19T15:42:58.216582Z","caller":"traceutil/trace.go:171","msg":"trace[1514781367] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:262; }","duration":"117.949479ms","start":"2026-05-19T15:42:58.09861Z","end":"2026-05-19T15:42:58.216559Z","steps":["trace[1514781367] 'range keys from in-memory index tree' (duration: 117.634912ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:58.216673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.152983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:42:58.216782Z","caller":"traceutil/trace.go:171","msg":"trace[1110658499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:262; }","duration":"383.286868ms","start":"2026-05-19T15:42:57.833463Z","end":"2026-05-19T15:42:58.21675Z","steps":["trace[1110658499] 'range keys from in-memory index tree' (duration: 383.081812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:58.216814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:57.833445Z","time spent":"383.362889ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-19T15:42:58.869978Z","caller":"traceutil/trace.go:171","msg":"trace[2042600425] linearizableReadLoop","detail":"{readStateIndex:274; appliedIndex:272; }","duration":"641.435665ms","start":"2026-05-19T15:42:58.228518Z","end":"2026-05-19T15:42:58.869954Z","steps":["trace[2042600425] 'read index received' (duration: 68.399161ms)","trace[2042600425] 'applied index is now lower than readState.Index' (duration: 573.035584ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:42:58.870127Z","caller":"traceutil/trace.go:171","msg":"trace[1027350660] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"622.303526ms","start":"2026-05-19T15:42:58.247812Z","end":"2026-05-19T15:42:58.870115Z","steps":["trace[1027350660] 'process raft request' (duration: 622.08251ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:42:58.87034Z","caller":"traceutil/trace.go:171","msg":"trace[967101793] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"646.041319ms","start":"2026-05-19T15:42:58.224261Z","end":"2026-05-19T15:42:58.870303Z","steps":["trace[967101793] 'process raft request' (duration: 645.479665ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:58.87052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:58.224236Z","time spent":"646.212383ms","remote":"127.0.0.1:47972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":190,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T15:42:58.870549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:58.24778Z","time spent":"622.375687ms","remote":"127.0.0.1:47942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T15:42:58.870886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.567546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-19T15:42:58.870936Z","caller":"traceutil/trace.go:171","msg":"trace[2075690020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:265; }","duration":"565.68914ms","start":"2026-05-19T15:42:58.305232Z","end":"2026-05-19T15:42:58.870921Z","steps":["trace[2075690020] 'agreement among raft nodes before linearized reading' (duration: 565.576957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:58.870974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:58.305202Z","time spent":"565.764381ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T15:42:58.870997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.4607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:42:58.871038Z","caller":"traceutil/trace.go:171","msg":"trace[460898751] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:265; }","duration":"642.546171ms","start":"2026-05-19T15:42:58.228479Z","end":"2026-05-19T15:42:58.871025Z","steps":["trace[460898751] 'agreement among raft nodes before linearized reading' (duration: 642.471219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:42:58.87107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:42:58.228462Z","time spent":"642.601493ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T15:42:58.871144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.976632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-19T15:42:58.871347Z","caller":"traceutil/trace.go:171","msg":"trace[141556371] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:265; }","duration":"216.177987ms","start":"2026-05-19T15:42:58.655131Z","end":"2026-05-19T15:42:58.871309Z","steps":["trace[141556371] 'agreement among raft nodes before linearized reading' (duration: 215.975811ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:43:21.839873Z","caller":"traceutil/trace.go:171","msg":"trace[575146336] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"260.433496ms","start":"2026-05-19T15:43:21.579397Z","end":"2026-05-19T15:43:21.839831Z","steps":["trace[575146336] 'process raft request' (duration: 260.16413ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:43:24.786635Z","caller":"traceutil/trace.go:171","msg":"trace[641224066] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"267.748818ms","start":"2026-05-19T15:43:24.518848Z","end":"2026-05-19T15:43:24.786597Z","steps":["trace[641224066] 'process raft request' (duration: 267.459601ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:43:28.595555Z","caller":"traceutil/trace.go:171","msg":"trace[475493107] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"161.557333ms","start":"2026-05-19T15:43:28.433936Z","end":"2026-05-19T15:43:28.595494Z","steps":["trace[475493107] 'read index received' (duration: 160.018673ms)","trace[475493107] 'applied index is now lower than readState.Index' (duration: 1.53729ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:43:28.595644Z","caller":"traceutil/trace.go:171","msg":"trace[578484467] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"331.169106ms","start":"2026-05-19T15:43:28.264431Z","end":"2026-05-19T15:43:28.5956Z","steps":["trace[578484467] 'process raft request' (duration: 330.057568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:28.595804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.81755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T15:43:28.595868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:28.264386Z","time spent":"331.378031ms","remote":"127.0.0.1:47854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T15:43:28.595879Z","caller":"traceutil/trace.go:171","msg":"trace[972805653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"161.963923ms","start":"2026-05-19T15:43:28.433876Z","end":"2026-05-19T15:43:28.59584Z","steps":["trace[972805653] 'agreement among raft nodes before linearized reading' (duration: 161.795939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:28.800993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.036672ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T15:43:28.801153Z","caller":"traceutil/trace.go:171","msg":"trace[781328690] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"137.096063ms","start":"2026-05-19T15:43:28.664034Z","end":"2026-05-19T15:43:28.80113Z","steps":["trace[781328690] 'process raft request' (duration: 25.831965ms)","trace[781328690] 'compare' (duration: 110.791646ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T15:43:30.02313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.792776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T15:43:30.023242Z","caller":"traceutil/trace.go:171","msg":"trace[319423494] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:574; }","duration":"871.950149ms","start":"2026-05-19T15:43:29.151266Z","end":"2026-05-19T15:43:30.023217Z","steps":["trace[319423494] 'range keys from in-memory index tree' (duration: 871.54118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:30.023293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:29.15125Z","time spent":"872.031722ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T15:43:30.02332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.49684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-19T15:43:30.023401Z","caller":"traceutil/trace.go:171","msg":"trace[473257913] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:574; }","duration":"956.642354ms","start":"2026-05-19T15:43:29.066737Z","end":"2026-05-19T15:43:30.023379Z","steps":["trace[473257913] 'range keys from in-memory index tree' (duration: 956.192932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:30.023436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:29.066706Z","time spent":"956.723397ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T15:43:30.023592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.617555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-19T15:43:30.023633Z","caller":"traceutil/trace.go:171","msg":"trace[2096388645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:574; }","duration":"896.690387ms","start":"2026-05-19T15:43:29.126929Z","end":"2026-05-19T15:43:30.023619Z","steps":["trace[2096388645] 'range keys from in-memory index tree' (duration: 896.387339ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:30.023661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:29.12691Z","time spent":"896.744378ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T15:43:30.023567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.084633ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:43:30.02374Z","caller":"traceutil/trace.go:171","msg":"trace[15430969] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:574; }","duration":"818.285618ms","start":"2026-05-19T15:43:29.205428Z","end":"2026-05-19T15:43:30.023713Z","steps":["trace[15430969] 'range keys from in-memory index tree' (duration: 818.060552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:30.023915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.558491ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T15:43:30.023975Z","caller":"traceutil/trace.go:171","msg":"trace[320634900] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"589.349003ms","start":"2026-05-19T15:43:29.434615Z","end":"2026-05-19T15:43:30.023964Z","steps":["trace[320634900] 'read index received' (duration: 10.475323ms)","trace[320634900] 'applied index is now lower than readState.Index' (duration: 578.87247ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:43:30.024051Z","caller":"traceutil/trace.go:171","msg":"trace[1846176276] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"752.819086ms","start":"2026-05-19T15:43:29.271223Z","end":"2026-05-19T15:43:30.024042Z","steps":["trace[1846176276] 'process raft request' (duration: 174.051359ms)","trace[1846176276] 'compare' (duration: 577.799442ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T15:43:30.024089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:29.271201Z","time spent":"752.865767ms","remote":"127.0.0.1:47854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T15:43:30.02422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.623721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:43:30.02424Z","caller":"traceutil/trace.go:171","msg":"trace[1244643650] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"589.703453ms","start":"2026-05-19T15:43:29.43453Z","end":"2026-05-19T15:43:30.024233Z","steps":["trace[1244643650] 'agreement among raft nodes before linearized reading' (duration: 589.667192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:30.024257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:29.434462Z","time spent":"589.791686ms","remote":"127.0.0.1:47752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T15:43:30.024557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.365976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T15:43:30.024645Z","caller":"traceutil/trace.go:171","msg":"trace[1836927288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:575; }","duration":"120.487739ms","start":"2026-05-19T15:43:29.904113Z","end":"2026-05-19T15:43:30.024601Z","steps":["trace[1836927288] 'agreement among raft nodes before linearized reading' (duration: 120.284264ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:43:30.236575Z","caller":"traceutil/trace.go:171","msg":"trace[297345359] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"206.590719ms","start":"2026-05-19T15:43:30.029954Z","end":"2026-05-19T15:43:30.236545Z","steps":["trace[297345359] 'process raft request' (duration: 206.331893ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:43:30.236911Z","caller":"traceutil/trace.go:171","msg":"trace[1379010396] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"205.743066ms","start":"2026-05-19T15:43:30.031137Z","end":"2026-05-19T15:43:30.23688Z","steps":["trace[1379010396] 'process raft request' (duration: 205.357467ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:43:30.237498Z","caller":"traceutil/trace.go:171","msg":"trace[959489296] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"206.194718ms","start":"2026-05-19T15:43:30.031291Z","end":"2026-05-19T15:43:30.237486Z","steps":["trace[959489296] 'process raft request' (duration: 205.50332ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:43:30.237629Z","caller":"traceutil/trace.go:171","msg":"trace[1019227093] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"152.917697ms","start":"2026-05-19T15:43:30.084683Z","end":"2026-05-19T15:43:30.237601Z","steps":["trace[1019227093] 'process raft request' (duration: 152.628849ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:43:31.707334Z","caller":"traceutil/trace.go:171","msg":"trace[723636413] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"354.835434ms","start":"2026-05-19T15:43:31.352468Z","end":"2026-05-19T15:43:31.707303Z","steps":["trace[723636413] 'process raft request' (duration: 354.002833ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:43:31.707354Z","caller":"traceutil/trace.go:171","msg":"trace[1332416581] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"348.280984ms","start":"2026-05-19T15:43:31.359048Z","end":"2026-05-19T15:43:31.707329Z","steps":["trace[1332416581] 'read index received' (duration: 347.36537ms)","trace[1332416581] 'applied index is now lower than readState.Index' (duration: 913.994µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T15:43:31.707505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:31.352452Z","time spent":"354.982657ms","remote":"127.0.0.1:47838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T15:43:31.707701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.5393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:43:31.707766Z","caller":"traceutil/trace.go:171","msg":"trace[195487668] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:594; }","duration":"348.704804ms","start":"2026-05-19T15:43:31.359049Z","end":"2026-05-19T15:43:31.707754Z","steps":["trace[195487668] 'agreement among raft nodes before linearized reading' (duration: 348.54853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.70786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:31.359017Z","time spent":"348.774885ms","remote":"127.0.0.1:55130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T15:43:31.707889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.239724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:43:31.707935Z","caller":"traceutil/trace.go:171","msg":"trace[1040137986] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:594; }","duration":"218.302846ms","start":"2026-05-19T15:43:31.489615Z","end":"2026-05-19T15:43:31.707918Z","steps":["trace[1040137986] 'agreement among raft nodes before linearized reading' (duration: 218.224374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.708219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.427665ms","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-05-19T15:43:31.708281Z","caller":"traceutil/trace.go:171","msg":"trace[26422148] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"245.492606ms","start":"2026-05-19T15:43:31.462751Z","end":"2026-05-19T15:43:31.708243Z","steps":["trace[26422148] 'agreement among raft nodes before linearized reading' (duration: 245.439715ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.708339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.51627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:43:31.708406Z","caller":"traceutil/trace.go:171","msg":"trace[1627106995] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:594; }","duration":"125.627733ms","start":"2026-05-19T15:43:31.582757Z","end":"2026-05-19T15:43:31.708384Z","steps":["trace[1627106995] 'agreement among raft nodes before linearized reading' (duration: 125.543901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.708821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.181758ms","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":"info","ts":"2026-05-19T15:43:31.708883Z","caller":"traceutil/trace.go:171","msg":"trace[2103553882] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:594; }","duration":"126.296421ms","start":"2026-05-19T15:43:31.582572Z","end":"2026-05-19T15:43:31.708868Z","steps":["trace[2103553882] 'agreement among raft nodes before linearized reading' (duration: 126.153807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.708999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.703155ms","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":"warn","ts":"2026-05-19T15:43:31.708981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.81964ms","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-05-19T15:43:31.709074Z","caller":"traceutil/trace.go:171","msg":"trace[1399045297] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"246.929173ms","start":"2026-05-19T15:43:31.462129Z","end":"2026-05-19T15:43:31.709058Z","steps":["trace[1399045297] 'agreement among raft nodes before linearized reading' (duration: 246.735569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.709213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.350364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:43:31.709271Z","caller":"traceutil/trace.go:171","msg":"trace[1864977358] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:594; }","duration":"219.467896ms","start":"2026-05-19T15:43:31.489789Z","end":"2026-05-19T15:43:31.709257Z","steps":["trace[1864977358] 'agreement among raft nodes before linearized reading' (duration: 219.386423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.708845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.551314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T15:43:31.709335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.582769ms","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-05-19T15:43:31.70935Z","caller":"traceutil/trace.go:171","msg":"trace[7300828] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"247.059618ms","start":"2026-05-19T15:43:31.462259Z","end":"2026-05-19T15:43:31.709319Z","steps":["trace[7300828] 'agreement among raft nodes before linearized reading' (duration: 246.540844ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:43:31.7094Z","caller":"traceutil/trace.go:171","msg":"trace[2119984993] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:594; }","duration":"333.650721ms","start":"2026-05-19T15:43:31.37573Z","end":"2026-05-19T15:43:31.709381Z","steps":["trace[2119984993] 'agreement among raft nodes before linearized reading' (duration: 333.57327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.709482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:31.375727Z","time spent":"333.696262ms","remote":"127.0.0.1:55134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"info","ts":"2026-05-19T15:43:31.709124Z","caller":"traceutil/trace.go:171","msg":"trace[309085353] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:594; }","duration":"125.817238ms","start":"2026-05-19T15:43:31.583217Z","end":"2026-05-19T15:43:31.709035Z","steps":["trace[309085353] 'agreement among raft nodes before linearized reading' (duration: 125.455939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.709662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.188434ms","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-05-19T15:43:31.709717Z","caller":"traceutil/trace.go:171","msg":"trace[577264062] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:594; }","duration":"334.289187ms","start":"2026-05-19T15:43:31.37542Z","end":"2026-05-19T15:43:31.709709Z","steps":["trace[577264062] 'agreement among raft nodes before linearized reading' (duration: 334.213925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.709092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.392888ms","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":"warn","ts":"2026-05-19T15:43:31.709765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:31.375395Z","time spent":"334.360989ms","remote":"127.0.0.1:55134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-05-19T15:43:31.709761Z","caller":"traceutil/trace.go:171","msg":"trace[1913216239] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:594; }","duration":"219.068466ms","start":"2026-05-19T15:43:31.490682Z","end":"2026-05-19T15:43:31.709751Z","steps":["trace[1913216239] 'agreement among raft nodes before linearized reading' (duration: 218.365327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.709664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.920348ms","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-05-19T15:43:31.709887Z","caller":"traceutil/trace.go:171","msg":"trace[2138329218] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:594; }","duration":"334.143203ms","start":"2026-05-19T15:43:31.375712Z","end":"2026-05-19T15:43:31.709855Z","steps":["trace[2138329218] 'agreement among raft nodes before linearized reading' (duration: 333.895447ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.709926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:31.375691Z","time spent":"334.224697ms","remote":"127.0.0.1:55134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-19T15:43:31.710087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.524712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:43:31.710138Z","caller":"traceutil/trace.go:171","msg":"trace[1176608834] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"275.633715ms","start":"2026-05-19T15:43:31.434497Z","end":"2026-05-19T15:43:31.710131Z","steps":["trace[1176608834] 'agreement among raft nodes before linearized reading' (duration: 275.533572ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.710231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.540008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T15:43:31.710209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.526352ms","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-05-19T15:43:31.710284Z","caller":"traceutil/trace.go:171","msg":"trace[53134536] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"275.672715ms","start":"2026-05-19T15:43:31.434596Z","end":"2026-05-19T15:43:31.710269Z","steps":["trace[53134536] 'agreement among raft nodes before linearized reading' (duration: 275.517212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.710235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.599654ms","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-05-19T15:43:31.710265Z","caller":"traceutil/trace.go:171","msg":"trace[1756498981] 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:594; }","duration":"307.579659ms","start":"2026-05-19T15:43:31.402677Z","end":"2026-05-19T15:43:31.710256Z","steps":["trace[1756498981] 'agreement among raft nodes before linearized reading' (duration: 307.526138ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:43:31.710429Z","caller":"traceutil/trace.go:171","msg":"trace[1983858319] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"275.803519ms","start":"2026-05-19T15:43:31.434607Z","end":"2026-05-19T15:43:31.710411Z","steps":["trace[1983858319] 'agreement among raft nodes before linearized reading' (duration: 275.526122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.71045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:31.402656Z","time spent":"307.782954ms","remote":"127.0.0.1:55136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"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-05-19T15:43:31.710441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.466142ms","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-05-19T15:43:31.710571Z","caller":"traceutil/trace.go:171","msg":"trace[929512725] 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:594; }","duration":"308.609685ms","start":"2026-05-19T15:43:31.40194Z","end":"2026-05-19T15:43:31.710549Z","steps":["trace[929512725] 'agreement among raft nodes before linearized reading' (duration: 308.38959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.710639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:31.401937Z","time spent":"308.682658ms","remote":"127.0.0.1:55136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T15:43:31.710736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.684403ms","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-05-19T15:43:31.710838Z","caller":"traceutil/trace.go:171","msg":"trace[1003800542] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:594; }","duration":"351.785525ms","start":"2026-05-19T15:43:31.359041Z","end":"2026-05-19T15:43:31.710826Z","steps":["trace[1003800542] 'agreement among raft nodes before linearized reading' (duration: 348.449668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.710993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:31.358967Z","time spent":"352.014311ms","remote":"127.0.0.1:55130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T15:43:31.711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.132136ms","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-05-19T15:43:31.71104Z","caller":"traceutil/trace.go:171","msg":"trace[801969130] 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:594; }","duration":"309.132599ms","start":"2026-05-19T15:43:31.401896Z","end":"2026-05-19T15:43:31.711029Z","steps":["trace[801969130] 'agreement among raft nodes before linearized reading' (duration: 307.142387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:31.711093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:31.401879Z","time spent":"309.20592ms","remote":"127.0.0.1:55136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-19T15:43:35.53489Z","caller":"traceutil/trace.go:171","msg":"trace[2016878250] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"147.980208ms","start":"2026-05-19T15:43:35.386884Z","end":"2026-05-19T15:43:35.534864Z","steps":["trace[2016878250] 'read index received' (duration: 147.578437ms)","trace[2016878250] 'applied index is now lower than readState.Index' (duration: 400.271µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:43:35.535133Z","caller":"traceutil/trace.go:171","msg":"trace[1257030911] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"152.418023ms","start":"2026-05-19T15:43:35.382703Z","end":"2026-05-19T15:43:35.535121Z","steps":["trace[1257030911] 'process raft request' (duration: 151.861289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:35.535567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.365469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:43:35.535644Z","caller":"traceutil/trace.go:171","msg":"trace[662864800] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"101.484062ms","start":"2026-05-19T15:43:35.43414Z","end":"2026-05-19T15:43:35.535624Z","steps":["trace[662864800] 'agreement among raft nodes before linearized reading' (duration: 101.333659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:35.535813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.86768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.152\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-19T15:43:35.535952Z","caller":"traceutil/trace.go:171","msg":"trace[48693715] range","detail":"{range_begin:/registry/masterleases/199.19.213.152; range_end:; response_count:1; response_revision:657; }","duration":"149.058716ms","start":"2026-05-19T15:43:35.386862Z","end":"2026-05-19T15:43:35.535921Z","steps":["trace[48693715] 'agreement among raft nodes before linearized reading' (duration: 148.654015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:54.211223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.593438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-19T15:43:54.211294Z","caller":"traceutil/trace.go:171","msg":"trace[33113595] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:760; }","duration":"323.69828ms","start":"2026-05-19T15:43:53.887583Z","end":"2026-05-19T15:43:54.211282Z","steps":["trace[33113595] 'range keys from in-memory index tree' (duration: 323.465675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:43:54.211323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:43:53.887559Z","time spent":"323.758382ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-19T15:44:28.793569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.900848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:44:28.793674Z","caller":"traceutil/trace.go:171","msg":"trace[784761913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:973; }","duration":"359.045562ms","start":"2026-05-19T15:44:28.434605Z","end":"2026-05-19T15:44:28.79365Z","steps":["trace[784761913] 'range keys from in-memory index tree' (duration: 358.754285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:44:28.793727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:44:28.434584Z","time spent":"359.129594ms","remote":"127.0.0.1:47752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T15:44:28.793747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.917674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-19T15:44:28.793813Z","caller":"traceutil/trace.go:171","msg":"trace[1122278807] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:973; }","duration":"399.030827ms","start":"2026-05-19T15:44:28.394767Z","end":"2026-05-19T15:44:28.793798Z","steps":["trace[1122278807] 'range keys from in-memory index tree' (duration: 398.77043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:44:28.793844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:44:28.394748Z","time spent":"399.091118ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T15:44:28.793868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.330929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-19T15:44:28.793956Z","caller":"traceutil/trace.go:171","msg":"trace[247285344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:973; }","duration":"261.453761ms","start":"2026-05-19T15:44:28.53248Z","end":"2026-05-19T15:44:28.793933Z","steps":["trace[247285344] 'range keys from in-memory index tree' (duration: 261.127893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:44:28.793963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.746291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-19T15:44:28.794041Z","caller":"traceutil/trace.go:171","msg":"trace[2029230084] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:973; }","duration":"266.855053ms","start":"2026-05-19T15:44:28.527166Z","end":"2026-05-19T15:44:28.794021Z","steps":["trace[2029230084] 'range keys from in-memory index tree' (duration: 266.605587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:44:28.794146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.611265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T15:44:28.794243Z","caller":"traceutil/trace.go:171","msg":"trace[179287195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:973; }","duration":"261.76235ms","start":"2026-05-19T15:44:28.53246Z","end":"2026-05-19T15:44:28.794222Z","steps":["trace[179287195] 'range keys from in-memory index tree' (duration: 261.37579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:44:28.794323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.690981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-19T15:44:28.794424Z","caller":"traceutil/trace.go:171","msg":"trace[1265847133] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:973; }","duration":"398.661168ms","start":"2026-05-19T15:44:28.395748Z","end":"2026-05-19T15:44:28.794409Z","steps":["trace[1265847133] 'range keys from in-memory index tree' (duration: 397.547528ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:44:28.794476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:44:28.395742Z","time spent":"398.719769ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-19T15:44:28.9355Z","caller":"traceutil/trace.go:171","msg":"trace[2144845042] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"135.575041ms","start":"2026-05-19T15:44:28.799902Z","end":"2026-05-19T15:44:28.935477Z","steps":["trace[2144845042] 'process raft request' (duration: 135.418428ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:44:28.95582Z","caller":"traceutil/trace.go:171","msg":"trace[1300091564] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"155.885152ms","start":"2026-05-19T15:44:28.799909Z","end":"2026-05-19T15:44:28.955794Z","steps":["trace[1300091564] 'process raft request' (duration: 155.591945ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:44:28.95624Z","caller":"traceutil/trace.go:171","msg":"trace[1226780610] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"156.262073ms","start":"2026-05-19T15:44:28.799968Z","end":"2026-05-19T15:44:28.95623Z","steps":["trace[1226780610] 'process raft request' (duration: 155.700188ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:44:28.9563Z","caller":"traceutil/trace.go:171","msg":"trace[285723706] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"153.868511ms","start":"2026-05-19T15:44:28.802402Z","end":"2026-05-19T15:44:28.95627Z","steps":["trace[285723706] 'process raft request' (duration: 153.81734ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:44:28.956405Z","caller":"traceutil/trace.go:171","msg":"trace[163338353] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"156.332784ms","start":"2026-05-19T15:44:28.800036Z","end":"2026-05-19T15:44:28.956368Z","steps":["trace[163338353] 'process raft request' (duration: 156.115099ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:44:49.30315Z","caller":"traceutil/trace.go:171","msg":"trace[2110946888] linearizableReadLoop","detail":"{readStateIndex:1080; appliedIndex:1079; }","duration":"261.806101ms","start":"2026-05-19T15:44:49.041323Z","end":"2026-05-19T15:44:49.303129Z","steps":["trace[2110946888] 'read index received' (duration: 261.634967ms)","trace[2110946888] 'applied index is now lower than readState.Index' (duration: 170.474µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:44:49.303391Z","caller":"traceutil/trace.go:171","msg":"trace[16253038] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"271.839643ms","start":"2026-05-19T15:44:49.031543Z","end":"2026-05-19T15:44:49.303382Z","steps":["trace[16253038] 'process raft request' (duration: 271.472774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:44:49.3036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.272783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T15:44:49.303628Z","caller":"traceutil/trace.go:171","msg":"trace[1301688630] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1040; }","duration":"262.371526ms","start":"2026-05-19T15:44:49.04125Z","end":"2026-05-19T15:44:49.303622Z","steps":["trace[1301688630] 'agreement among raft nodes before linearized reading' (duration: 262.263314ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:44:49.303744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.233363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-19T15:44:49.303774Z","caller":"traceutil/trace.go:171","msg":"trace[2064930434] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1040; }","duration":"161.299224ms","start":"2026-05-19T15:44:49.14247Z","end":"2026-05-19T15:44:49.303769Z","steps":["trace[2064930434] 'agreement among raft nodes before linearized reading' (duration: 161.238373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:44:49.303868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.993047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-19T15:44:49.303888Z","caller":"traceutil/trace.go:171","msg":"trace[1363615836] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1040; }","duration":"161.033438ms","start":"2026-05-19T15:44:49.14285Z","end":"2026-05-19T15:44:49.303883Z","steps":["trace[1363615836] 'agreement among raft nodes before linearized reading' (duration: 160.980487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:44:49.304199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.588432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-19T15:44:49.304225Z","caller":"traceutil/trace.go:171","msg":"trace[1742207308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1040; }","duration":"161.658814ms","start":"2026-05-19T15:44:49.142561Z","end":"2026-05-19T15:44:49.30422Z","steps":["trace[1742207308] 'agreement among raft nodes before linearized reading' (duration: 161.588021ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:44:49.512915Z","caller":"traceutil/trace.go:171","msg":"trace[251684398] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"205.066908ms","start":"2026-05-19T15:44:49.307816Z","end":"2026-05-19T15:44:49.512883Z","steps":["trace[251684398] 'process raft request' (duration: 201.110685ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:44:49.518468Z","caller":"traceutil/trace.go:171","msg":"trace[1563274742] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"209.192067ms","start":"2026-05-19T15:44:49.309246Z","end":"2026-05-19T15:44:49.518438Z","steps":["trace[1563274742] 'process raft request' (duration: 208.758385ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:44:49.518551Z","caller":"traceutil/trace.go:171","msg":"trace[1458866717] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"210.386688ms","start":"2026-05-19T15:44:49.308154Z","end":"2026-05-19T15:44:49.518541Z","steps":["trace[1458866717] 'process raft request' (duration: 209.68622ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:44:49.51847Z","caller":"traceutil/trace.go:171","msg":"trace[1100689949] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"207.630636ms","start":"2026-05-19T15:44:49.310808Z","end":"2026-05-19T15:44:49.518438Z","steps":["trace[1100689949] 'process raft request' (duration: 207.229715ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:45:04.282699Z","caller":"traceutil/trace.go:171","msg":"trace[283282403] linearizableReadLoop","detail":"{readStateIndex:1187; appliedIndex:1186; }","duration":"265.458307ms","start":"2026-05-19T15:45:04.017201Z","end":"2026-05-19T15:45:04.282659Z","steps":["trace[283282403] 'read index received' (duration: 264.983805ms)","trace[283282403] 'applied index is now lower than readState.Index' (duration: 472.581µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:45:04.282828Z","caller":"traceutil/trace.go:171","msg":"trace[299206847] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"510.259934ms","start":"2026-05-19T15:45:03.772525Z","end":"2026-05-19T15:45:04.282785Z","steps":["trace[299206847] 'process raft request' (duration: 509.899544ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:45:04.282908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.681973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:45:04.282985Z","caller":"traceutil/trace.go:171","msg":"trace[1135409500] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1142; }","duration":"265.813326ms","start":"2026-05-19T15:45:04.017151Z","end":"2026-05-19T15:45:04.282964Z","steps":["trace[1135409500] 'agreement among raft nodes before linearized reading' (duration: 265.651802ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:45:04.283029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:45:03.772495Z","time spent":"510.429457ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T15:45:04.28318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.110619ms","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-05-19T15:45:04.283323Z","caller":"traceutil/trace.go:171","msg":"trace[1738363411] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1142; }","duration":"161.371076ms","start":"2026-05-19T15:45:04.12192Z","end":"2026-05-19T15:45:04.283291Z","steps":["trace[1738363411] 'agreement among raft nodes before linearized reading' (duration: 161.055198ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:45:20.809374Z","caller":"traceutil/trace.go:171","msg":"trace[1800906754] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"240.88878ms","start":"2026-05-19T15:45:20.568455Z","end":"2026-05-19T15:45:20.809344Z","steps":["trace[1800906754] 'process raft request' (duration: 240.650823ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:45:20.840564Z","caller":"traceutil/trace.go:171","msg":"trace[373616382] linearizableReadLoop","detail":"{readStateIndex:1265; appliedIndex:1263; }","duration":"158.863469ms","start":"2026-05-19T15:45:20.681654Z","end":"2026-05-19T15:45:20.840517Z","steps":["trace[373616382] 'read index received' (duration: 127.488214ms)","trace[373616382] 'applied index is now lower than readState.Index' (duration: 31.373575ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:45:20.840655Z","caller":"traceutil/trace.go:171","msg":"trace[1921352615] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"181.593079ms","start":"2026-05-19T15:45:20.659029Z","end":"2026-05-19T15:45:20.840622Z","steps":["trace[1921352615] 'process raft request' (duration: 181.296302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:45:20.840883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.120576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T15:45:20.840948Z","caller":"traceutil/trace.go:171","msg":"trace[190521995] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1217; }","duration":"159.331231ms","start":"2026-05-19T15:45:20.681597Z","end":"2026-05-19T15:45:20.840929Z","steps":["trace[190521995] 'agreement among raft nodes before linearized reading' (duration: 159.068214ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:45:21.623394Z","caller":"traceutil/trace.go:171","msg":"trace[382249151] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"104.752372ms","start":"2026-05-19T15:45:21.518617Z","end":"2026-05-19T15:45:21.623369Z","steps":["trace[382249151] 'process raft request' (duration: 104.586287ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:45:22.006101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.542702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-19T15:45:22.00619Z","caller":"traceutil/trace.go:171","msg":"trace[84448797] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1224; }","duration":"322.702486ms","start":"2026-05-19T15:45:21.683467Z","end":"2026-05-19T15:45:22.00617Z","steps":["trace[84448797] 'range keys from in-memory index tree' (duration: 322.319346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:45:22.006199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.455097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-19T15:45:22.006379Z","caller":"traceutil/trace.go:171","msg":"trace[544128521] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1224; }","duration":"345.718075ms","start":"2026-05-19T15:45:21.66061Z","end":"2026-05-19T15:45:22.006328Z","steps":["trace[544128521] 'range keys from in-memory index tree' (duration: 345.187271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:45:22.006348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.338306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-19T15:45:22.00625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:45:21.683434Z","time spent":"322.802599ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T15:45:22.006463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:45:21.660574Z","time spent":"345.872029ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-19T15:45:22.006478Z","caller":"traceutil/trace.go:171","msg":"trace[1123730879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1224; }","duration":"295.52667ms","start":"2026-05-19T15:45:21.71093Z","end":"2026-05-19T15:45:22.006457Z","steps":["trace[1123730879] 'range keys from in-memory index tree' (duration: 295.13671ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:45:22.00691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.907645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-19T15:45:22.00699Z","caller":"traceutil/trace.go:171","msg":"trace[659619410] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1224; }","duration":"277.025879ms","start":"2026-05-19T15:45:21.729946Z","end":"2026-05-19T15:45:22.006972Z","steps":["trace[659619410] 'range keys from in-memory index tree' (duration: 275.831558ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:45:22.172231Z","caller":"traceutil/trace.go:171","msg":"trace[2047086753] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"159.351652ms","start":"2026-05-19T15:45:22.012854Z","end":"2026-05-19T15:45:22.172206Z","steps":["trace[2047086753] 'process raft request' (duration: 159.170296ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:45:22.188444Z","caller":"traceutil/trace.go:171","msg":"trace[948562485] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"175.388778ms","start":"2026-05-19T15:45:22.013034Z","end":"2026-05-19T15:45:22.188423Z","steps":["trace[948562485] 'process raft request' (duration: 175.183922ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:45:22.188447Z","caller":"traceutil/trace.go:171","msg":"trace[1550125965] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"175.254745ms","start":"2026-05-19T15:45:22.013164Z","end":"2026-05-19T15:45:22.188419Z","steps":["trace[1550125965] 'process raft request' (duration: 175.214844ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:45:22.188532Z","caller":"traceutil/trace.go:171","msg":"trace[960064143] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"175.384288ms","start":"2026-05-19T15:45:22.013117Z","end":"2026-05-19T15:45:22.188501Z","steps":["trace[960064143] 'process raft request' (duration: 175.227914ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:45:35.809305Z","caller":"traceutil/trace.go:171","msg":"trace[1507291768] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1362; }","duration":"336.513405ms","start":"2026-05-19T15:45:35.472772Z","end":"2026-05-19T15:45:35.809285Z","steps":["trace[1507291768] 'read index received' (duration: 336.3125ms)","trace[1507291768] 'applied index is now lower than readState.Index' (duration: 199.735µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T15:45:35.809353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:45:35.394937Z","time spent":"414.384228ms","remote":"127.0.0.1:47778","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-19T15:45:35.809493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.708881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-05-19T15:45:35.809519Z","caller":"traceutil/trace.go:171","msg":"trace[1027392270] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1311; }","duration":"336.788333ms","start":"2026-05-19T15:45:35.472723Z","end":"2026-05-19T15:45:35.809511Z","steps":["trace[1027392270] 'agreement among raft nodes before linearized reading' (duration: 336.66491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T15:45:35.809541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T15:45:35.472702Z","time spent":"336.834284ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-05-19T15:45:35.80956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.153437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T15:45:35.809636Z","caller":"traceutil/trace.go:171","msg":"trace[232038860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1311; }","duration":"104.283521ms","start":"2026-05-19T15:45:35.705333Z","end":"2026-05-19T15:45:35.809616Z","steps":["trace[232038860] 'agreement among raft nodes before linearized reading' (duration: 104.079376ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:45:35.920498Z","caller":"traceutil/trace.go:171","msg":"trace[1030853243] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"109.907296ms","start":"2026-05-19T15:45:35.810534Z","end":"2026-05-19T15:45:35.920442Z","steps":["trace[1030853243] 'process raft request' (duration: 67.534385ms)","trace[1030853243] 'compare' (duration: 42.122245ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:45:35.920651Z","caller":"traceutil/trace.go:171","msg":"trace[1847241576] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"106.571219ms","start":"2026-05-19T15:45:35.814056Z","end":"2026-05-19T15:45:35.920627Z","steps":["trace[1847241576] 'process raft request' (duration: 106.348734ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:45:35.922936Z","caller":"traceutil/trace.go:171","msg":"trace[1592026728] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"106.466857ms","start":"2026-05-19T15:45:35.81398Z","end":"2026-05-19T15:45:35.920447Z","steps":["trace[1592026728] 'process raft request' (duration: 106.339523ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T15:46:40.439531Z","caller":"traceutil/trace.go:171","msg":"trace[778407339] transaction","detail":"{read_only:false; response_revision:1610; number_of_response:1; }","duration":"196.056612ms","start":"2026-05-19T15:46:40.243451Z","end":"2026-05-19T15:46:40.439508Z","steps":["trace[778407339] 'process raft request' (duration: 132.775655ms)","trace[778407339] 'compare' (duration: 63.072582ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T15:49:05.950319Z","caller":"traceutil/trace.go:171","msg":"trace[115270724] transaction","detail":"{read_only:false; response_revision:2317; number_of_response:1; }","duration":"135.137747ms","start":"2026-05-19T15:49:05.81515Z","end":"2026-05-19T15:49:05.950288Z","steps":["trace[115270724] 'process raft request' (duration: 134.942992ms)"],"step_count":1}