{"level":"warn","ts":"2026-07-01T07:22:30.490912Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T07:22:30.49103Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-07-01T07:22:30.491121Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T07:22:30.491136Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-07-01T07:22:30.491163Z","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-07-01T07:22:30.492028Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-07-01T07:22:30.49214Z","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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-07-01T07:22:30.496906Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.471556ms"} {"level":"info","ts":"2026-07-01T07:22:30.505017Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-07-01T07:22:30.505102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-07-01T07:22:30.505122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-07-01T07:22:30.50514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-01T07:22:30.505153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-07-01T07:22:30.505193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-07-01T07:22:30.511013Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-01T07:22:30.512764Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-01T07:22:30.514477Z","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-07-01T07:22:30.518359Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-01T07:22:30.519952Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-01T07:22:30.520856Z","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-07-01T07:22:30.521002Z","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-07-01T07:22:30.521115Z","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-07-01T07:22:30.522039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-07-01T07:22:30.522258Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-07-01T07:22:30.529119Z","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-07-01T07:22:30.529259Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-01T07:22:30.529304Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-01T07:22:30.53007Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-01T07:22:30.530099Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-01T07:22:31.305457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-07-01T07:22:31.305544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-01T07:22:31.305568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-07-01T07:22:31.305589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-07-01T07:22:31.305601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-07-01T07:22:31.305617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-07-01T07:22:31.30563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-07-01T07:22:31.448487Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-07-01T07:22:31.448542Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T07:22:31.448649Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T07:22:31.448805Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:22:31.44916Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-01T07:22:31.449198Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-01T07:22:31.451754Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-01T07:22:31.45244Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-07-01T07:22:31.642008Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:22:31.642172Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:22:31.642226Z","caller":"traceutil/trace.go:171","msg":"trace[2060388538] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"148.150689ms","start":"2026-07-01T07:22:31.494059Z","end":"2026-07-01T07:22:31.64221Z","steps":["trace[2060388538] 'read index received' (duration: 147.872274ms)","trace[2060388538] 'applied index is now lower than readState.Index' (duration: 277.085µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:22:31.642234Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-07-01T07:22:31.642536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.422264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T07:22:31.642603Z","caller":"traceutil/trace.go:171","msg":"trace[1206053331] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"148.535166ms","start":"2026-07-01T07:22:31.494054Z","end":"2026-07-01T07:22:31.642589Z","steps":["trace[1206053331] 'agreement among raft nodes before linearized reading' (duration: 148.271961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:22:31.643311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.112308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T07:22:31.643376Z","caller":"traceutil/trace.go:171","msg":"trace[1877444353] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"149.173699ms","start":"2026-07-01T07:22:31.494178Z","end":"2026-07-01T07:22:31.643352Z","steps":["trace[1877444353] 'agreement among raft nodes before linearized reading' (duration: 148.20804ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:22:31.643652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.678335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T07:22:31.643741Z","caller":"traceutil/trace.go:171","msg":"trace[1084132524] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"108.813727ms","start":"2026-07-01T07:22:31.534902Z","end":"2026-07-01T07:22:31.643716Z","steps":["trace[1084132524] 'agreement among raft nodes before linearized reading' (duration: 108.639194ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:22:39.237361Z","caller":"traceutil/trace.go:171","msg":"trace[462747888] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"139.766717ms","start":"2026-07-01T07:22:39.097538Z","end":"2026-07-01T07:22:39.237305Z","steps":["trace[462747888] 'process raft request' (duration: 74.874089ms)","trace[462747888] 'compare' (duration: 64.612142ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:23:07.465713Z","caller":"traceutil/trace.go:171","msg":"trace[567624412] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"175.50531ms","start":"2026-07-01T07:23:07.290188Z","end":"2026-07-01T07:23:07.465693Z","steps":["trace[567624412] 'process raft request' (duration: 175.354927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:08.084366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.868025ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:23:08.08455Z","caller":"traceutil/trace.go:171","msg":"trace[2092396617] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"597.533817ms","start":"2026-07-01T07:23:07.48699Z","end":"2026-07-01T07:23:08.084524Z","steps":["trace[2092396617] 'process raft request' (duration: 178.924647ms)","trace[2092396617] 'compare' (duration: 417.721563ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:23:08.08464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.486971Z","time spent":"597.630999ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:23:08.215124Z","caller":"traceutil/trace.go:171","msg":"trace[293551183] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"727.902433ms","start":"2026-07-01T07:23:07.4872Z","end":"2026-07-01T07:23:08.215103Z","steps":["trace[293551183] 'process raft request' (duration: 727.701759ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:08.215422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.48718Z","time spent":"728.012864ms","remote":"127.0.0.1:47796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:23:08.215516Z","caller":"traceutil/trace.go:171","msg":"trace[63127048] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"728.070086ms","start":"2026-07-01T07:23:07.487404Z","end":"2026-07-01T07:23:08.215474Z","steps":["trace[63127048] 'process raft request' (duration: 727.660798ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:08.215683Z","caller":"traceutil/trace.go:171","msg":"trace[52834925] transaction","detail":"{read_only:false; number_of_response:1; response_revision:540; }","duration":"726.087417ms","start":"2026-07-01T07:23:07.489586Z","end":"2026-07-01T07:23:08.215674Z","steps":["trace[52834925] 'process raft request' (duration: 725.854992ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:08.215716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.487398Z","time spent":"728.242239ms","remote":"127.0.0.1:47796","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-07-01T07:23:08.215758Z","caller":"traceutil/trace.go:171","msg":"trace[1985074852] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"726.552386ms","start":"2026-07-01T07:23:07.489199Z","end":"2026-07-01T07:23:08.215752Z","steps":["trace[1985074852] 'process raft request' (duration: 726.126827ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:08.215786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.489192Z","time spent":"726.580826ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:23:08.21581Z","caller":"traceutil/trace.go:171","msg":"trace[1221971650] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"725.988565ms","start":"2026-07-01T07:23:07.489791Z","end":"2026-07-01T07:23:08.21578Z","steps":["trace[1221971650] 'process raft request' (duration: 725.727779ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:08.21573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.489578Z","time spent":"726.126558ms","remote":"127.0.0.1:47796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6936,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:23:08.216034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.489758Z","time spent":"726.173579ms","remote":"127.0.0.1:47796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:23:08.216104Z","caller":"traceutil/trace.go:171","msg":"trace[557347074] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:557; }","duration":"719.811176ms","start":"2026-07-01T07:23:07.496263Z","end":"2026-07-01T07:23:08.216074Z","steps":["trace[557347074] 'read index received' (duration: 169.324861ms)","trace[557347074] 'applied index is now lower than readState.Index' (duration: 550.485575ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:23:08.216199Z","caller":"traceutil/trace.go:171","msg":"trace[1932936184] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"722.280614ms","start":"2026-07-01T07:23:07.493908Z","end":"2026-07-01T07:23:08.216188Z","steps":["trace[1932936184] 'process raft request' (duration: 721.862086ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:08.216214Z","caller":"traceutil/trace.go:171","msg":"trace[1054605121] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"721.865206ms","start":"2026-07-01T07:23:07.49434Z","end":"2026-07-01T07:23:08.216205Z","steps":["trace[1054605121] 'process raft request' (duration: 721.463119ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:08.216233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.493883Z","time spent":"722.333904ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:23:08.216244Z","caller":"traceutil/trace.go:171","msg":"trace[1388167680] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"726.559586ms","start":"2026-07-01T07:23:07.489676Z","end":"2026-07-01T07:23:08.216236Z","steps":["trace[1388167680] 'process raft request' (duration: 725.987624ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:08.216284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.489668Z","time spent":"726.597877ms","remote":"127.0.0.1:47796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-01T07:23:08.216319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.494313Z","time spent":"721.923787ms","remote":"127.0.0.1:47796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:23:08.21636Z","caller":"traceutil/trace.go:171","msg":"trace[280836320] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"726.079417ms","start":"2026-07-01T07:23:07.490273Z","end":"2026-07-01T07:23:08.216352Z","steps":["trace[280836320] 'process raft request' (duration: 725.446805ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:08.216391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.490261Z","time spent":"726.114378ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-01T07:23:08.216455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.199223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-01T07:23:08.216471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.84934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:23:08.216478Z","caller":"traceutil/trace.go:171","msg":"trace[365734045] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"726.151438ms","start":"2026-07-01T07:23:07.49032Z","end":"2026-07-01T07:23:08.216471Z","steps":["trace[365734045] 'process raft request' (duration: 725.422555ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:08.216491Z","caller":"traceutil/trace.go:171","msg":"trace[265936630] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:549; }","duration":"720.271684ms","start":"2026-07-01T07:23:07.496212Z","end":"2026-07-01T07:23:08.216483Z","steps":["trace[265936630] 'agreement among raft nodes before linearized reading' (duration: 720.204733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:08.216511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.490314Z","time spent":"726.18195ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-01T07:23:08.216516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.496201Z","time spent":"720.311375ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-01T07:23:08.216627Z","caller":"traceutil/trace.go:171","msg":"trace[1723723991] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"719.304036ms","start":"2026-07-01T07:23:07.497316Z","end":"2026-07-01T07:23:08.21662Z","steps":["trace[1723723991] 'process raft request' (duration: 718.543892ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:08.216673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.497305Z","time spent":"719.343286ms","remote":"127.0.0.1:47796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:23:08.216493Z","caller":"traceutil/trace.go:171","msg":"trace[87885034] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:549; }","duration":"249.90954ms","start":"2026-07-01T07:23:07.966577Z","end":"2026-07-01T07:23:08.216486Z","steps":["trace[87885034] 'agreement among raft nodes before linearized reading' (duration: 249.86971ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:08.216793Z","caller":"traceutil/trace.go:171","msg":"trace[249357344] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"711.632667ms","start":"2026-07-01T07:23:07.505151Z","end":"2026-07-01T07:23:08.216784Z","steps":["trace[249357344] 'process raft request' (duration: 710.761031ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:08.216792Z","caller":"traceutil/trace.go:171","msg":"trace[1167818734] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"606.664203ms","start":"2026-07-01T07:23:07.610109Z","end":"2026-07-01T07:23:08.216774Z","steps":["trace[1167818734] 'process raft request' (duration: 605.905289ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:08.216854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.505136Z","time spent":"711.689088ms","remote":"127.0.0.1:47796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:23:08.216865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:07.610085Z","time spent":"606.745145ms","remote":"127.0.0.1:47796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:23:14.196451Z","caller":"traceutil/trace.go:171","msg":"trace[362407735] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"109.256606ms","start":"2026-07-01T07:23:14.087168Z","end":"2026-07-01T07:23:14.196424Z","steps":["trace[362407735] 'process raft request' (duration: 108.589484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:14.920388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.149943ms","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-07-01T07:23:14.920407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.432179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-01T07:23:14.920486Z","caller":"traceutil/trace.go:171","msg":"trace[1628754120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"431.329456ms","start":"2026-07-01T07:23:14.489131Z","end":"2026-07-01T07:23:14.920461Z","steps":["trace[1628754120] 'range keys from in-memory index tree' (duration: 430.921209ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:14.920507Z","caller":"traceutil/trace.go:171","msg":"trace[2019279241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"430.551581ms","start":"2026-07-01T07:23:14.489924Z","end":"2026-07-01T07:23:14.920476Z","steps":["trace[2019279241] 'range keys from in-memory index tree' (duration: 430.256435ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:14.920533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:14.489098Z","time spent":"431.424968ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T07:23:14.920568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:14.489914Z","time spent":"430.642442ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T07:23:15.46806Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021459161345667,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:23:15.943792Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.263354745s","expected-duration":"1s"} {"level":"info","ts":"2026-07-01T07:23:15.951014Z","caller":"traceutil/trace.go:171","msg":"trace[618237463] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.272251858s","start":"2026-07-01T07:23:14.678069Z","end":"2026-07-01T07:23:15.950321Z","steps":["trace[618237463] 'process raft request' (duration: 1.266804452s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:15.951179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:14.678032Z","time spent":"1.273061383s","remote":"127.0.0.1:47848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:23:16.967137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999991878s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-01T07:23:16.967248Z","caller":"traceutil/trace.go:171","msg":"trace[1457589540] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000166761s","start":"2026-07-01T07:23:14.967049Z","end":"2026-07-01T07:23:16.967216Z","steps":["trace[1457589540] 'agreement among raft nodes before linearized reading' (duration: 2.000041499s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:16.967326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:14.967023Z","time spent":"2.000285184s","remote":"127.0.0.1:47750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/01 07:23:16 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-01T07:23:17.015158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.578526ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:23:17.015527Z","caller":"traceutil/trace.go:171","msg":"trace[1332338922] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"2.090455879s","start":"2026-07-01T07:23:14.925018Z","end":"2026-07-01T07:23:17.015474Z","steps":["trace[1332338922] 'process raft request' (duration: 1.106414405s)","trace[1332338922] 'compare' (duration: 983.352352ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:23:17.015578Z","caller":"traceutil/trace.go:171","msg":"trace[330865227] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"2.088537713s","start":"2026-07-01T07:23:14.927013Z","end":"2026-07-01T07:23:17.015551Z","steps":["trace[330865227] 'process raft request' (duration: 2.088284967s)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:17.015638Z","caller":"traceutil/trace.go:171","msg":"trace[994362863] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:664; }","duration":"2.048458356s","start":"2026-07-01T07:23:14.967117Z","end":"2026-07-01T07:23:17.015575Z","steps":["trace[994362863] 'read index received' (duration: 977.12075ms)","trace[994362863] 'applied index is now lower than readState.Index' (duration: 1.071334576s)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:23:17.015697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:14.924995Z","time spent":"2.090606664s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:23:17.015758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:14.926999Z","time spent":"2.088641406s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:23:17.01589Z","caller":"traceutil/trace.go:171","msg":"trace[1474181195] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"1.004124114s","start":"2026-07-01T07:23:16.011739Z","end":"2026-07-01T07:23:17.015863Z","steps":["trace[1474181195] 'process raft request' (duration: 1.003784457s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:17.016078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:16.011708Z","time spent":"1.004272906s","remote":"127.0.0.1:48000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-01T07:23:17.01619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.026543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T07:23:17.0162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.51388976s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-01T07:23:17.016247Z","caller":"traceutil/trace.go:171","msg":"trace[1250782821] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"459.107874ms","start":"2026-07-01T07:23:16.55711Z","end":"2026-07-01T07:23:17.016218Z","steps":["trace[1250782821] 'agreement among raft nodes before linearized reading' (duration: 459.021223ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:17.016278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:16.557086Z","time spent":"459.185046ms","remote":"127.0.0.1:47746","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-07-01T07:23:17.016286Z","caller":"traceutil/trace.go:171","msg":"trace[697610403] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"1.514030862s","start":"2026-07-01T07:23:15.502233Z","end":"2026-07-01T07:23:17.016264Z","steps":["trace[697610403] 'agreement among raft nodes before linearized reading' (duration: 1.513794988s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:17.016343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:15.502211Z","time spent":"1.514117354s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-01T07:23:17.016386Z","caller":"traceutil/trace.go:171","msg":"trace[1451458934] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"143.227924ms","start":"2026-07-01T07:23:16.873142Z","end":"2026-07-01T07:23:17.01637Z","steps":["trace[1451458934] 'process raft request' (duration: 142.655474ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:17.016774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.266926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-01T07:23:17.016822Z","caller":"traceutil/trace.go:171","msg":"trace[656448972] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"764.351517ms","start":"2026-07-01T07:23:16.252459Z","end":"2026-07-01T07:23:17.01681Z","steps":["trace[656448972] 'agreement among raft nodes before linearized reading' (duration: 764.202215ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:17.016855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:16.252438Z","time spent":"764.411059ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-01T07:23:18.157594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.389182ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:23:18.15806Z","caller":"traceutil/trace.go:171","msg":"trace[525538470] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:672; }","duration":"191.109433ms","start":"2026-07-01T07:23:17.966931Z","end":"2026-07-01T07:23:18.15804Z","steps":["trace[525538470] 'read index received' (duration: 34.681µs)","trace[525538470] 'applied index is now lower than readState.Index' (duration: 191.034211ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:23:18.158184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.249906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:23:18.158245Z","caller":"traceutil/trace.go:171","msg":"trace[468688816] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"191.356918ms","start":"2026-07-01T07:23:17.966875Z","end":"2026-07-01T07:23:18.158232Z","steps":["trace[468688816] 'agreement among raft nodes before linearized reading' (duration: 191.217765ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:18.158165Z","caller":"traceutil/trace.go:171","msg":"trace[1186490882] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.084872848s","start":"2026-07-01T07:23:17.073172Z","end":"2026-07-01T07:23:18.158045Z","steps":["trace[1186490882] 'process raft request' (duration: 244.944406ms)","trace[1186490882] 'compare' (duration: 839.199378ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:23:18.158483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:17.073158Z","time spent":"1.085254575s","remote":"127.0.0.1:47948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:23:18.795728Z","caller":"traceutil/trace.go:171","msg":"trace[493991736] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"633.042025ms","start":"2026-07-01T07:23:18.162653Z","end":"2026-07-01T07:23:18.795695Z","steps":["trace[493991736] 'process raft request' (duration: 607.380478ms)","trace[493991736] 'compare' (duration: 25.431712ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:23:18.795867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:18.162625Z","time spent":"633.173726ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:23:18.798183Z","caller":"traceutil/trace.go:171","msg":"trace[713914812] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"633.861491ms","start":"2026-07-01T07:23:18.164304Z","end":"2026-07-01T07:23:18.798165Z","steps":["trace[713914812] 'process raft request' (duration: 633.8213ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:18.798221Z","caller":"traceutil/trace.go:171","msg":"trace[1228403465] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"635.081114ms","start":"2026-07-01T07:23:18.163097Z","end":"2026-07-01T07:23:18.798179Z","steps":["trace[1228403465] 'process raft request' (duration: 634.906361ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:18.798337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:18.164292Z","time spent":"633.948112ms","remote":"127.0.0.1:48000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:23:18.798441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:18.16308Z","time spent":"635.218837ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:23:18.798204Z","caller":"traceutil/trace.go:171","msg":"trace[1134316641] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"634.661936ms","start":"2026-07-01T07:23:18.163529Z","end":"2026-07-01T07:23:18.798191Z","steps":["trace[1134316641] 'process raft request' (duration: 634.543894ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:18.79862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:18.163517Z","time spent":"635.067624ms","remote":"127.0.0.1:47948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:23:25.258308Z","caller":"traceutil/trace.go:171","msg":"trace[1390485433] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"104.597247ms","start":"2026-07-01T07:23:25.153683Z","end":"2026-07-01T07:23:25.25828Z","steps":["trace[1390485433] 'process raft request' (duration: 104.020285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:35.730054Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021459161345998,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:23:36.230997Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021459161345998,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:23:36.288214Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.142714668s","expected-duration":"1s"} {"level":"info","ts":"2026-07-01T07:23:36.288681Z","caller":"traceutil/trace.go:171","msg":"trace[2135635664] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"1.14328508s","start":"2026-07-01T07:23:35.145371Z","end":"2026-07-01T07:23:36.288657Z","steps":["trace[2135635664] 'process raft request' (duration: 1.143096626s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:36.288832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:35.145281Z","time spent":"1.143473524s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:23:36.545116Z","caller":"traceutil/trace.go:171","msg":"trace[1330358029] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:842; }","duration":"1.315740091s","start":"2026-07-01T07:23:35.229353Z","end":"2026-07-01T07:23:36.545093Z","steps":["trace[1330358029] 'read index received' (duration: 1.059110959s)","trace[1330358029] 'applied index is now lower than readState.Index' (duration: 256.628112ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:23:36.545206Z","caller":"traceutil/trace.go:171","msg":"trace[906824729] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"1.094072206s","start":"2026-07-01T07:23:35.451092Z","end":"2026-07-01T07:23:36.545164Z","steps":["trace[906824729] 'process raft request' (duration: 1.093826241s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:36.545308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315941624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-01T07:23:36.545329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.050659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:23:36.54536Z","caller":"traceutil/trace.go:171","msg":"trace[1581175557] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:811; }","duration":"1.316048886s","start":"2026-07-01T07:23:35.229298Z","end":"2026-07-01T07:23:36.545347Z","steps":["trace[1581175557] 'agreement among raft nodes before linearized reading' (duration: 1.315911344s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:36.545364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.30800973s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-01T07:23:36.545371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:35.451068Z","time spent":"1.094201519s","remote":"127.0.0.1:48000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:23:36.545441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:35.22926Z","time spent":"1.316168719s","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":29,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-07-01T07:23:36.545437Z","caller":"traceutil/trace.go:171","msg":"trace[1146009446] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:811; }","duration":"578.170751ms","start":"2026-07-01T07:23:35.96722Z","end":"2026-07-01T07:23:36.545391Z","steps":["trace[1146009446] 'agreement among raft nodes before linearized reading' (duration: 578.025639ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:36.54545Z","caller":"traceutil/trace.go:171","msg":"trace[1118516104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:811; }","duration":"1.308132623s","start":"2026-07-01T07:23:35.237306Z","end":"2026-07-01T07:23:36.545438Z","steps":["trace[1118516104] 'agreement among raft nodes before linearized reading' (duration: 1.307917059s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:36.545477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.303039465s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-01T07:23:36.545484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:35.9672Z","time spent":"578.275733ms","remote":"127.0.0.1:47746","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-07-01T07:23:36.545495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:35.237292Z","time spent":"1.308193034s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-01T07:23:36.545529Z","caller":"traceutil/trace.go:171","msg":"trace[1166621999] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:811; }","duration":"1.303152858s","start":"2026-07-01T07:23:35.242362Z","end":"2026-07-01T07:23:36.545515Z","steps":["trace[1166621999] 'agreement among raft nodes before linearized reading' (duration: 1.302950904s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:36.545681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:35.242339Z","time spent":"1.303215528s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-01T07:23:36.545658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.867885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-01T07:23:36.545762Z","caller":"traceutil/trace.go:171","msg":"trace[887114397] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:811; }","duration":"195.019438ms","start":"2026-07-01T07:23:36.350715Z","end":"2026-07-01T07:23:36.545735Z","steps":["trace[887114397] 'agreement among raft nodes before linearized reading' (duration: 194.62865ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:36.545965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.223079915s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-01T07:23:36.546024Z","caller":"traceutil/trace.go:171","msg":"trace[1821536482] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:811; }","duration":"1.223178968s","start":"2026-07-01T07:23:35.322827Z","end":"2026-07-01T07:23:36.546006Z","steps":["trace[1821536482] 'agreement among raft nodes before linearized reading' (duration: 1.223000453s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:36.546068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:23:35.322779Z","time spent":"1.2232757s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-01T07:23:44.078187Z","caller":"traceutil/trace.go:171","msg":"trace[1589296806] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"218.703727ms","start":"2026-07-01T07:23:43.859461Z","end":"2026-07-01T07:23:44.078165Z","steps":["trace[1589296806] 'process raft request' (duration: 218.501983ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:44.078363Z","caller":"traceutil/trace.go:171","msg":"trace[1875664678] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:916; }","duration":"179.246053ms","start":"2026-07-01T07:23:43.89909Z","end":"2026-07-01T07:23:44.078336Z","steps":["trace[1875664678] 'read index received' (duration: 178.870916ms)","trace[1875664678] 'applied index is now lower than readState.Index' (duration: 373.477µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:23:44.078452Z","caller":"traceutil/trace.go:171","msg":"trace[734641898] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"215.891062ms","start":"2026-07-01T07:23:43.862515Z","end":"2026-07-01T07:23:44.078406Z","steps":["trace[734641898] 'process raft request' (duration: 215.594197ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:23:44.078598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.481137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-trztr\" ","response":"range_response_count:1 size:3871"} {"level":"info","ts":"2026-07-01T07:23:44.078673Z","caller":"traceutil/trace.go:171","msg":"trace[957565934] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-trztr; range_end:; response_count:1; response_revision:884; }","duration":"179.604369ms","start":"2026-07-01T07:23:43.89905Z","end":"2026-07-01T07:23:44.078655Z","steps":["trace[957565934] 'agreement among raft nodes before linearized reading' (duration: 179.396045ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:23:44.079223Z","caller":"traceutil/trace.go:171","msg":"trace[146383227] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"179.894125ms","start":"2026-07-01T07:23:43.899277Z","end":"2026-07-01T07:23:44.079171Z","steps":["trace[146383227] 'process raft request' (duration: 179.671411ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:02.653523Z","caller":"traceutil/trace.go:171","msg":"trace[1592037461] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"134.205109ms","start":"2026-07-01T07:24:02.519287Z","end":"2026-07-01T07:24:02.653492Z","steps":["trace[1592037461] 'process raft request' (duration: 134.071606ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:11.115789Z","caller":"traceutil/trace.go:171","msg":"trace[180399224] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1063; }","duration":"145.063859ms","start":"2026-07-01T07:24:10.970704Z","end":"2026-07-01T07:24:11.115768Z","steps":["trace[180399224] 'read index received' (duration: 144.866925ms)","trace[180399224] 'applied index is now lower than readState.Index' (duration: 195.514µs)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:24:11.116174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.784073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-01T07:24:11.116185Z","caller":"traceutil/trace.go:171","msg":"trace[1449795084] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"268.248523ms","start":"2026-07-01T07:24:10.847884Z","end":"2026-07-01T07:24:11.116133Z","steps":["trace[1449795084] 'process raft request' (duration: 267.749733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:11.116206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.481826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-01T07:24:11.116256Z","caller":"traceutil/trace.go:171","msg":"trace[1375468063] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1023; }","duration":"111.927567ms","start":"2026-07-01T07:24:11.00431Z","end":"2026-07-01T07:24:11.116237Z","steps":["trace[1375468063] 'agreement among raft nodes before linearized reading' (duration: 111.694352ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:11.116275Z","caller":"traceutil/trace.go:171","msg":"trace[2004451058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1023; }","duration":"145.605839ms","start":"2026-07-01T07:24:10.970652Z","end":"2026-07-01T07:24:11.116258Z","steps":["trace[2004451058] 'agreement among raft nodes before linearized reading' (duration: 145.376765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:11.838247Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021459161346454,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-01T07:24:12.14562Z","caller":"traceutil/trace.go:171","msg":"trace[1727891128] linearizableReadLoop","detail":"{readStateIndex:1068; appliedIndex:1064; }","duration":"808.342057ms","start":"2026-07-01T07:24:11.337237Z","end":"2026-07-01T07:24:12.145579Z","steps":["trace[1727891128] 'read index received' (duration: 736.744081ms)","trace[1727891128] 'applied index is now lower than readState.Index' (duration: 71.596626ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:24:12.145949Z","caller":"traceutil/trace.go:171","msg":"trace[718935943] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"1.024296898s","start":"2026-07-01T07:24:11.121627Z","end":"2026-07-01T07:24:12.145923Z","steps":["trace[718935943] 'process raft request' (duration: 952.224603ms)","trace[718935943] 'compare' (duration: 71.412382ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:24:12.146091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:11.121578Z","time spent":"1.02441581s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:24:12.14617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.893578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T07:24:12.146243Z","caller":"traceutil/trace.go:171","msg":"trace[1369908552] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"1.024267817s","start":"2026-07-01T07:24:11.121964Z","end":"2026-07-01T07:24:12.146232Z","steps":["trace[1369908552] 'process raft request' (duration: 1.023492972s)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:12.146259Z","caller":"traceutil/trace.go:171","msg":"trace[2064634151] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1027; }","duration":"809.030421ms","start":"2026-07-01T07:24:11.337211Z","end":"2026-07-01T07:24:12.146241Z","steps":["trace[2064634151] 'agreement among raft nodes before linearized reading' (duration: 808.855608ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:12.146233Z","caller":"traceutil/trace.go:171","msg":"trace[190069100] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"420.593862ms","start":"2026-07-01T07:24:11.725572Z","end":"2026-07-01T07:24:12.146166Z","steps":["trace[190069100] 'process raft request' (duration: 419.973739ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:12.146348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.099009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-01T07:24:12.146366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:11.121945Z","time spent":"1.024331639s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:24:12.146391Z","caller":"traceutil/trace.go:171","msg":"trace[538202082] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1027; }","duration":"799.14535ms","start":"2026-07-01T07:24:11.347234Z","end":"2026-07-01T07:24:12.14638Z","steps":["trace[538202082] 'agreement among raft nodes before linearized reading' (duration: 799.068018ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:12.146434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:11.347218Z","time spent":"799.207251ms","remote":"127.0.0.1:48152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-01T07:24:12.146522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:11.725551Z","time spent":"420.822547ms","remote":"127.0.0.1:48026","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-07-01T07:24:12.146558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.075626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:24:12.146592Z","caller":"traceutil/trace.go:171","msg":"trace[1894229396] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1027; }","duration":"179.145328ms","start":"2026-07-01T07:24:11.967435Z","end":"2026-07-01T07:24:12.14658Z","steps":["trace[1894229396] 'agreement among raft nodes before linearized reading' (duration: 179.090007ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:12.146305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:11.337199Z","time spent":"809.096372ms","remote":"127.0.0.1:48292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":29,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-07-01T07:24:12.146176Z","caller":"traceutil/trace.go:171","msg":"trace[2027507034] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"1.024096284s","start":"2026-07-01T07:24:11.122032Z","end":"2026-07-01T07:24:12.146128Z","steps":["trace[2027507034] 'process raft request' (duration: 1.023472551s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:12.146993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:11.122004Z","time spent":"1.02494282s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:24:12.876711Z","caller":"traceutil/trace.go:171","msg":"trace[2037759502] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"182.31839ms","start":"2026-07-01T07:24:12.694369Z","end":"2026-07-01T07:24:12.876688Z","steps":["trace[2037759502] 'process raft request' (duration: 182.173516ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:13.873692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.095772ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:24:13.873795Z","caller":"traceutil/trace.go:171","msg":"trace[1193905741] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1028; }","duration":"669.218204ms","start":"2026-07-01T07:24:13.204562Z","end":"2026-07-01T07:24:13.87378Z","steps":["trace[1193905741] 'range keys from in-memory index tree' (duration: 669.078011ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:13.87396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.520586ms","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-07-01T07:24:13.874036Z","caller":"traceutil/trace.go:171","msg":"trace[383158239] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1028; }","duration":"753.641748ms","start":"2026-07-01T07:24:13.120375Z","end":"2026-07-01T07:24:13.874017Z","steps":["trace[383158239] 'range keys from in-memory index tree' (duration: 753.352493ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:13.87409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:13.120356Z","time spent":"753.72214ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-01T07:24:13.988742Z","caller":"traceutil/trace.go:171","msg":"trace[414003064] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"110.344756ms","start":"2026-07-01T07:24:13.878363Z","end":"2026-07-01T07:24:13.988708Z","steps":["trace[414003064] 'process raft request' (duration: 110.147053ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:35.376626Z","caller":"traceutil/trace.go:171","msg":"trace[604478754] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"376.748532ms","start":"2026-07-01T07:24:34.999841Z","end":"2026-07-01T07:24:35.376589Z","steps":["trace[604478754] 'process raft request' (duration: 376.548758ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:35.376895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:34.999823Z","time spent":"376.983868ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:24:36.21665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.731534ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:24:36.216765Z","caller":"traceutil/trace.go:171","msg":"trace[101941564] linearizableReadLoop","detail":"{readStateIndex:1148; appliedIndex:1147; }","duration":"250.09345ms","start":"2026-07-01T07:24:35.966655Z","end":"2026-07-01T07:24:36.216748Z","steps":["trace[101941564] 'read index received' (duration: 78.258254ms)","trace[101941564] 'applied index is now lower than readState.Index' (duration: 171.833776ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:24:36.217091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.710715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-01T07:24:36.217214Z","caller":"traceutil/trace.go:171","msg":"trace[1900015634] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1102; }","duration":"138.861778ms","start":"2026-07-01T07:24:36.078312Z","end":"2026-07-01T07:24:36.217174Z","steps":["trace[1900015634] 'agreement among raft nodes before linearized reading' (duration: 138.647904ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:36.217217Z","caller":"traceutil/trace.go:171","msg":"trace[650393213] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"287.040286ms","start":"2026-07-01T07:24:35.930154Z","end":"2026-07-01T07:24:36.217194Z","steps":["trace[650393213] 'process raft request' (duration: 114.67824ms)","trace[650393213] 'compare' (duration: 171.619462ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:24:36.217308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.648942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:24:36.217374Z","caller":"traceutil/trace.go:171","msg":"trace[1131799826] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1102; }","duration":"250.761164ms","start":"2026-07-01T07:24:35.966597Z","end":"2026-07-01T07:24:36.217359Z","steps":["trace[1131799826] 'agreement among raft nodes before linearized reading' (duration: 250.650742ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:36.718606Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021459161346666,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:24:37.006118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.562954ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:24:37.006249Z","caller":"traceutil/trace.go:171","msg":"trace[565719689] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"788.519544ms","start":"2026-07-01T07:24:36.217709Z","end":"2026-07-01T07:24:37.006228Z","steps":["trace[565719689] 'process raft request' (duration: 589.731216ms)","trace[565719689] 'compare' (duration: 197.593795ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:24:37.006517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:36.217692Z","time spent":"788.774409ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:24:37.029111Z","caller":"traceutil/trace.go:171","msg":"trace[762380052] linearizableReadLoop","detail":"{readStateIndex:1150; appliedIndex:1148; }","duration":"810.786966ms","start":"2026-07-01T07:24:36.218307Z","end":"2026-07-01T07:24:37.029094Z","steps":["trace[762380052] 'read index received' (duration: 589.251626ms)","trace[762380052] 'applied index is now lower than readState.Index' (duration: 221.53427ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:24:37.029256Z","caller":"traceutil/trace.go:171","msg":"trace[873056656] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"808.192786ms","start":"2026-07-01T07:24:36.221024Z","end":"2026-07-01T07:24:37.029217Z","steps":["trace[873056656] 'process raft request' (duration: 807.954492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:37.029324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.965469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:24:37.029358Z","caller":"traceutil/trace.go:171","msg":"trace[380273209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1104; }","duration":"811.087792ms","start":"2026-07-01T07:24:36.218259Z","end":"2026-07-01T07:24:37.029347Z","steps":["trace[380273209] 'agreement among raft nodes before linearized reading' (duration: 810.95513ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:37.029443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:36.218212Z","time spent":"811.220795ms","remote":"127.0.0.1:47750","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-07-01T07:24:37.029503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:36.221011Z","time spent":"808.34227ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:24:37.029703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.199187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-01T07:24:37.029785Z","caller":"traceutil/trace.go:171","msg":"trace[1092994429] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1104; }","duration":"791.323798ms","start":"2026-07-01T07:24:36.238449Z","end":"2026-07-01T07:24:37.029773Z","steps":["trace[1092994429] 'agreement among raft nodes before linearized reading' (duration: 791.072244ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:37.029856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:36.238431Z","time spent":"791.415291ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-01T07:24:37.029659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.113667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:24:37.030003Z","caller":"traceutil/trace.go:171","msg":"trace[992860110] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1104; }","duration":"756.509414ms","start":"2026-07-01T07:24:36.273461Z","end":"2026-07-01T07:24:37.02997Z","steps":["trace[992860110] 'agreement among raft nodes before linearized reading' (duration: 756.127307ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:37.029861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.464056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-01T07:24:37.030084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:36.273437Z","time spent":"756.595696ms","remote":"127.0.0.1:54722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-01T07:24:37.030116Z","caller":"traceutil/trace.go:171","msg":"trace[997815679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1104; }","duration":"784.72644ms","start":"2026-07-01T07:24:36.245371Z","end":"2026-07-01T07:24:37.030097Z","steps":["trace[997815679] 'agreement among raft nodes before linearized reading' (duration: 784.390594ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:37.03017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:36.24536Z","time spent":"784.800482ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T07:24:37.030556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.176383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-01T07:24:37.030606Z","caller":"traceutil/trace.go:171","msg":"trace[880428973] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1104; }","duration":"781.263594ms","start":"2026-07-01T07:24:36.249334Z","end":"2026-07-01T07:24:37.030597Z","steps":["trace[880428973] 'agreement among raft nodes before linearized reading' (duration: 780.218363ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:37.030632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:36.249318Z","time spent":"781.307445ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-01T07:24:39.149027Z","caller":"traceutil/trace.go:171","msg":"trace[836551515] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1155; }","duration":"115.71175ms","start":"2026-07-01T07:24:39.033288Z","end":"2026-07-01T07:24:39.149Z","steps":["trace[836551515] 'read index received' (duration: 115.625978ms)","trace[836551515] 'applied index is now lower than readState.Index' (duration: 84.732µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:24:39.149129Z","caller":"traceutil/trace.go:171","msg":"trace[174575225] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"137.290947ms","start":"2026-07-01T07:24:39.011796Z","end":"2026-07-01T07:24:39.149087Z","steps":["trace[174575225] 'process raft request' (duration: 137.053403ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:39.149345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.032186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-01T07:24:39.149458Z","caller":"traceutil/trace.go:171","msg":"trace[482762948] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1110; }","duration":"116.202689ms","start":"2026-07-01T07:24:39.033231Z","end":"2026-07-01T07:24:39.149434Z","steps":["trace[482762948] 'agreement among raft nodes before linearized reading' (duration: 115.890513ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:39.532443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.088846ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:24:39.532723Z","caller":"traceutil/trace.go:171","msg":"trace[1163858351] linearizableReadLoop","detail":"{readStateIndex:1160; appliedIndex:1156; }","duration":"221.063199ms","start":"2026-07-01T07:24:39.311643Z","end":"2026-07-01T07:24:39.532706Z","steps":["trace[1163858351] 'read index received' (duration: 202.120422ms)","trace[1163858351] 'applied index is now lower than readState.Index' (duration: 18.941857ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:24:39.532726Z","caller":"traceutil/trace.go:171","msg":"trace[607246180] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"379.173211ms","start":"2026-07-01T07:24:39.153494Z","end":"2026-07-01T07:24:39.532667Z","steps":["trace[607246180] 'process raft request' (duration: 73.782578ms)","trace[607246180] 'compare' (duration: 304.979704ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:24:39.53282Z","caller":"traceutil/trace.go:171","msg":"trace[1761596281] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"378.651081ms","start":"2026-07-01T07:24:39.154158Z","end":"2026-07-01T07:24:39.53281Z","steps":["trace[1761596281] 'process raft request' (duration: 378.432397ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:39.532823Z","caller":"traceutil/trace.go:171","msg":"trace[448029763] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"379.212471ms","start":"2026-07-01T07:24:39.153494Z","end":"2026-07-01T07:24:39.532706Z","steps":["trace[448029763] 'process raft request' (duration: 379.046528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:39.532882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:39.153474Z","time spent":"379.328444ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:24:39.532986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:39.153474Z","time spent":"379.442166ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:24:39.532895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:39.154144Z","time spent":"378.720972ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:24:39.533022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.352505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:24:39.533005Z","caller":"traceutil/trace.go:171","msg":"trace[1956644828] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"378.670411ms","start":"2026-07-01T07:24:39.154305Z","end":"2026-07-01T07:24:39.532975Z","steps":["trace[1956644828] 'process raft request' (duration: 378.320485ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:39.533115Z","caller":"traceutil/trace.go:171","msg":"trace[1981956148] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1114; }","duration":"221.491628ms","start":"2026-07-01T07:24:39.311604Z","end":"2026-07-01T07:24:39.533096Z","steps":["trace[1981956148] 'agreement among raft nodes before linearized reading' (duration: 221.246453ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:39.533255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:39.154287Z","time spent":"378.885766ms","remote":"127.0.0.1:48026","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-07-01T07:24:40.554423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.538107ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-01T07:24:40.554574Z","caller":"traceutil/trace.go:171","msg":"trace[1796146109] linearizableReadLoop","detail":"{readStateIndex:1162; appliedIndex:1161; }","duration":"510.926921ms","start":"2026-07-01T07:24:40.043622Z","end":"2026-07-01T07:24:40.554548Z","steps":["trace[1796146109] 'read index received' (duration: 99.187439ms)","trace[1796146109] 'applied index is now lower than readState.Index' (duration: 411.737472ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:24:40.55476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.228026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-01T07:24:40.554788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.114005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:24:40.554851Z","caller":"traceutil/trace.go:171","msg":"trace[1658471127] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1115; }","duration":"420.358948ms","start":"2026-07-01T07:24:40.134475Z","end":"2026-07-01T07:24:40.554834Z","steps":["trace[1658471127] 'agreement among raft nodes before linearized reading' (duration: 420.197245ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:40.554919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:40.134417Z","time spent":"420.485541ms","remote":"127.0.0.1:48240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-07-01T07:24:40.554936Z","caller":"traceutil/trace.go:171","msg":"trace[1417668880] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1115; }","duration":"511.322169ms","start":"2026-07-01T07:24:40.043567Z","end":"2026-07-01T07:24:40.554889Z","steps":["trace[1417668880] 'agreement among raft nodes before linearized reading' (duration: 511.063934ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:40.55504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:40.043535Z","time spent":"511.43792ms","remote":"127.0.0.1:47900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"info","ts":"2026-07-01T07:24:55.838945Z","caller":"traceutil/trace.go:171","msg":"trace[1033109499] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"193.896051ms","start":"2026-07-01T07:24:55.645022Z","end":"2026-07-01T07:24:55.838918Z","steps":["trace[1033109499] 'process raft request' (duration: 193.84085ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:55.839163Z","caller":"traceutil/trace.go:171","msg":"trace[1465116892] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"226.533444ms","start":"2026-07-01T07:24:55.612604Z","end":"2026-07-01T07:24:55.839137Z","steps":["trace[1465116892] 'process raft request' (duration: 215.253655ms)","trace[1465116892] 'compare' (duration: 10.868701ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:24:55.839236Z","caller":"traceutil/trace.go:171","msg":"trace[1762921468] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"197.745366ms","start":"2026-07-01T07:24:55.641434Z","end":"2026-07-01T07:24:55.839179Z","steps":["trace[1762921468] 'read index received' (duration: 186.457767ms)","trace[1762921468] 'applied index is now lower than readState.Index' (duration: 11.279629ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:24:55.839464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.588208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-01T07:24:55.83956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.803979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-01T07:24:55.839563Z","caller":"traceutil/trace.go:171","msg":"trace[775845931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"220.746021ms","start":"2026-07-01T07:24:55.618798Z","end":"2026-07-01T07:24:55.839544Z","steps":["trace[775845931] 'agreement among raft nodes before linearized reading' (duration: 220.410444ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:24:55.839605Z","caller":"traceutil/trace.go:171","msg":"trace[816871175] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1216; }","duration":"224.933872ms","start":"2026-07-01T07:24:55.614657Z","end":"2026-07-01T07:24:55.839591Z","steps":["trace[816871175] 'agreement among raft nodes before linearized reading' (duration: 224.666837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:57.129876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.911058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:24:57.129938Z","caller":"traceutil/trace.go:171","msg":"trace[99645058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1219; }","duration":"165.008291ms","start":"2026-07-01T07:24:56.964915Z","end":"2026-07-01T07:24:57.129924Z","steps":["trace[99645058] 'range keys from in-memory index tree' (duration: 164.852457ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:57.129906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.82038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:24:57.129974Z","caller":"traceutil/trace.go:171","msg":"trace[1839895460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1219; }","duration":"572.934822ms","start":"2026-07-01T07:24:56.557025Z","end":"2026-07-01T07:24:57.12996Z","steps":["trace[1839895460] 'range keys from in-memory index tree' (duration: 572.751979ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:57.129998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:56.557006Z","time spent":"572.984373ms","remote":"127.0.0.1:47746","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-07-01T07:24:57.130375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.874495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:24:57.130407Z","caller":"traceutil/trace.go:171","msg":"trace[65844301] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1219; }","duration":"516.961857ms","start":"2026-07-01T07:24:56.613436Z","end":"2026-07-01T07:24:57.130398Z","steps":["trace[65844301] 'count revisions from in-memory index tree' (duration: 516.370126ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:57.130432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:56.613386Z","time spent":"517.035658ms","remote":"127.0.0.1:54852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-01T07:24:57.893928Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021459161346930,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-01T07:24:57.900525Z","caller":"traceutil/trace.go:171","msg":"trace[593000006] linearizableReadLoop","detail":"{readStateIndex:1272; appliedIndex:1271; }","duration":"507.018474ms","start":"2026-07-01T07:24:57.393485Z","end":"2026-07-01T07:24:57.900503Z","steps":["trace[593000006] 'read index received' (duration: 506.845111ms)","trace[593000006] 'applied index is now lower than readState.Index' (duration: 172.353µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:24:57.900622Z","caller":"traceutil/trace.go:171","msg":"trace[571473432] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"636.876282ms","start":"2026-07-01T07:24:57.263712Z","end":"2026-07-01T07:24:57.900588Z","steps":["trace[571473432] 'process raft request' (duration: 636.637268ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:57.900759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.246858ms","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-07-01T07:24:57.900805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:57.263684Z","time spent":"637.027396ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:24:57.900814Z","caller":"traceutil/trace.go:171","msg":"trace[231815202] 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:1220; }","duration":"507.32001ms","start":"2026-07-01T07:24:57.393479Z","end":"2026-07-01T07:24:57.900799Z","steps":["trace[231815202] 'agreement among raft nodes before linearized reading' (duration: 507.197397ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:57.900864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:24:57.393433Z","time spent":"507.420442ms","remote":"127.0.0.1:54932","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-07-01T07:24:57.901351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.144498ms","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-07-01T07:24:57.901394Z","caller":"traceutil/trace.go:171","msg":"trace[709906560] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1220; }","duration":"255.21451ms","start":"2026-07-01T07:24:57.646168Z","end":"2026-07-01T07:24:57.901383Z","steps":["trace[709906560] 'agreement among raft nodes before linearized reading' (duration: 255.094178ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:24:57.901659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.160755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T07:24:57.901699Z","caller":"traceutil/trace.go:171","msg":"trace[1690534443] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1220; }","duration":"244.244037ms","start":"2026-07-01T07:24:57.657442Z","end":"2026-07-01T07:24:57.901686Z","steps":["trace[1690534443] 'agreement among raft nodes before linearized reading' (duration: 244.183786ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:10.070114Z","caller":"traceutil/trace.go:171","msg":"trace[1767602481] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"114.748166ms","start":"2026-07-01T07:25:09.955337Z","end":"2026-07-01T07:25:10.070085Z","steps":["trace[1767602481] 'process raft request' (duration: 114.589433ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:10.070287Z","caller":"traceutil/trace.go:171","msg":"trace[1034571337] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1315; }","duration":"103.278934ms","start":"2026-07-01T07:25:09.966982Z","end":"2026-07-01T07:25:10.070261Z","steps":["trace[1034571337] 'read index received' (duration: 103.269174ms)","trace[1034571337] 'applied index is now lower than readState.Index' (duration: 8.27µs)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:25:10.07056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.542278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:25:10.070603Z","caller":"traceutil/trace.go:171","msg":"trace[1701450716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1260; }","duration":"103.664051ms","start":"2026-07-01T07:25:09.966927Z","end":"2026-07-01T07:25:10.070591Z","steps":["trace[1701450716] 'agreement among raft nodes before linearized reading' (duration: 103.480128ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:10.352596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.984859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-01T07:25:10.352674Z","caller":"traceutil/trace.go:171","msg":"trace[851052402] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1260; }","duration":"200.104182ms","start":"2026-07-01T07:25:10.152552Z","end":"2026-07-01T07:25:10.352656Z","steps":["trace[851052402] 'range keys from in-memory index tree' (duration: 199.784806ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:10.352896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.277536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-01T07:25:10.352929Z","caller":"traceutil/trace.go:171","msg":"trace[741864339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1260; }","duration":"198.351498ms","start":"2026-07-01T07:25:10.154569Z","end":"2026-07-01T07:25:10.35292Z","steps":["trace[741864339] 'range keys from in-memory index tree' (duration: 198.156994ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:10.353122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.889144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-01T07:25:10.353154Z","caller":"traceutil/trace.go:171","msg":"trace[1027237136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1260; }","duration":"186.944556ms","start":"2026-07-01T07:25:10.166201Z","end":"2026-07-01T07:25:10.353145Z","steps":["trace[1027237136] 'range keys from in-memory index tree' (duration: 186.743652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:10.353304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.322375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-01T07:25:10.353333Z","caller":"traceutil/trace.go:171","msg":"trace[1273664800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1260; }","duration":"185.396875ms","start":"2026-07-01T07:25:10.167929Z","end":"2026-07-01T07:25:10.353326Z","steps":["trace[1273664800] 'range keys from in-memory index tree' (duration: 185.212082ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:10.353522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.236785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-01T07:25:10.353556Z","caller":"traceutil/trace.go:171","msg":"trace[626767286] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1260; }","duration":"182.291486ms","start":"2026-07-01T07:25:10.171255Z","end":"2026-07-01T07:25:10.353546Z","steps":["trace[626767286] 'range keys from in-memory index tree' (duration: 182.128753ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:12.598446Z","caller":"traceutil/trace.go:171","msg":"trace[575524238] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"162.292578ms","start":"2026-07-01T07:25:12.436115Z","end":"2026-07-01T07:25:12.598407Z","steps":["trace[575524238] 'process raft request' (duration: 112.366879ms)","trace[575524238] 'compare' (duration: 49.710055ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:25:12.598673Z","caller":"traceutil/trace.go:171","msg":"trace[377535576] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"161.298958ms","start":"2026-07-01T07:25:12.437343Z","end":"2026-07-01T07:25:12.598642Z","steps":["trace[377535576] 'process raft request' (duration: 161.208036ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:12.598728Z","caller":"traceutil/trace.go:171","msg":"trace[109544673] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"162.502891ms","start":"2026-07-01T07:25:12.436197Z","end":"2026-07-01T07:25:12.5987Z","steps":["trace[109544673] 'process raft request' (duration: 162.152765ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:14.495648Z","caller":"traceutil/trace.go:171","msg":"trace[2100793398] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1326; }","duration":"217.417997ms","start":"2026-07-01T07:25:14.278201Z","end":"2026-07-01T07:25:14.495619Z","steps":["trace[2100793398] 'read index received' (duration: 217.200663ms)","trace[2100793398] 'applied index is now lower than readState.Index' (duration: 216.504µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:25:14.496013Z","caller":"traceutil/trace.go:171","msg":"trace[1786456683] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"386.609948ms","start":"2026-07-01T07:25:14.10939Z","end":"2026-07-01T07:25:14.496Z","steps":["trace[1786456683] 'process raft request' (duration: 386.087708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:14.496128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:14.109365Z","time spent":"386.68312ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:25:14.496281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.081249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:25:14.496315Z","caller":"traceutil/trace.go:171","msg":"trace[764994359] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1272; }","duration":"218.146001ms","start":"2026-07-01T07:25:14.27816Z","end":"2026-07-01T07:25:14.496306Z","steps":["trace[764994359] 'agreement among raft nodes before linearized reading' (duration: 218.08574ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:14.496618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.669126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-01T07:25:14.496674Z","caller":"traceutil/trace.go:171","msg":"trace[1989236384] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:1272; }","duration":"162.766467ms","start":"2026-07-01T07:25:14.333895Z","end":"2026-07-01T07:25:14.496661Z","steps":["trace[1989236384] 'agreement among raft nodes before linearized reading' (duration: 162.607943ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:14.69118Z","caller":"traceutil/trace.go:171","msg":"trace[905251215] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"147.97287ms","start":"2026-07-01T07:25:14.543177Z","end":"2026-07-01T07:25:14.69115Z","steps":["trace[905251215] 'process raft request' (duration: 129.535522ms)","trace[905251215] 'compare' (duration: 18.236634ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:25:16.811823Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021459161347081,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:25:17.312339Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021459161347081,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:25:17.483556Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.209733214s","expected-duration":"1s"} {"level":"info","ts":"2026-07-01T07:25:17.484051Z","caller":"traceutil/trace.go:171","msg":"trace[1874910337] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"1.210331135s","start":"2026-07-01T07:25:16.27369Z","end":"2026-07-01T07:25:17.484021Z","steps":["trace[1874910337] 'process raft request' (duration: 1.210105781s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:17.484264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.273661Z","time spent":"1.210500698s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-01T07:25:17.677538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.699105ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:25:17.67779Z","caller":"traceutil/trace.go:171","msg":"trace[161270022] linearizableReadLoop","detail":"{readStateIndex:1339; appliedIndex:1336; }","duration":"1.366991385s","start":"2026-07-01T07:25:16.310779Z","end":"2026-07-01T07:25:17.67777Z","steps":["trace[161270022] 'read index received' (duration: 1.173011882s)","trace[161270022] 'applied index is now lower than readState.Index' (duration: 193.978483ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:25:17.677883Z","caller":"traceutil/trace.go:171","msg":"trace[548743458] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"774.713157ms","start":"2026-07-01T07:25:16.90316Z","end":"2026-07-01T07:25:17.677874Z","steps":["trace[548743458] 'process raft request' (duration: 774.514883ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:17.677918Z","caller":"traceutil/trace.go:171","msg":"trace[925367671] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"189.70507ms","start":"2026-07-01T07:25:17.488183Z","end":"2026-07-01T07:25:17.677888Z","steps":["trace[925367671] 'process raft request' (duration: 189.554547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:17.678043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.36727093s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:25:17.677995Z","caller":"traceutil/trace.go:171","msg":"trace[1884276411] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"1.175367868s","start":"2026-07-01T07:25:16.502581Z","end":"2026-07-01T07:25:17.677949Z","steps":["trace[1884276411] 'process raft request' (duration: 1.044158403s)","trace[1884276411] 'compare' (duration: 130.527822ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:25:17.678086Z","caller":"traceutil/trace.go:171","msg":"trace[1237462897] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1284; }","duration":"1.367366162s","start":"2026-07-01T07:25:16.310708Z","end":"2026-07-01T07:25:17.678074Z","steps":["trace[1237462897] 'agreement among raft nodes before linearized reading' (duration: 1.36726557s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:17.678121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.310679Z","time spent":"1.367434783s","remote":"127.0.0.1:48168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" "} {"level":"warn","ts":"2026-07-01T07:25:17.677948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.903136Z","time spent":"774.779669ms","remote":"127.0.0.1:48026","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-07-01T07:25:17.678205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.502553Z","time spent":"1.175545221s","remote":"127.0.0.1:48026","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-07-01T07:25:17.678408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233336372s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T07:25:17.678446Z","caller":"traceutil/trace.go:171","msg":"trace[1000157066] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1284; }","duration":"1.233415103s","start":"2026-07-01T07:25:16.445022Z","end":"2026-07-01T07:25:17.678437Z","steps":["trace[1000157066] 'agreement among raft nodes before linearized reading' (duration: 1.233329682s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:17.678475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.444998Z","time spent":"1.233469634s","remote":"127.0.0.1:48132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":70,"response size":29,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-07-01T07:25:17.678561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.29326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-01T07:25:17.678611Z","caller":"traceutil/trace.go:171","msg":"trace[363093293] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1284; }","duration":"903.375351ms","start":"2026-07-01T07:25:16.775223Z","end":"2026-07-01T07:25:17.678598Z","steps":["trace[363093293] 'agreement among raft nodes before linearized reading' (duration: 903.223389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:17.678653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.775204Z","time spent":"903.440342ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-01T07:25:17.678694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.11056316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-01T07:25:17.6787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.10800476s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-01T07:25:17.67873Z","caller":"traceutil/trace.go:171","msg":"trace[1563896954] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1284; }","duration":"1.110624982s","start":"2026-07-01T07:25:16.568097Z","end":"2026-07-01T07:25:17.678722Z","steps":["trace[1563896954] 'agreement among raft nodes before linearized reading' (duration: 1.110507829s)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:17.67874Z","caller":"traceutil/trace.go:171","msg":"trace[2065315242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1284; }","duration":"1.108067702s","start":"2026-07-01T07:25:16.57066Z","end":"2026-07-01T07:25:17.678728Z","steps":["trace[2065315242] 'agreement among raft nodes before linearized reading' (duration: 1.107926869s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:17.678763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.568084Z","time spent":"1.110673392s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-01T07:25:17.678772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.57065Z","time spent":"1.108115712s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T07:25:17.678841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.120211258s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:25:17.678871Z","caller":"traceutil/trace.go:171","msg":"trace[2074036805] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1284; }","duration":"1.120275458s","start":"2026-07-01T07:25:16.558588Z","end":"2026-07-01T07:25:17.678863Z","steps":["trace[2074036805] 'agreement among raft nodes before linearized reading' (duration: 1.120236648s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:17.67889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.881151ms","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-07-01T07:25:17.678903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.558565Z","time spent":"1.12033032s","remote":"127.0.0.1:47746","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-07-01T07:25:17.678916Z","caller":"traceutil/trace.go:171","msg":"trace[570078391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1284; }","duration":"903.964222ms","start":"2026-07-01T07:25:16.774943Z","end":"2026-07-01T07:25:17.678908Z","steps":["trace[570078391] 'agreement among raft nodes before linearized reading' (duration: 903.891771ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:17.678942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.774922Z","time spent":"904.014644ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T07:25:17.679059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.167151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:25:17.67912Z","caller":"traceutil/trace.go:171","msg":"trace[955256610] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1284; }","duration":"649.272934ms","start":"2026-07-01T07:25:17.02983Z","end":"2026-07-01T07:25:17.679103Z","steps":["trace[955256610] 'agreement among raft nodes before linearized reading' (duration: 649.184861ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:17.679175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:17.029801Z","time spent":"649.360145ms","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-01T07:25:17.679264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.941258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:25:17.679308Z","caller":"traceutil/trace.go:171","msg":"trace[1684292900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1284; }","duration":"715.021859ms","start":"2026-07-01T07:25:16.964275Z","end":"2026-07-01T07:25:17.679297Z","steps":["trace[1684292900] 'agreement among raft nodes before linearized reading' (duration: 714.965848ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:17.679341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.964255Z","time spent":"715.08066ms","remote":"127.0.0.1:47750","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-07-01T07:25:17.679132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.111275ms","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-07-01T07:25:17.679471Z","caller":"traceutil/trace.go:171","msg":"trace[61684959] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1284; }","duration":"941.473981ms","start":"2026-07-01T07:25:16.737979Z","end":"2026-07-01T07:25:17.679453Z","steps":["trace[61684959] 'agreement among raft nodes before linearized reading' (duration: 941.091114ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:17.679535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:16.737964Z","time spent":"941.554542ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-01T07:25:17.884518Z","caller":"traceutil/trace.go:171","msg":"trace[1326962766] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"200.503019ms","start":"2026-07-01T07:25:17.683986Z","end":"2026-07-01T07:25:17.884489Z","steps":["trace[1326962766] 'process raft request' (duration: 200.277455ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:17.900076Z","caller":"traceutil/trace.go:171","msg":"trace[1846729616] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"214.4414ms","start":"2026-07-01T07:25:17.685611Z","end":"2026-07-01T07:25:17.900053Z","steps":["trace[1846729616] 'process raft request' (duration: 214.386279ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:17.900152Z","caller":"traceutil/trace.go:171","msg":"trace[1421962753] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"215.407218ms","start":"2026-07-01T07:25:17.684706Z","end":"2026-07-01T07:25:17.900114Z","steps":["trace[1421962753] 'process raft request' (duration: 215.149453ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:17.900277Z","caller":"traceutil/trace.go:171","msg":"trace[1201770370] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"215.307705ms","start":"2026-07-01T07:25:17.684946Z","end":"2026-07-01T07:25:17.900253Z","steps":["trace[1201770370] 'process raft request' (duration: 215.01976ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:17.900416Z","caller":"traceutil/trace.go:171","msg":"trace[2112394629] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"214.073923ms","start":"2026-07-01T07:25:17.686305Z","end":"2026-07-01T07:25:17.900379Z","steps":["trace[2112394629] 'process raft request' (duration: 213.718595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:18.088555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.71478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:25:18.088634Z","caller":"traceutil/trace.go:171","msg":"trace[124876228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1289; }","duration":"121.834993ms","start":"2026-07-01T07:25:17.966781Z","end":"2026-07-01T07:25:18.088616Z","steps":["trace[124876228] 'range keys from in-memory index tree' (duration: 121.650809ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:19.409622Z","caller":"traceutil/trace.go:171","msg":"trace[497393424] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"335.048118ms","start":"2026-07-01T07:25:19.074547Z","end":"2026-07-01T07:25:19.409595Z","steps":["trace[497393424] 'process raft request' (duration: 334.935286ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:19.409757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:19.074524Z","time spent":"335.173052ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":871,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:25:24.06401Z","caller":"traceutil/trace.go:171","msg":"trace[121328298] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"134.383807ms","start":"2026-07-01T07:25:23.929585Z","end":"2026-07-01T07:25:24.063969Z","steps":["trace[121328298] 'process raft request' (duration: 134.338256ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:24.064088Z","caller":"traceutil/trace.go:171","msg":"trace[1919833420] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"134.486368ms","start":"2026-07-01T07:25:23.929557Z","end":"2026-07-01T07:25:24.064044Z","steps":["trace[1919833420] 'process raft request' (duration: 118.709813ms)","trace[1919833420] 'compare' (duration: 15.541591ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:25:24.066552Z","caller":"traceutil/trace.go:171","msg":"trace[901289272] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"136.891276ms","start":"2026-07-01T07:25:23.929638Z","end":"2026-07-01T07:25:24.06653Z","steps":["trace[901289272] 'process raft request' (duration: 136.726612ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:24.066699Z","caller":"traceutil/trace.go:171","msg":"trace[1435066807] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"136.850304ms","start":"2026-07-01T07:25:23.929819Z","end":"2026-07-01T07:25:24.06667Z","steps":["trace[1435066807] 'process raft request' (duration: 136.650361ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:28.250888Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021459161347206,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:25:28.751906Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021459161347206,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:25:28.929631Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.202811599s","expected-duration":"1s"} {"level":"info","ts":"2026-07-01T07:25:28.929995Z","caller":"traceutil/trace.go:171","msg":"trace[215912712] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"1.203301119s","start":"2026-07-01T07:25:27.726664Z","end":"2026-07-01T07:25:28.929965Z","steps":["trace[215912712] 'process raft request' (duration: 1.203141026s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:28.930156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:27.726636Z","time spent":"1.203436702s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:25:28.969283Z","caller":"traceutil/trace.go:171","msg":"trace[1355400964] linearizableReadLoop","detail":"{readStateIndex:1412; appliedIndex:1411; }","duration":"1.219308299s","start":"2026-07-01T07:25:27.749943Z","end":"2026-07-01T07:25:28.969251Z","steps":["trace[1355400964] 'read index received' (duration: 1.18012936s)","trace[1355400964] 'applied index is now lower than readState.Index' (duration: 39.177609ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:25:28.969501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.219547574s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-07-01T07:25:28.969569Z","caller":"traceutil/trace.go:171","msg":"trace[1805137929] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1354; }","duration":"1.219659586s","start":"2026-07-01T07:25:27.74989Z","end":"2026-07-01T07:25:28.96955Z","steps":["trace[1805137929] 'agreement among raft nodes before linearized reading' (duration: 1.219447532s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:28.969626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:27.749871Z","time spent":"1.219741747s","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-01T07:25:28.969616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.261156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-07-01T07:25:28.969666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"932.100709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T07:25:28.96968Z","caller":"traceutil/trace.go:171","msg":"trace[1414062954] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1354; }","duration":"891.366828ms","start":"2026-07-01T07:25:28.078297Z","end":"2026-07-01T07:25:28.969664Z","steps":["trace[1414062954] 'agreement among raft nodes before linearized reading' (duration: 891.205715ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:28.969736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:28.078275Z","time spent":"891.450251ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-01T07:25:28.969739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.811218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-01T07:25:28.969803Z","caller":"traceutil/trace.go:171","msg":"trace[1490540352] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1354; }","duration":"889.87307ms","start":"2026-07-01T07:25:28.079911Z","end":"2026-07-01T07:25:28.969784Z","steps":["trace[1490540352] 'agreement among raft nodes before linearized reading' (duration: 889.698716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:28.969766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.564976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T07:25:28.969859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:28.079875Z","time spent":"889.973023ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-01T07:25:28.969876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.686633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-01T07:25:28.969895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003218909s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:25:28.969912Z","caller":"traceutil/trace.go:171","msg":"trace[1295283898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1354; }","duration":"894.769355ms","start":"2026-07-01T07:25:28.075134Z","end":"2026-07-01T07:25:28.969903Z","steps":["trace[1295283898] 'agreement among raft nodes before linearized reading' (duration: 894.628612ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:28.969735Z","caller":"traceutil/trace.go:171","msg":"trace[1895003048] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1354; }","duration":"932.21418ms","start":"2026-07-01T07:25:28.037499Z","end":"2026-07-01T07:25:28.969713Z","steps":["trace[1895003048] 'agreement among raft nodes before linearized reading' (duration: 932.077408ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:28.96995Z","caller":"traceutil/trace.go:171","msg":"trace[1149195424] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1354; }","duration":"1.00329326s","start":"2026-07-01T07:25:27.966644Z","end":"2026-07-01T07:25:28.969937Z","steps":["trace[1149195424] 'agreement among raft nodes before linearized reading' (duration: 1.003211989s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:28.969975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:28.037481Z","time spent":"932.479327ms","remote":"127.0.0.1:48220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-07-01T07:25:28.97Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:27.966633Z","time spent":"1.003357011s","remote":"127.0.0.1:47746","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-07-01T07:25:28.969905Z","caller":"traceutil/trace.go:171","msg":"trace[256052573] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1354; }","duration":"255.759881ms","start":"2026-07-01T07:25:28.714106Z","end":"2026-07-01T07:25:28.969866Z","steps":["trace[256052573] 'agreement among raft nodes before linearized reading' (duration: 255.491925ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:28.969484Z","caller":"traceutil/trace.go:171","msg":"trace[1340061579] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"1.041484461s","start":"2026-07-01T07:25:27.927949Z","end":"2026-07-01T07:25:28.969433Z","steps":["trace[1340061579] 'process raft request' (duration: 1.041183605s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:28.96996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:28.075118Z","time spent":"894.834026ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-01T07:25:28.970427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:27.927918Z","time spent":"1.042363198s","remote":"127.0.0.1:48026","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-07-01T07:25:28.970497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.88369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-01T07:25:28.97055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033303582s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-01T07:25:28.970555Z","caller":"traceutil/trace.go:171","msg":"trace[68991665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1354; }","duration":"888.996403ms","start":"2026-07-01T07:25:28.081542Z","end":"2026-07-01T07:25:28.970538Z","steps":["trace[68991665] 'agreement among raft nodes before linearized reading' (duration: 887.993033ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:28.970603Z","caller":"traceutil/trace.go:171","msg":"trace[857726425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1354; }","duration":"1.033384604s","start":"2026-07-01T07:25:27.937204Z","end":"2026-07-01T07:25:28.970588Z","steps":["trace[857726425] 'agreement among raft nodes before linearized reading' (duration: 1.032259561s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:28.97061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:28.081516Z","time spent":"889.082685ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T07:25:28.970638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:27.937168Z","time spent":"1.033461575s","remote":"127.0.0.1:48026","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-07-01T07:25:30.752767Z","caller":"traceutil/trace.go:171","msg":"trace[386075104] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"127.293469ms","start":"2026-07-01T07:25:30.625453Z","end":"2026-07-01T07:25:30.752746Z","steps":["trace[386075104] 'process raft request' (duration: 127.167397ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:31.272015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.540993ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:25:31.272145Z","caller":"traceutil/trace.go:171","msg":"trace[1990237058] linearizableReadLoop","detail":"{readStateIndex:1430; appliedIndex:1429; }","duration":"332.222643ms","start":"2026-07-01T07:25:30.939901Z","end":"2026-07-01T07:25:31.272124Z","steps":["trace[1990237058] 'read index received' (duration: 135.12191ms)","trace[1990237058] 'applied index is now lower than readState.Index' (duration: 197.098753ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:25:31.272275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.479725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T07:25:31.272301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.383297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:25:31.272308Z","caller":"traceutil/trace.go:171","msg":"trace[741977891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1371; }","duration":"306.550476ms","start":"2026-07-01T07:25:30.965748Z","end":"2026-07-01T07:25:31.272299Z","steps":["trace[741977891] 'agreement among raft nodes before linearized reading' (duration: 306.481395ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:31.27243Z","caller":"traceutil/trace.go:171","msg":"trace[356636056] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:0; response_revision:1371; }","duration":"332.555429ms","start":"2026-07-01T07:25:30.939855Z","end":"2026-07-01T07:25:31.27241Z","steps":["trace[356636056] 'agreement among raft nodes before linearized reading' (duration: 332.350655ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:31.272474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.026189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-01T07:25:31.272509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:30.939837Z","time spent":"332.660762ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-07-01T07:25:31.272564Z","caller":"traceutil/trace.go:171","msg":"trace[2023411548] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1371; }","duration":"284.176152ms","start":"2026-07-01T07:25:30.988369Z","end":"2026-07-01T07:25:31.272545Z","steps":["trace[2023411548] 'agreement among raft nodes before linearized reading' (duration: 283.920327ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:31.272563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.879046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-01T07:25:31.272625Z","caller":"traceutil/trace.go:171","msg":"trace[1293239134] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1371; }","duration":"282.945438ms","start":"2026-07-01T07:25:30.989662Z","end":"2026-07-01T07:25:31.272607Z","steps":["trace[1293239134] 'agreement among raft nodes before linearized reading' (duration: 282.842446ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:31.272431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.143101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-01T07:25:31.272768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.774083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-01T07:25:31.272783Z","caller":"traceutil/trace.go:171","msg":"trace[1019910652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1371; }","duration":"283.552109ms","start":"2026-07-01T07:25:30.989222Z","end":"2026-07-01T07:25:31.272774Z","steps":["trace[1019910652] 'agreement among raft nodes before linearized reading' (duration: 283.023079ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:31.272796Z","caller":"traceutil/trace.go:171","msg":"trace[255417013] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1371; }","duration":"283.823404ms","start":"2026-07-01T07:25:30.988964Z","end":"2026-07-01T07:25:31.272787Z","steps":["trace[255417013] 'agreement among raft nodes before linearized reading' (duration: 283.741023ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:31.272802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:30.965735Z","time spent":"307.048335ms","remote":"127.0.0.1:47746","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-07-01T07:25:31.272823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.059036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-01T07:25:31.272832Z","caller":"traceutil/trace.go:171","msg":"trace[1512037063] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"337.065787ms","start":"2026-07-01T07:25:30.935078Z","end":"2026-07-01T07:25:31.272143Z","steps":["trace[1512037063] 'process raft request' (duration: 140.029365ms)","trace[1512037063] 'compare' (duration: 196.214936ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:25:31.272906Z","caller":"traceutil/trace.go:171","msg":"trace[295113947] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1371; }","duration":"290.140797ms","start":"2026-07-01T07:25:30.982749Z","end":"2026-07-01T07:25:31.27289Z","steps":["trace[295113947] 'agreement among raft nodes before linearized reading' (duration: 289.952644ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:31.273069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:25:30.935054Z","time spent":"337.896454ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:25:35.574979Z","caller":"traceutil/trace.go:171","msg":"trace[1485991772] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"144.628435ms","start":"2026-07-01T07:25:35.430316Z","end":"2026-07-01T07:25:35.574944Z","steps":["trace[1485991772] 'process raft request' (duration: 144.515163ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:35.575051Z","caller":"traceutil/trace.go:171","msg":"trace[92729786] transaction","detail":"{read_only:false; response_revision:1401; number_of_response:1; }","duration":"144.711986ms","start":"2026-07-01T07:25:35.43031Z","end":"2026-07-01T07:25:35.575022Z","steps":["trace[92729786] 'process raft request' (duration: 120.288203ms)","trace[92729786] 'compare' (duration: 24.107217ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:25:35.575292Z","caller":"traceutil/trace.go:171","msg":"trace[1570132256] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"144.951971ms","start":"2026-07-01T07:25:35.430317Z","end":"2026-07-01T07:25:35.575269Z","steps":["trace[1570132256] 'process raft request' (duration: 144.575924ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:25:35.57541Z","caller":"traceutil/trace.go:171","msg":"trace[1669429649] linearizableReadLoop","detail":"{readStateIndex:1464; appliedIndex:1460; }","duration":"141.176868ms","start":"2026-07-01T07:25:35.434178Z","end":"2026-07-01T07:25:35.575355Z","steps":["trace[1669429649] 'read index received' (duration: 116.452569ms)","trace[1669429649] 'applied index is now lower than readState.Index' (duration: 24.722889ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:25:35.575537Z","caller":"traceutil/trace.go:171","msg":"trace[760128776] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"144.932011ms","start":"2026-07-01T07:25:35.430595Z","end":"2026-07-01T07:25:35.575527Z","steps":["trace[760128776] 'process raft request' (duration: 144.552344ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:35.575682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.465284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:25:35.575753Z","caller":"traceutil/trace.go:171","msg":"trace[1794419739] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1404; }","duration":"141.572195ms","start":"2026-07-01T07:25:35.434147Z","end":"2026-07-01T07:25:35.575719Z","steps":["trace[1794419739] 'agreement among raft nodes before linearized reading' (duration: 141.439633ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:25:35.575753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-01T07:25:35.575797Z","caller":"traceutil/trace.go:171","msg":"trace[1889801967] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1404; }","duration":"133.551841ms","start":"2026-07-01T07:25:35.442232Z","end":"2026-07-01T07:25:35.575784Z","steps":["trace[1889801967] 'agreement among raft nodes before linearized reading' (duration: 133.382817ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:28:28.903804Z","caller":"traceutil/trace.go:171","msg":"trace[337078165] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"101.437836ms","start":"2026-07-01T07:28:28.802331Z","end":"2026-07-01T07:28:28.903769Z","steps":["trace[337078165] 'process raft request' (duration: 101.249012ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:29:22.623075Z","caller":"traceutil/trace.go:171","msg":"trace[298635523] transaction","detail":"{read_only:false; response_revision:2466; number_of_response:1; }","duration":"302.610916ms","start":"2026-07-01T07:29:22.320421Z","end":"2026-07-01T07:29:22.623032Z","steps":["trace[298635523] 'process raft request' (duration: 302.368592ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:29:22.623352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:29:22.320405Z","time spent":"302.82698ms","remote":"127.0.0.1:48026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:29:22.652769Z","caller":"traceutil/trace.go:171","msg":"trace[1190259526] transaction","detail":"{read_only:false; response_revision:2467; number_of_response:1; }","duration":"274.337239ms","start":"2026-07-01T07:29:22.378359Z","end":"2026-07-01T07:29:22.652696Z","steps":["trace[1190259526] 'process raft request' (duration: 274.090055ms)"],"step_count":1}