{"level":"warn","ts":"2026-05-05T09:45:31.364384Z","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-05T09:45:31.364619Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-05T09:45:31.364749Z","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-05T09:45:31.364785Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-05T09:45:31.364805Z","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-05T09:45:31.365741Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-05-05T09:45:31.365823Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-05T09:45:31.37256Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.536351ms"} {"level":"info","ts":"2026-05-05T09:45:31.386821Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-05-05T09:45:31.386907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T09:45:31.386926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-05-05T09:45:31.386943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T09:45:31.38699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-05-05T09:45:31.387051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-05-05T09:45:31.397561Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T09:45:31.400492Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T09:45:31.402553Z","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-05T09:45:31.406157Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T09:45:31.406586Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T09:45:31.40671Z","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-05T09:45:31.40681Z","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-05T09:45:31.406835Z","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-05T09:45:31.410613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-05-05T09:45:31.411058Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-05T09:45:31.415433Z","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-05T09:45:31.415792Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T09:45:31.415939Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T09:45:31.416156Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-05T09:45:31.416211Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-05T09:45:32.087334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T09:45:32.087396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T09:45:32.087437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-05-05T09:45:32.087457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-05-05T09:45:32.08747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-05T09:45:32.087494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-05-05T09:45:32.087509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-05T09:45:32.088856Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T09:45:32.089859Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T09:45:32.089857Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T09:45:32.089893Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T09:45:32.090177Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T09:45:32.090209Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T09:45:32.092124Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T09:45:32.092158Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T09:45:32.092291Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T09:45:32.092344Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T09:45:32.094731Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"warn","ts":"2026-05-05T09:45:40.940498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.921304ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T09:45:40.942781Z","caller":"traceutil/trace.go:171","msg":"trace[1281499416] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:370; }","duration":"179.417254ms","start":"2026-05-05T09:45:40.763264Z","end":"2026-05-05T09:45:40.942681Z","steps":["trace[1281499416] 'read index received' (duration: 35.378205ms)","trace[1281499416] 'applied index is now lower than readState.Index' (duration: 144.034469ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T09:45:40.942972Z","caller":"traceutil/trace.go:171","msg":"trace[1423119254] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"180.211603ms","start":"2026-05-05T09:45:40.762739Z","end":"2026-05-05T09:45:40.94295Z","steps":["trace[1423119254] 'process raft request' (duration: 35.971919ms)","trace[1423119254] 'compare' (duration: 139.72678ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:45:40.94365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.288654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-zzv6g\" ","response":"range_response_count:1 size:3439"} {"level":"info","ts":"2026-05-05T09:45:40.943767Z","caller":"traceutil/trace.go:171","msg":"trace[1102197015] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-zzv6g; range_end:; response_count:1; response_revision:358; }","duration":"180.5198ms","start":"2026-05-05T09:45:40.763212Z","end":"2026-05-05T09:45:40.943732Z","steps":["trace[1102197015] 'agreement among raft nodes before linearized reading' (duration: 180.153931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:45:40.943697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.772081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-05-05T09:45:40.943926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.091204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-05-05T09:45:40.944027Z","caller":"traceutil/trace.go:171","msg":"trace[1444631109] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:358; }","duration":"178.300709ms","start":"2026-05-05T09:45:40.765702Z","end":"2026-05-05T09:45:40.944002Z","steps":["trace[1444631109] 'agreement among raft nodes before linearized reading' (duration: 177.751766ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:45:40.944776Z","caller":"traceutil/trace.go:171","msg":"trace[268895006] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:358; }","duration":"127.973689ms","start":"2026-05-05T09:45:40.816781Z","end":"2026-05-05T09:45:40.944755Z","steps":["trace[268895006] 'agreement among raft nodes before linearized reading' (duration: 126.69638ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:45:41.294618Z","caller":"traceutil/trace.go:171","msg":"trace[2084062602] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"189.917347ms","start":"2026-05-05T09:45:41.104668Z","end":"2026-05-05T09:45:41.294585Z","steps":["trace[2084062602] 'process raft request' (duration: 189.856245ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:45:41.294995Z","caller":"traceutil/trace.go:171","msg":"trace[1121359746] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"190.537251ms","start":"2026-05-05T09:45:41.104412Z","end":"2026-05-05T09:45:41.294949Z","steps":["trace[1121359746] 'process raft request' (duration: 106.71424ms)","trace[1121359746] 'compare' (duration: 83.214987ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T09:45:41.298873Z","caller":"traceutil/trace.go:171","msg":"trace[730092507] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"187.46972ms","start":"2026-05-05T09:45:41.111377Z","end":"2026-05-05T09:45:41.298846Z","steps":["trace[730092507] 'process raft request' (duration: 187.408238ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:45:41.299251Z","caller":"traceutil/trace.go:171","msg":"trace[373330541] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"192.101077ms","start":"2026-05-05T09:45:41.10714Z","end":"2026-05-05T09:45:41.299241Z","steps":["trace[373330541] 'process raft request' (duration: 191.523243ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:45:41.529314Z","caller":"traceutil/trace.go:171","msg":"trace[622299120] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"229.126519ms","start":"2026-05-05T09:45:41.300148Z","end":"2026-05-05T09:45:41.529275Z","steps":["trace[622299120] 'process raft request' (duration: 173.365095ms)","trace[622299120] 'compare' (duration: 55.517419ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T09:45:41.529398Z","caller":"traceutil/trace.go:171","msg":"trace[1296327462] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"225.820203ms","start":"2026-05-05T09:45:41.303565Z","end":"2026-05-05T09:45:41.529385Z","steps":["trace[1296327462] 'process raft request' (duration: 225.604048ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:45:41.529376Z","caller":"traceutil/trace.go:171","msg":"trace[2130610432] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"224.476652ms","start":"2026-05-05T09:45:41.304875Z","end":"2026-05-05T09:45:41.529351Z","steps":["trace[2130610432] 'process raft request' (duration: 224.347259ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:45:41.52931Z","caller":"traceutil/trace.go:171","msg":"trace[1537272510] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"221.559096ms","start":"2026-05-05T09:45:41.30773Z","end":"2026-05-05T09:45:41.529289Z","steps":["trace[1537272510] 'process raft request' (duration: 221.519625ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:00.18799Z","caller":"traceutil/trace.go:171","msg":"trace[2084611132] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"116.365281ms","start":"2026-05-05T09:46:00.0716Z","end":"2026-05-05T09:46:00.187965Z","steps":["trace[2084611132] 'process raft request' (duration: 116.222838ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:00.747403Z","caller":"traceutil/trace.go:171","msg":"trace[811035178] linearizableReadLoop","detail":"{readStateIndex:494; appliedIndex:493; }","duration":"301.663321ms","start":"2026-05-05T09:46:00.445714Z","end":"2026-05-05T09:46:00.747377Z","steps":["trace[811035178] 'read index received' (duration: 248.899195ms)","trace[811035178] 'applied index is now lower than readState.Index' (duration: 52.762616ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:46:00.747586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.22339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12673"} {"level":"info","ts":"2026-05-05T09:46:00.747623Z","caller":"traceutil/trace.go:171","msg":"trace[924700312] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:475; }","duration":"271.311362ms","start":"2026-05-05T09:46:00.476299Z","end":"2026-05-05T09:46:00.747611Z","steps":["trace[924700312] 'agreement among raft nodes before linearized reading' (duration: 271.203739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:00.747629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.890716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:46:00.747767Z","caller":"traceutil/trace.go:171","msg":"trace[1864393265] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:475; }","duration":"302.067601ms","start":"2026-05-05T09:46:00.445668Z","end":"2026-05-05T09:46:00.747735Z","steps":["trace[1864393265] 'agreement among raft nodes before linearized reading' (duration: 301.819645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:00.747832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:00.445647Z","time spent":"302.173274ms","remote":"127.0.0.1:52432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T09:46:01.729953Z","caller":"traceutil/trace.go:171","msg":"trace[344696603] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"110.754922ms","start":"2026-05-05T09:46:01.619172Z","end":"2026-05-05T09:46:01.729927Z","steps":["trace[344696603] 'process raft request' (duration: 110.391634ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:01.938272Z","caller":"traceutil/trace.go:171","msg":"trace[1350167896] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"115.389809ms","start":"2026-05-05T09:46:01.822633Z","end":"2026-05-05T09:46:01.938023Z","steps":["trace[1350167896] 'process raft request' (duration: 96.347421ms)","trace[1350167896] 'compare' (duration: 18.802243ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:46:04.691897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.814414ms","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-05T09:46:04.692016Z","caller":"traceutil/trace.go:171","msg":"trace[501922108] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:516; }","duration":"719.021058ms","start":"2026-05-05T09:46:03.97297Z","end":"2026-05-05T09:46:04.691991Z","steps":["trace[501922108] 'range keys from in-memory index tree' (duration: 718.700571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.692132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:03.97295Z","time spent":"719.168162ms","remote":"127.0.0.1:52718","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-05T09:46:04.704152Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225958195986279,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T09:46:04.765551Z","caller":"traceutil/trace.go:171","msg":"trace[252963345] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"627.335306ms","start":"2026-05-05T09:46:04.138184Z","end":"2026-05-05T09:46:04.76552Z","steps":["trace[252963345] 'process raft request' (duration: 626.961827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.765725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.138159Z","time spent":"627.47949ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T09:46:04.780557Z","caller":"traceutil/trace.go:171","msg":"trace[1104122804] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"635.945985ms","start":"2026-05-05T09:46:04.14458Z","end":"2026-05-05T09:46:04.780526Z","steps":["trace[1104122804] 'process raft request' (duration: 635.654568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.780713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.14456Z","time spent":"636.083107ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T09:46:04.780747Z","caller":"traceutil/trace.go:171","msg":"trace[1647375648] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"612.474263ms","start":"2026-05-05T09:46:04.168246Z","end":"2026-05-05T09:46:04.780721Z","steps":["trace[1647375648] 'process raft request' (duration: 612.188276ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:04.780835Z","caller":"traceutil/trace.go:171","msg":"trace[526258928] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"612.412752ms","start":"2026-05-05T09:46:04.168414Z","end":"2026-05-05T09:46:04.780826Z","steps":["trace[526258928] 'process raft request' (duration: 612.071845ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.780869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.168409Z","time spent":"612.443113ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T09:46:04.780871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.168227Z","time spent":"612.579516ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T09:46:04.781105Z","caller":"traceutil/trace.go:171","msg":"trace[805728641] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"607.176681ms","start":"2026-05-05T09:46:04.173898Z","end":"2026-05-05T09:46:04.781075Z","steps":["trace[805728641] 'process raft request' (duration: 606.838133ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:04.78104Z","caller":"traceutil/trace.go:171","msg":"trace[1357544878] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"608.355309ms","start":"2026-05-05T09:46:04.17266Z","end":"2026-05-05T09:46:04.781015Z","steps":["trace[1357544878] 'process raft request' (duration: 607.903838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.781284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.172654Z","time spent":"608.559383ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T09:46:04.781289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.173889Z","time spent":"607.320444ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T09:46:04.781269Z","caller":"traceutil/trace.go:171","msg":"trace[1754746974] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"606.308961ms","start":"2026-05-05T09:46:04.174951Z","end":"2026-05-05T09:46:04.78126Z","steps":["trace[1754746974] 'process raft request' (duration: 606.037625ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.78136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.174913Z","time spent":"606.426544ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T09:46:04.781582Z","caller":"traceutil/trace.go:171","msg":"trace[315796669] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"604.04487ms","start":"2026-05-05T09:46:04.177525Z","end":"2026-05-05T09:46:04.78157Z","steps":["trace[315796669] 'process raft request' (duration: 603.577059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.781656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.177498Z","time spent":"604.117861ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T09:46:04.78181Z","caller":"traceutil/trace.go:171","msg":"trace[1703068505] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"603.716392ms","start":"2026-05-05T09:46:04.178078Z","end":"2026-05-05T09:46:04.781794Z","steps":["trace[1703068505] 'process raft request' (duration: 603.442485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.781876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.178065Z","time spent":"603.790093ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T09:46:04.782027Z","caller":"traceutil/trace.go:171","msg":"trace[1890353777] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"593.905825ms","start":"2026-05-05T09:46:04.188089Z","end":"2026-05-05T09:46:04.781995Z","steps":["trace[1890353777] 'process raft request' (duration: 593.698011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.78211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.188048Z","time spent":"594.027848ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T09:46:04.782423Z","caller":"traceutil/trace.go:171","msg":"trace[1646208012] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"579.589886ms","start":"2026-05-05T09:46:04.202805Z","end":"2026-05-05T09:46:04.782395Z","steps":["trace[1646208012] 'process raft request' (duration: 579.145825ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.782528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.202745Z","time spent":"579.730958ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T09:46:04.78285Z","caller":"traceutil/trace.go:171","msg":"trace[921066847] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:535; }","duration":"579.643156ms","start":"2026-05-05T09:46:04.203178Z","end":"2026-05-05T09:46:04.782821Z","steps":["trace[921066847] 'read index received' (duration: 562.060461ms)","trace[921066847] 'applied index is now lower than readState.Index' (duration: 17.581575ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T09:46:04.783014Z","caller":"traceutil/trace.go:171","msg":"trace[1526238895] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"311.388615ms","start":"2026-05-05T09:46:04.471608Z","end":"2026-05-05T09:46:04.782997Z","steps":["trace[1526238895] 'process raft request' (duration: 311.080938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.783068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.878362ms","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-05T09:46:04.783052Z","caller":"traceutil/trace.go:171","msg":"trace[1351352304] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"476.499019ms","start":"2026-05-05T09:46:04.306542Z","end":"2026-05-05T09:46:04.783041Z","steps":["trace[1351352304] 'process raft request' (duration: 476.008208ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:04.783161Z","caller":"traceutil/trace.go:171","msg":"trace[212650282] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:530; }","duration":"580.028046ms","start":"2026-05-05T09:46:04.20312Z","end":"2026-05-05T09:46:04.783148Z","steps":["trace[212650282] 'agreement among raft nodes before linearized reading' (duration: 579.818361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:04.783273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.203104Z","time spent":"580.127218ms","remote":"127.0.0.1:52718","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-05T09:46:04.783283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.306502Z","time spent":"476.704514ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T09:46:04.783315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:04.471576Z","time spent":"311.488098ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T09:46:05.579801Z","caller":"traceutil/trace.go:171","msg":"trace[896381470] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"501.63961ms","start":"2026-05-05T09:46:05.078114Z","end":"2026-05-05T09:46:05.579754Z","steps":["trace[896381470] 'process raft request' (duration: 497.422252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:05.580471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:05.07809Z","time spent":"502.278065ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T09:46:05.585068Z","caller":"traceutil/trace.go:171","msg":"trace[888979407] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"466.695615ms","start":"2026-05-05T09:46:05.118351Z","end":"2026-05-05T09:46:05.585047Z","steps":["trace[888979407] 'process raft request' (duration: 466.595592ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:05.585053Z","caller":"traceutil/trace.go:171","msg":"trace[1642113729] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:581; }","duration":"215.570207ms","start":"2026-05-05T09:46:05.369448Z","end":"2026-05-05T09:46:05.585018Z","steps":["trace[1642113729] 'read index received' (duration: 206.057438ms)","trace[1642113729] 'applied index is now lower than readState.Index' (duration: 9.511589ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:46:05.585137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:05.118325Z","time spent":"466.781676ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T09:46:05.585276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.797399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T09:46:05.585305Z","caller":"traceutil/trace.go:171","msg":"trace[499906953] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:562; }","duration":"184.86644ms","start":"2026-05-05T09:46:05.400432Z","end":"2026-05-05T09:46:05.585299Z","steps":["trace[499906953] 'agreement among raft nodes before linearized reading' (duration: 184.776368ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:05.585073Z","caller":"traceutil/trace.go:171","msg":"trace[1122839503] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"505.877097ms","start":"2026-05-05T09:46:05.079149Z","end":"2026-05-05T09:46:05.585027Z","steps":["trace[1122839503] 'process raft request' (duration: 505.433027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:05.58539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.802641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T09:46:05.585397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:05.07912Z","time spent":"506.215225ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T09:46:05.585405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.929576ms","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-05T09:46:05.585438Z","caller":"traceutil/trace.go:171","msg":"trace[377265574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:562; }","duration":"139.906253ms","start":"2026-05-05T09:46:05.445518Z","end":"2026-05-05T09:46:05.585424Z","steps":["trace[377265574] 'agreement among raft nodes before linearized reading' (duration: 139.816731ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:05.585451Z","caller":"traceutil/trace.go:171","msg":"trace[1772576455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:562; }","duration":"216.045088ms","start":"2026-05-05T09:46:05.36939Z","end":"2026-05-05T09:46:05.585435Z","steps":["trace[1772576455] 'agreement among raft nodes before linearized reading' (duration: 215.803283ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:11.42199Z","caller":"traceutil/trace.go:171","msg":"trace[1857771510] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"177.117461ms","start":"2026-05-05T09:46:11.244833Z","end":"2026-05-05T09:46:11.42195Z","steps":["trace[1857771510] 'process raft request' (duration: 175.955284ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:11.685483Z","caller":"traceutil/trace.go:171","msg":"trace[58329155] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"240.541483ms","start":"2026-05-05T09:46:11.444907Z","end":"2026-05-05T09:46:11.685448Z","steps":["trace[58329155] 'read index received' (duration: 240.350169ms)","trace[58329155] 'applied index is now lower than readState.Index' (duration: 189.834µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:46:11.685676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.718437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:46:11.685785Z","caller":"traceutil/trace.go:171","msg":"trace[700508973] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:625; }","duration":"240.87047ms","start":"2026-05-05T09:46:11.44489Z","end":"2026-05-05T09:46:11.685761Z","steps":["trace[700508973] 'agreement among raft nodes before linearized reading' (duration: 240.632365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:11.685856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.902921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:46:11.685961Z","caller":"traceutil/trace.go:171","msg":"trace[1293651023] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:625; }","duration":"241.061225ms","start":"2026-05-05T09:46:11.444878Z","end":"2026-05-05T09:46:11.685939Z","steps":["trace[1293651023] 'agreement among raft nodes before linearized reading' (duration: 240.84739ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:11.686221Z","caller":"traceutil/trace.go:171","msg":"trace[1574475421] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"248.411505ms","start":"2026-05-05T09:46:11.437771Z","end":"2026-05-05T09:46:11.686182Z","steps":["trace[1574475421] 'process raft request' (duration: 247.428052ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:12.186078Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225958195986506,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T09:46:12.365537Z","caller":"traceutil/trace.go:171","msg":"trace[1413830682] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"679.908636ms","start":"2026-05-05T09:46:11.685578Z","end":"2026-05-05T09:46:12.365487Z","steps":["trace[1413830682] 'read index received' (duration: 619.370031ms)","trace[1413830682] 'applied index is now lower than readState.Index' (duration: 60.537445ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:46:12.365952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.767931ms","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-05T09:46:12.365994Z","caller":"traceutil/trace.go:171","msg":"trace[937462684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:626; }","duration":"744.898064ms","start":"2026-05-05T09:46:11.621082Z","end":"2026-05-05T09:46:12.36598Z","steps":["trace[937462684] 'agreement among raft nodes before linearized reading' (duration: 744.655068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:12.366038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.621029Z","time spent":"745.001256ms","remote":"127.0.0.1:52718","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-05T09:46:12.366015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.425631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T09:46:12.366069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.530413ms","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":"warn","ts":"2026-05-05T09:46:12.366231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.31374ms","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-05T09:46:12.366238Z","caller":"traceutil/trace.go:171","msg":"trace[1939585210] 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:626; }","duration":"832.723188ms","start":"2026-05-05T09:46:11.533479Z","end":"2026-05-05T09:46:12.366202Z","steps":["trace[1939585210] 'agreement among raft nodes before linearized reading' (duration: 832.445461ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:12.366246Z","caller":"traceutil/trace.go:171","msg":"trace[2097923935] 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:626; }","duration":"832.714047ms","start":"2026-05-05T09:46:11.533476Z","end":"2026-05-05T09:46:12.36619Z","steps":["trace[2097923935] 'agreement among raft nodes before linearized reading' (duration: 832.352879ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:12.3663Z","caller":"traceutil/trace.go:171","msg":"trace[693907028] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"895.435282ms","start":"2026-05-05T09:46:11.470844Z","end":"2026-05-05T09:46:12.366279Z","steps":["trace[693907028] 'agreement among raft nodes before linearized reading' (duration: 895.33943ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:12.366342Z","caller":"traceutil/trace.go:171","msg":"trace[1653347525] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"880.798386ms","start":"2026-05-05T09:46:11.48553Z","end":"2026-05-05T09:46:12.366329Z","steps":["trace[1653347525] 'process raft request' (duration: 819.499213ms)","trace[1653347525] 'compare' (duration: 60.252809ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:46:12.366347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.533462Z","time spent":"832.864801ms","remote":"127.0.0.1:40130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T09:46:12.366208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.319072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T09:46:12.366452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.728384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T09:46:12.36607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"831.330415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:46:12.366508Z","caller":"traceutil/trace.go:171","msg":"trace[553919668] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"854.839437ms","start":"2026-05-05T09:46:11.511653Z","end":"2026-05-05T09:46:12.366493Z","steps":["trace[553919668] 'agreement among raft nodes before linearized reading' (duration: 854.724655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:12.366555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.73787ms","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":"warn","ts":"2026-05-05T09:46:12.366555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.511642Z","time spent":"854.900989ms","remote":"127.0.0.1:40114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-05-05T09:46:12.36659Z","caller":"traceutil/trace.go:171","msg":"trace[1127991858] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"895.77556ms","start":"2026-05-05T09:46:11.470804Z","end":"2026-05-05T09:46:12.36658Z","steps":["trace[1127991858] 'agreement among raft nodes before linearized reading' (duration: 895.732459ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:12.366579Z","caller":"traceutil/trace.go:171","msg":"trace[1853684801] 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:626; }","duration":"831.834417ms","start":"2026-05-05T09:46:11.534669Z","end":"2026-05-05T09:46:12.366503Z","steps":["trace[1853684801] 'agreement among raft nodes before linearized reading' (duration: 831.201332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:12.366644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.640497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:46:12.366668Z","caller":"traceutil/trace.go:171","msg":"trace[1349797896] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"921.676307ms","start":"2026-05-05T09:46:11.444986Z","end":"2026-05-05T09:46:12.366662Z","steps":["trace[1349797896] 'agreement among raft nodes before linearized reading' (duration: 921.639816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:12.36669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.444978Z","time spent":"921.707298ms","remote":"127.0.0.1:40082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T09:46:12.366347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.470814Z","time spent":"895.518685ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T09:46:12.366869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.834122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:46:12.366928Z","caller":"traceutil/trace.go:171","msg":"trace[1761099576] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"875.904653ms","start":"2026-05-05T09:46:11.491009Z","end":"2026-05-05T09:46:12.366914Z","steps":["trace[1761099576] 'agreement among raft nodes before linearized reading' (duration: 875.813451ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:12.366936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.596315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-05T09:46:12.367001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.074267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:46:12.367028Z","caller":"traceutil/trace.go:171","msg":"trace[251071328] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"876.114188ms","start":"2026-05-05T09:46:11.490907Z","end":"2026-05-05T09:46:12.367021Z","steps":["trace[251071328] 'agreement among raft nodes before linearized reading' (duration: 876.069797ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:46:12.367033Z","caller":"traceutil/trace.go:171","msg":"trace[69989289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"405.731758ms","start":"2026-05-05T09:46:11.961286Z","end":"2026-05-05T09:46:12.367018Z","steps":["trace[69989289] 'agreement among raft nodes before linearized reading' (duration: 405.441102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:12.367052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.490898Z","time spent":"876.146108ms","remote":"127.0.0.1:40098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-05T09:46:12.36638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.53346Z","time spent":"832.881011ms","remote":"127.0.0.1:40130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T09:46:12.367101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.961265Z","time spent":"405.82516ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T09:46:12.367112Z","caller":"traceutil/trace.go:171","msg":"trace[2087624680] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"854.290585ms","start":"2026-05-05T09:46:11.512777Z","end":"2026-05-05T09:46:12.367067Z","steps":["trace[2087624680] 'agreement among raft nodes before linearized reading' (duration: 852.77107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:12.366521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.706895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T09:46:12.366614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.470797Z","time spent":"895.810821ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-05-05T09:46:12.367245Z","caller":"traceutil/trace.go:171","msg":"trace[378330073] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"855.447921ms","start":"2026-05-05T09:46:11.511778Z","end":"2026-05-05T09:46:12.367226Z","steps":["trace[378330073] 'agreement among raft nodes before linearized reading' (duration: 853.902576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:12.36726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.51275Z","time spent":"854.461819ms","remote":"127.0.0.1:40098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-05-05T09:46:12.367214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.888443ms","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-05T09:46:12.367371Z","caller":"traceutil/trace.go:171","msg":"trace[1001044640] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"896.074977ms","start":"2026-05-05T09:46:11.47124Z","end":"2026-05-05T09:46:12.367315Z","steps":["trace[1001044640] 'agreement among raft nodes before linearized reading' (duration: 895.735219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:12.366451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.485504Z","time spent":"880.867007ms","remote":"127.0.0.1:52792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T09:46:12.367443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.471233Z","time spent":"896.19808ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-05-05T09:46:12.366981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.491001Z","time spent":"875.965654ms","remote":"127.0.0.1:40098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T09:46:12.366656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.534637Z","time spent":"832.003721ms","remote":"127.0.0.1:40130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-05-05T09:46:12.36732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:11.511762Z","time spent":"855.537003ms","remote":"127.0.0.1:40114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-05T09:46:13.202537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.489819ms","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-05T09:46:13.202606Z","caller":"traceutil/trace.go:171","msg":"trace[1750083995] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:628; }","duration":"364.599362ms","start":"2026-05-05T09:46:12.837986Z","end":"2026-05-05T09:46:13.202585Z","steps":["trace[1750083995] 'range keys from in-memory index tree' (duration: 364.210963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:13.202647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:12.837963Z","time spent":"364.677013ms","remote":"127.0.0.1:52718","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-05T09:46:13.396222Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225958195986514,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T09:46:13.62654Z","caller":"traceutil/trace.go:171","msg":"trace[394542173] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"767.794262ms","start":"2026-05-05T09:46:12.85871Z","end":"2026-05-05T09:46:13.626505Z","steps":["trace[394542173] 'process raft request' (duration: 767.067776ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:13.626763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:12.858665Z","time spent":"767.982307ms","remote":"127.0.0.1:52532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T09:46:13.628723Z","caller":"traceutil/trace.go:171","msg":"trace[1251619494] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"732.95756ms","start":"2026-05-05T09:46:12.895721Z","end":"2026-05-05T09:46:13.628679Z","steps":["trace[1251619494] 'read index received' (duration: 729.815747ms)","trace[1251619494] 'applied index is now lower than readState.Index' (duration: 3.140292ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T09:46:13.628787Z","caller":"traceutil/trace.go:171","msg":"trace[1378666025] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"419.719402ms","start":"2026-05-05T09:46:13.209055Z","end":"2026-05-05T09:46:13.628774Z","steps":["trace[1378666025] 'process raft request' (duration: 419.423335ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:13.62892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.194805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-05T09:46:13.628951Z","caller":"traceutil/trace.go:171","msg":"trace[1527963818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"733.258687ms","start":"2026-05-05T09:46:12.895686Z","end":"2026-05-05T09:46:13.628944Z","steps":["trace[1527963818] 'agreement among raft nodes before linearized reading' (duration: 733.130484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:46:13.628975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:12.895664Z","time spent":"733.305717ms","remote":"127.0.0.1:52718","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-05T09:46:13.629033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:46:13.209037Z","time spent":"419.854194ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T09:46:13.629028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.044369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:46:13.62926Z","caller":"traceutil/trace.go:171","msg":"trace[1156455430] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"180.341635ms","start":"2026-05-05T09:46:13.448898Z","end":"2026-05-05T09:46:13.62924Z","steps":["trace[1156455430] 'agreement among raft nodes before linearized reading' (duration: 180.046999ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:47:00.872058Z","caller":"traceutil/trace.go:171","msg":"trace[1254012702] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"101.727087ms","start":"2026-05-05T09:47:00.770284Z","end":"2026-05-05T09:47:00.872011Z","steps":["trace[1254012702] 'process raft request' (duration: 101.312268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:47:06.464042Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225958195987309,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T09:47:06.737811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.594336ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T09:47:06.737949Z","caller":"traceutil/trace.go:171","msg":"trace[1209522911] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"799.43115ms","start":"2026-05-05T09:47:05.938491Z","end":"2026-05-05T09:47:06.737922Z","steps":["trace[1209522911] 'process raft request' (duration: 570.617579ms)","trace[1209522911] 'compare' (duration: 228.232418ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:47:06.738242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:47:05.938479Z","time spent":"799.712946ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T09:47:06.747629Z","caller":"traceutil/trace.go:171","msg":"trace[392211051] linearizableReadLoop","detail":"{readStateIndex:1055; appliedIndex:1053; }","duration":"784.164118ms","start":"2026-05-05T09:47:05.963455Z","end":"2026-05-05T09:47:06.747619Z","steps":["trace[392211051] 'read index received' (duration: 545.666464ms)","trace[392211051] 'applied index is now lower than readState.Index' (duration: 238.497034ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T09:47:06.747807Z","caller":"traceutil/trace.go:171","msg":"trace[871580430] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"363.300395ms","start":"2026-05-05T09:47:06.384499Z","end":"2026-05-05T09:47:06.747799Z","steps":["trace[871580430] 'process raft request' (duration: 363.067889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:47:06.747872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:47:06.384474Z","time spent":"363.359076ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T09:47:06.748082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.632378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-05T09:47:06.748109Z","caller":"traceutil/trace.go:171","msg":"trace[1923933149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1016; }","duration":"784.68929ms","start":"2026-05-05T09:47:05.963411Z","end":"2026-05-05T09:47:06.7481Z","steps":["trace[1923933149] 'agreement among raft nodes before linearized reading' (duration: 784.588297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:47:06.748138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:47:05.963385Z","time spent":"784.746451ms","remote":"127.0.0.1:52718","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-05T09:47:06.748174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.305607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:47:06.748253Z","caller":"traceutil/trace.go:171","msg":"trace[1552170585] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1016; }","duration":"302.386989ms","start":"2026-05-05T09:47:06.445839Z","end":"2026-05-05T09:47:06.748226Z","steps":["trace[1552170585] 'agreement among raft nodes before linearized reading' (duration: 302.264746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:47:06.748286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:47:06.445801Z","time spent":"302.479161ms","remote":"127.0.0.1:52432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T09:47:07.221442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.075179ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T09:47:07.221553Z","caller":"traceutil/trace.go:171","msg":"trace[1126921943] linearizableReadLoop","detail":"{readStateIndex:1056; appliedIndex:1055; }","duration":"327.18153ms","start":"2026-05-05T09:47:06.894354Z","end":"2026-05-05T09:47:07.221535Z","steps":["trace[1126921943] 'read index received' (duration: 184.906867ms)","trace[1126921943] 'applied index is now lower than readState.Index' (duration: 142.273203ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T09:47:07.221643Z","caller":"traceutil/trace.go:171","msg":"trace[420598146] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"469.218098ms","start":"2026-05-05T09:47:06.752413Z","end":"2026-05-05T09:47:07.221631Z","steps":["trace[420598146] 'process raft request' (duration: 326.859093ms)","trace[420598146] 'compare' (duration: 141.879444ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:47:07.221699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:47:06.752388Z","time spent":"469.28012ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T09:47:07.221803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.447377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-05T09:47:07.221805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.637009ms","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-05T09:47:07.221882Z","caller":"traceutil/trace.go:171","msg":"trace[960736905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1017; }","duration":"327.548309ms","start":"2026-05-05T09:47:06.894304Z","end":"2026-05-05T09:47:07.221852Z","steps":["trace[960736905] 'agreement among raft nodes before linearized reading' (duration: 327.414696ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:47:07.221874Z","caller":"traceutil/trace.go:171","msg":"trace[1835598630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1017; }","duration":"258.741582ms","start":"2026-05-05T09:47:06.963117Z","end":"2026-05-05T09:47:07.221859Z","steps":["trace[1835598630] 'agreement among raft nodes before linearized reading' (duration: 258.542037ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:47:07.221912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:47:06.894283Z","time spent":"327.620811ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T09:47:33.047507Z","caller":"traceutil/trace.go:171","msg":"trace[1677647332] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"175.202963ms","start":"2026-05-05T09:47:32.872267Z","end":"2026-05-05T09:47:33.04747Z","steps":["trace[1677647332] 'process raft request' (duration: 175.036319ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:47:33.734346Z","caller":"traceutil/trace.go:171","msg":"trace[266280667] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"132.430698ms","start":"2026-05-05T09:47:33.601662Z","end":"2026-05-05T09:47:33.734093Z","steps":["trace[266280667] 'process raft request' (duration: 132.253024ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:47:35.211512Z","caller":"traceutil/trace.go:171","msg":"trace[1740530378] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"156.442739ms","start":"2026-05-05T09:47:35.055051Z","end":"2026-05-05T09:47:35.211493Z","steps":["trace[1740530378] 'process raft request' (duration: 156.333907ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:47:48.098642Z","caller":"traceutil/trace.go:171","msg":"trace[1382567578] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"301.628877ms","start":"2026-05-05T09:47:47.796994Z","end":"2026-05-05T09:47:48.098622Z","steps":["trace[1382567578] 'process raft request' (duration: 301.496724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:47:48.098776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:47:47.796978Z","time spent":"301.733559ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T09:47:48.135103Z","caller":"traceutil/trace.go:171","msg":"trace[802509300] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"154.458763ms","start":"2026-05-05T09:47:47.980547Z","end":"2026-05-05T09:47:48.135005Z","steps":["trace[802509300] 'process raft request' (duration: 154.134536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:48:05.104097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.726595ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T09:48:05.104237Z","caller":"traceutil/trace.go:171","msg":"trace[792486653] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1327; }","duration":"817.567738ms","start":"2026-05-05T09:48:04.286648Z","end":"2026-05-05T09:48:05.104216Z","steps":["trace[792486653] 'read index received' (duration: 95.176987ms)","trace[792486653] 'applied index is now lower than readState.Index' (duration: 722.38886ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:48:05.104388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.745301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:48:05.104424Z","caller":"traceutil/trace.go:171","msg":"trace[1905420589] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1276; }","duration":"817.841863ms","start":"2026-05-05T09:48:04.28657Z","end":"2026-05-05T09:48:05.104412Z","steps":["trace[1905420589] 'agreement among raft nodes before linearized reading' (duration: 817.757871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:48:05.104464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:04.286541Z","time spent":"817.912775ms","remote":"127.0.0.1:39912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T09:48:05.104724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.884547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T09:48:05.104796Z","caller":"traceutil/trace.go:171","msg":"trace[1682016872] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1276; }","duration":"730.0296ms","start":"2026-05-05T09:48:04.37475Z","end":"2026-05-05T09:48:05.10478Z","steps":["trace[1682016872] 'agreement among raft nodes before linearized reading' (duration: 729.881206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:48:05.104776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.784466ms","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":"warn","ts":"2026-05-05T09:48:05.104832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:04.374725Z","time spent":"730.099251ms","remote":"127.0.0.1:52542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-05-05T09:48:05.10488Z","caller":"traceutil/trace.go:171","msg":"trace[1202053313] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1276; }","duration":"388.916959ms","start":"2026-05-05T09:48:04.715925Z","end":"2026-05-05T09:48:05.104842Z","steps":["trace[1202053313] 'agreement among raft nodes before linearized reading' (duration: 388.735025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:48:05.104938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:04.715911Z","time spent":"389.012571ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"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-05T09:48:05.104987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.423622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T09:48:05.105024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.015124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:48:05.10503Z","caller":"traceutil/trace.go:171","msg":"trace[683569237] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1276; }","duration":"410.495453ms","start":"2026-05-05T09:48:04.694522Z","end":"2026-05-05T09:48:05.105018Z","steps":["trace[683569237] 'agreement among raft nodes before linearized reading' (duration: 410.420682ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:48:05.105048Z","caller":"traceutil/trace.go:171","msg":"trace[244168260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"658.042355ms","start":"2026-05-05T09:48:04.446998Z","end":"2026-05-05T09:48:05.105041Z","steps":["trace[244168260] 'agreement among raft nodes before linearized reading' (duration: 658.000094ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:48:05.105067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:04.446925Z","time spent":"658.138317ms","remote":"127.0.0.1:52432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T09:48:05.105066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:04.694506Z","time spent":"410.551935ms","remote":"127.0.0.1:40046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-05-05T09:48:05.104257Z","caller":"traceutil/trace.go:171","msg":"trace[69203181] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"872.666177ms","start":"2026-05-05T09:48:04.231552Z","end":"2026-05-05T09:48:05.104218Z","steps":["trace[69203181] 'process raft request' (duration: 150.295097ms)","trace[69203181] 'compare' (duration: 721.53033ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:48:05.105804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:04.231532Z","time spent":"874.149791ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T09:48:06.948835Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225958195987952,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T09:48:07.152651Z","caller":"traceutil/trace.go:171","msg":"trace[663434604] linearizableReadLoop","detail":"{readStateIndex:1336; appliedIndex:1335; }","duration":"704.084861ms","start":"2026-05-05T09:48:06.448546Z","end":"2026-05-05T09:48:07.152631Z","steps":["trace[663434604] 'read index received' (duration: 703.904857ms)","trace[663434604] 'applied index is now lower than readState.Index' (duration: 179.294µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T09:48:07.153028Z","caller":"traceutil/trace.go:171","msg":"trace[1797136117] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"878.633715ms","start":"2026-05-05T09:48:06.274347Z","end":"2026-05-05T09:48:07.152981Z","steps":["trace[1797136117] 'process raft request' (duration: 878.165344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:48:07.153103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.514971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T09:48:07.153228Z","caller":"traceutil/trace.go:171","msg":"trace[1542887318] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1283; }","duration":"704.684775ms","start":"2026-05-05T09:48:06.448502Z","end":"2026-05-05T09:48:07.153187Z","steps":["trace[1542887318] 'agreement among raft nodes before linearized reading' (duration: 704.45751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T09:48:07.153236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:06.274329Z","time spent":"878.805448ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T09:48:07.153296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:06.448485Z","time spent":"704.800698ms","remote":"127.0.0.1:52432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T09:48:20.084393Z","caller":"traceutil/trace.go:171","msg":"trace[70560487] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"284.288812ms","start":"2026-05-05T09:48:19.79978Z","end":"2026-05-05T09:48:20.084069Z","steps":["trace[70560487] 'process raft request' (duration: 284.100207ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:48:20.215646Z","caller":"traceutil/trace.go:171","msg":"trace[639943157] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"412.537911ms","start":"2026-05-05T09:48:19.803079Z","end":"2026-05-05T09:48:20.215617Z","steps":["trace[639943157] 'process raft request' (duration: 412.474899ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:48:20.215713Z","caller":"traceutil/trace.go:171","msg":"trace[1259506051] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"415.108591ms","start":"2026-05-05T09:48:19.800555Z","end":"2026-05-05T09:48:20.215663Z","steps":["trace[1259506051] 'process raft request' (duration: 371.90838ms)","trace[1259506051] 'compare' (duration: 42.936205ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T09:48:20.216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:19.800534Z","time spent":"415.282396ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T09:48:20.216232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:19.803069Z","time spent":"412.663844ms","remote":"127.0.0.1:52718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T09:50:23.969459Z","caller":"traceutil/trace.go:171","msg":"trace[535742808] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"170.224346ms","start":"2026-05-05T09:50:23.799205Z","end":"2026-05-05T09:50:23.969429Z","steps":["trace[535742808] 'process raft request' (duration: 170.025531ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T09:50:33.097046Z","caller":"traceutil/trace.go:171","msg":"trace[53366216] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"159.096331ms","start":"2026-05-05T09:50:32.93792Z","end":"2026-05-05T09:50:33.097016Z","steps":["trace[53366216] 'process raft request' (duration: 155.839343ms)"],"step_count":1}