{"level":"warn","ts":"2026-06-10T08:30:39.331331Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T08:30:39.331427Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.3:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.3:2380","--initial-cluster=instance=https://199.19.213.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.3: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-06-10T08:30:39.331497Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T08:30:39.331509Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.3:2380"]} {"level":"info","ts":"2026-06-10T08:30:39.331532Z","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-06-10T08:30:39.332178Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"]} {"level":"info","ts":"2026-06-10T08:30:39.332257Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.3:2380"],"listen-peer-urls":["https://199.19.213.3:2380"],"advertise-client-urls":["https://199.19.213.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.3: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-06-10T08:30:39.337015Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.54077ms"} {"level":"info","ts":"2026-06-10T08:30:39.347398Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cf904ec39d3e333","cluster-id":"7b1ae51097bedd0e"} {"level":"info","ts":"2026-06-10T08:30:39.347481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T08:30:39.347506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became follower at term 0"} {"level":"info","ts":"2026-06-10T08:30:39.347524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cf904ec39d3e333 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T08:30:39.34754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became follower at term 1"} {"level":"info","ts":"2026-06-10T08:30:39.347582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=(4393548324105610035)"} {"level":"warn","ts":"2026-06-10T08:30:39.354405Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T08:30:39.355766Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T08:30:39.356799Z","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-06-10T08:30:39.360336Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cf904ec39d3e333","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T08:30:39.360528Z","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-06-10T08:30:39.360658Z","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-06-10T08:30:39.360669Z","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-06-10T08:30:39.360552Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cf904ec39d3e333","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T08:30:39.362366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 switched to configuration voters=(4393548324105610035)"} {"level":"info","ts":"2026-06-10T08:30:39.362579Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7b1ae51097bedd0e","local-member-id":"3cf904ec39d3e333","added-peer-id":"3cf904ec39d3e333","added-peer-peer-urls":["https://199.19.213.3:2380"]} {"level":"info","ts":"2026-06-10T08:30:39.364218Z","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-06-10T08:30:39.364357Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.3:2380"} {"level":"info","ts":"2026-06-10T08:30:39.364401Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.3:2380"} {"level":"info","ts":"2026-06-10T08:30:39.364475Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cf904ec39d3e333","initial-advertise-peer-urls":["https://199.19.213.3:2380"],"listen-peer-urls":["https://199.19.213.3:2380"],"advertise-client-urls":["https://199.19.213.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T08:30:39.364506Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T08:30:39.848235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T08:30:39.848307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T08:30:39.848337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 received MsgPreVoteResp from 3cf904ec39d3e333 at term 1"} {"level":"info","ts":"2026-06-10T08:30:39.848358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became candidate at term 2"} {"level":"info","ts":"2026-06-10T08:30:39.848374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 received MsgVoteResp from 3cf904ec39d3e333 at term 2"} {"level":"info","ts":"2026-06-10T08:30:39.848395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cf904ec39d3e333 became leader at term 2"} {"level":"info","ts":"2026-06-10T08:30:39.848409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cf904ec39d3e333 elected leader 3cf904ec39d3e333 at term 2"} {"level":"info","ts":"2026-06-10T08:30:39.849659Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cf904ec39d3e333","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.3:2379]}","request-path":"/0/members/3cf904ec39d3e333/attributes","cluster-id":"7b1ae51097bedd0e","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T08:30:39.849866Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:30:39.850034Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:30:39.85046Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T08:30:39.850502Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T08:30:39.850482Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:30:39.852643Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7b1ae51097bedd0e","local-member-id":"3cf904ec39d3e333","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:30:39.852756Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:30:39.852805Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:30:39.854523Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T08:30:39.855629Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.3:2379"} {"level":"warn","ts":"2026-06-10T08:30:41.747675Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603551986447231,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:30:42.531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.979619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-10T08:30:42.531157Z","caller":"traceutil/trace.go:171","msg":"trace[1191458527] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.285484908s","start":"2026-06-10T08:30:41.245648Z","end":"2026-06-10T08:30:42.531133Z","steps":["trace[1191458527] 'process raft request' (duration: 690.689167ms)","trace[1191458527] 'compare' (duration: 593.866507ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:30:42.5313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.245629Z","time spent":"1.285594371s","remote":"127.0.0.1:50286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:30:43.678932Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.742576315s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T08:30:43.679692Z","caller":"traceutil/trace.go:171","msg":"trace[1455414018] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:6; }","duration":"2.432082131s","start":"2026-06-10T08:30:41.247586Z","end":"2026-06-10T08:30:43.679668Z","steps":["trace[1455414018] 'read index received' (duration: 688.716535ms)","trace[1455414018] 'applied index is now lower than readState.Index' (duration: 1.743364736s)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:30:43.679778Z","caller":"traceutil/trace.go:171","msg":"trace[1096711761] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"2.433331934s","start":"2026-06-10T08:30:41.246412Z","end":"2026-06-10T08:30:43.679744Z","steps":["trace[1096711761] 'process raft request' (duration: 2.433095377s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:30:43.679881Z","caller":"traceutil/trace.go:171","msg":"trace[1533283524] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"2.433585049s","start":"2026-06-10T08:30:41.246258Z","end":"2026-06-10T08:30:43.679843Z","steps":["trace[1533283524] 'process raft request' (duration: 2.433073286s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:43.679983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.246247Z","time spent":"2.433682962s","remote":"127.0.0.1:50286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:30:43.679987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.246393Z","time spent":"2.433522218s","remote":"127.0.0.1:50286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:30:43.679993Z","caller":"traceutil/trace.go:171","msg":"trace[1612056623] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"2.416686985s","start":"2026-06-10T08:30:41.263288Z","end":"2026-06-10T08:30:43.679975Z","steps":["trace[1612056623] 'process raft request' (duration: 2.416318166s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:43.680103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.263272Z","time spent":"2.416792729s","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:30:43.680132Z","caller":"traceutil/trace.go:171","msg":"trace[543943489] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"2.433740563s","start":"2026-06-10T08:30:41.246377Z","end":"2026-06-10T08:30:43.680117Z","steps":["trace[543943489] 'process raft request' (duration: 2.433088036s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:43.680206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.246353Z","time spent":"2.433811615s","remote":"127.0.0.1:50206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:30:43.68033Z","caller":"traceutil/trace.go:171","msg":"trace[279241971] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"2.415493165s","start":"2026-06-10T08:30:41.264824Z","end":"2026-06-10T08:30:43.680317Z","steps":["trace[279241971] 'process raft request' (duration: 2.414811248s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:43.680346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.432749168s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:30:43.680396Z","caller":"traceutil/trace.go:171","msg":"trace[2138493269] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"2.43282429s","start":"2026-06-10T08:30:41.247555Z","end":"2026-06-10T08:30:43.680379Z","steps":["trace[2138493269] 'agreement among raft nodes before linearized reading' (duration: 2.432685996s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:43.680399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.264808Z","time spent":"2.415560717s","remote":"127.0.0.1:49926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3157,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:30:43.680457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.247523Z","time spent":"2.432912882s","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-06-10T08:30:43.680527Z","caller":"traceutil/trace.go:171","msg":"trace[2104988969] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"2.434040091s","start":"2026-06-10T08:30:41.246434Z","end":"2026-06-10T08:30:43.680474Z","steps":["trace[2104988969] 'process raft request' (duration: 2.433142928s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:43.680685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.246386Z","time spent":"2.434227597s","remote":"127.0.0.1:50286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:30:43.680972Z","caller":"traceutil/trace.go:171","msg":"trace[368197403] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"2.434502604s","start":"2026-06-10T08:30:41.246426Z","end":"2026-06-10T08:30:43.680929Z","steps":["trace[368197403] 'process raft request' (duration: 2.433121647s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:43.68108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.246414Z","time spent":"2.434626527s","remote":"127.0.0.1:50286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:30:44.169359Z","caller":"traceutil/trace.go:171","msg":"trace[1471655024] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"489.550928ms","start":"2026-06-10T08:30:43.679784Z","end":"2026-06-10T08:30:44.169335Z","steps":["trace[1471655024] 'read index received' (duration: 485.489642ms)","trace[1471655024] 'applied index is now lower than readState.Index' (duration: 4.060236ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:30:44.169571Z","caller":"traceutil/trace.go:171","msg":"trace[1107974135] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"1.634373284s","start":"2026-06-10T08:30:42.53515Z","end":"2026-06-10T08:30:44.169524Z","steps":["trace[1107974135] 'process raft request' (duration: 1.630197095s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.169825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.907130458s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:30:44.169885Z","caller":"traceutil/trace.go:171","msg":"trace[600082190] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:12; }","duration":"2.907206541s","start":"2026-06-10T08:30:41.262663Z","end":"2026-06-10T08:30:44.169869Z","steps":["trace[600082190] 'agreement among raft nodes before linearized reading' (duration: 2.907116579s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.169925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.262653Z","time spent":"2.907261562s","remote":"127.0.0.1:50164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-06-10T08:30:44.169632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.024540035s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:30:44.170159Z","caller":"traceutil/trace.go:171","msg":"trace[164688183] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:12; }","duration":"2.025136891s","start":"2026-06-10T08:30:42.144999Z","end":"2026-06-10T08:30:44.170136Z","steps":["trace[164688183] 'agreement among raft nodes before linearized reading' (duration: 2.024456193s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.17022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:42.14497Z","time spent":"2.025232333s","remote":"127.0.0.1:50124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-06-10T08:30:44.169611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.920600007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:30:44.170422Z","caller":"traceutil/trace.go:171","msg":"trace[775075514] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"1.92148083s","start":"2026-06-10T08:30:42.248928Z","end":"2026-06-10T08:30:44.170409Z","steps":["trace[775075514] 'agreement among raft nodes before linearized reading' (duration: 1.920446773s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.170464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:42.24891Z","time spent":"1.921542812s","remote":"127.0.0.1:49728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T08:30:44.169704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.02471808s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:30:44.17062Z","caller":"traceutil/trace.go:171","msg":"trace[351506714] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:12; }","duration":"2.025698335s","start":"2026-06-10T08:30:42.14491Z","end":"2026-06-10T08:30:44.170608Z","steps":["trace[351506714] 'agreement among raft nodes before linearized reading' (duration: 2.02474889s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.170664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:42.14489Z","time spent":"2.025762497s","remote":"127.0.0.1:50136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-06-10T08:30:44.170869Z","caller":"traceutil/trace.go:171","msg":"trace[749198461] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"486.985921ms","start":"2026-06-10T08:30:43.683868Z","end":"2026-06-10T08:30:44.170854Z","steps":["trace[749198461] 'process raft request' (duration: 486.659912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.169714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.198791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-10T08:30:44.169751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.735114014s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-10T08:30:44.169765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.871659858s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:30:44.170929Z","caller":"traceutil/trace.go:171","msg":"trace[515443918] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"2.872855819s","start":"2026-06-10T08:30:41.298065Z","end":"2026-06-10T08:30:44.17092Z","steps":["trace[515443918] 'agreement among raft nodes before linearized reading' (duration: 2.871679748s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.170855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:42.535125Z","time spent":"1.634728333s","remote":"127.0.0.1:50286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:30:44.171051Z","caller":"traceutil/trace.go:171","msg":"trace[868005947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"809.556797ms","start":"2026-06-10T08:30:43.361483Z","end":"2026-06-10T08:30:44.17104Z","steps":["trace[868005947] 'agreement among raft nodes before linearized reading' (duration: 808.183631ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:30:44.171069Z","caller":"traceutil/trace.go:171","msg":"trace[270572989] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"486.897599ms","start":"2026-06-10T08:30:43.684147Z","end":"2026-06-10T08:30:44.171045Z","steps":["trace[270572989] 'process raft request' (duration: 486.540539ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:30:44.171151Z","caller":"traceutil/trace.go:171","msg":"trace[1522527306] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"486.310894ms","start":"2026-06-10T08:30:43.684831Z","end":"2026-06-10T08:30:44.171142Z","steps":["trace[1522527306] 'process raft request' (duration: 486.078838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.171161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:43.683851Z","time spent":"487.270128ms","remote":"127.0.0.1:49840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:30:44.171214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:43.684136Z","time spent":"487.005252ms","remote":"127.0.0.1:49840","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:30:44.171259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:43.684822Z","time spent":"486.364245ms","remote":"127.0.0.1:50286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:30:44.171353Z","caller":"traceutil/trace.go:171","msg":"trace[172129321] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"486.838677ms","start":"2026-06-10T08:30:43.684503Z","end":"2026-06-10T08:30:44.171342Z","steps":["trace[172129321] 'process raft request' (duration: 486.243401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.171414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:43.684493Z","time spent":"486.900539ms","remote":"127.0.0.1:50286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:30:44.170972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.298049Z","time spent":"2.872909311s","remote":"127.0.0.1:49840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-10T08:30:44.17149Z","caller":"traceutil/trace.go:171","msg":"trace[329168108] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"486.732155ms","start":"2026-06-10T08:30:43.684749Z","end":"2026-06-10T08:30:44.171481Z","steps":["trace[329168108] 'process raft request' (duration: 486.125459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.17154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:43.68474Z","time spent":"486.778956ms","remote":"127.0.0.1:50286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:30:44.171567Z","caller":"traceutil/trace.go:171","msg":"trace[1938594469] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"486.708143ms","start":"2026-06-10T08:30:43.684847Z","end":"2026-06-10T08:30:44.171555Z","steps":["trace[1938594469] 'process raft request' (duration: 486.123328ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.171644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:43.684829Z","time spent":"486.785426ms","remote":"127.0.0.1:50286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:30:44.1711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:43.361465Z","time spent":"809.624598ms","remote":"127.0.0.1:49728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T08:30:44.171873Z","caller":"traceutil/trace.go:171","msg":"trace[1203155196] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"482.142123ms","start":"2026-06-10T08:30:43.689718Z","end":"2026-06-10T08:30:44.171861Z","steps":["trace[1203155196] 'process raft request' (duration: 481.356833ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:30:44.172003Z","caller":"traceutil/trace.go:171","msg":"trace[1193962742] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"486.360625ms","start":"2026-06-10T08:30:43.685627Z","end":"2026-06-10T08:30:44.171987Z","steps":["trace[1193962742] 'process raft request' (duration: 485.371989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.171807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.442993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-hklnn\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-06-10T08:30:44.171107Z","caller":"traceutil/trace.go:171","msg":"trace[720617333] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:12; }","duration":"2.73651239s","start":"2026-06-10T08:30:41.434577Z","end":"2026-06-10T08:30:44.17109Z","steps":["trace[720617333] 'agreement among raft nodes before linearized reading' (duration: 2.735148214s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.172142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:41.43455Z","time spent":"2.737570148s","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-06-10T08:30:44.17215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:43.689707Z","time spent":"482.200976ms","remote":"127.0.0.1:49926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3477,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:30:44.172068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:43.685618Z","time spent":"486.422277ms","remote":"127.0.0.1:50206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:30:44.172087Z","caller":"traceutil/trace.go:171","msg":"trace[299441430] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-hklnn; range_end:; response_count:1; response_revision:19; }","duration":"487.764032ms","start":"2026-06-10T08:30:43.684301Z","end":"2026-06-10T08:30:44.172065Z","steps":["trace[299441430] 'agreement among raft nodes before linearized reading' (duration: 486.860218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:44.172618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:30:43.684294Z","time spent":"488.306996ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":883,"request content":"key:\"/registry/certificatesigningrequests/csr-hklnn\" "} {"level":"info","ts":"2026-06-10T08:31:14.998116Z","caller":"traceutil/trace.go:171","msg":"trace[2123146687] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"240.81618ms","start":"2026-06-10T08:31:14.757267Z","end":"2026-06-10T08:31:14.998083Z","steps":["trace[2123146687] 'process raft request' (duration: 240.635175ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:16.873631Z","caller":"traceutil/trace.go:171","msg":"trace[1814106084] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"434.963645ms","start":"2026-06-10T08:31:16.438559Z","end":"2026-06-10T08:31:16.873522Z","steps":["trace[1814106084] 'process raft request' (duration: 434.830172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:16.87382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:16.438549Z","time spent":"435.184802ms","remote":"127.0.0.1:50024","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-06-10T08:31:16.875129Z","caller":"traceutil/trace.go:171","msg":"trace[906984147] linearizableReadLoop","detail":"{readStateIndex:505; appliedIndex:503; }","duration":"247.063774ms","start":"2026-06-10T08:31:16.628028Z","end":"2026-06-10T08:31:16.875092Z","steps":["trace[906984147] 'read index received' (duration: 245.355219ms)","trace[906984147] 'applied index is now lower than readState.Index' (duration: 1.707675ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:31:16.875251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.213938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-10T08:31:16.875296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.521988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:16.875299Z","caller":"traceutil/trace.go:171","msg":"trace[939401281] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:486; }","duration":"247.29606ms","start":"2026-06-10T08:31:16.627989Z","end":"2026-06-10T08:31:16.875285Z","steps":["trace[939401281] 'agreement among raft nodes before linearized reading' (duration: 247.205908ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:16.875334Z","caller":"traceutil/trace.go:171","msg":"trace[147522161] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"148.627711ms","start":"2026-06-10T08:31:16.726696Z","end":"2026-06-10T08:31:16.875324Z","steps":["trace[147522161] 'agreement among raft nodes before linearized reading' (duration: 148.539299ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:16.875334Z","caller":"traceutil/trace.go:171","msg":"trace[986718819] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"435.701025ms","start":"2026-06-10T08:31:16.439601Z","end":"2026-06-10T08:31:16.875302Z","steps":["trace[986718819] 'process raft request' (duration: 435.374077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:16.87549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:16.43958Z","time spent":"435.823559ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:31:19.070862Z","caller":"traceutil/trace.go:171","msg":"trace[2066968399] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:542; }","duration":"187.730027ms","start":"2026-06-10T08:31:18.883114Z","end":"2026-06-10T08:31:19.070844Z","steps":["trace[2066968399] 'read index received' (duration: 74.392672ms)","trace[2066968399] 'applied index is now lower than readState.Index' (duration: 113.336825ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:31:19.070966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.835489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T08:31:19.070984Z","caller":"traceutil/trace.go:171","msg":"trace[1420680833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:525; }","duration":"187.888601ms","start":"2026-06-10T08:31:18.88309Z","end":"2026-06-10T08:31:19.070978Z","steps":["trace[1420680833] 'agreement among raft nodes before linearized reading' (duration: 187.81874ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:19.071197Z","caller":"traceutil/trace.go:171","msg":"trace[2070042981] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"190.038628ms","start":"2026-06-10T08:31:18.881113Z","end":"2026-06-10T08:31:19.071151Z","steps":["trace[2070042981] 'process raft request' (duration: 155.773449ms)","trace[2070042981] 'compare' (duration: 33.870259ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:31:20.174503Z","caller":"traceutil/trace.go:171","msg":"trace[968489567] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"785.474996ms","start":"2026-06-10T08:31:19.388993Z","end":"2026-06-10T08:31:20.174468Z","steps":["trace[968489567] 'process raft request' (duration: 785.309912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:20.174722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.388976Z","time spent":"785.63552ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:31:20.182572Z","caller":"traceutil/trace.go:171","msg":"trace[1802123875] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"789.042208ms","start":"2026-06-10T08:31:19.39352Z","end":"2026-06-10T08:31:20.182562Z","steps":["trace[1802123875] 'process raft request' (duration: 788.883544ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:20.182539Z","caller":"traceutil/trace.go:171","msg":"trace[1330213793] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"791.453421ms","start":"2026-06-10T08:31:19.391061Z","end":"2026-06-10T08:31:20.182514Z","steps":["trace[1330213793] 'process raft request' (duration: 791.208945ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:20.18263Z","caller":"traceutil/trace.go:171","msg":"trace[295873778] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"777.920758ms","start":"2026-06-10T08:31:19.404686Z","end":"2026-06-10T08:31:20.182607Z","steps":["trace[295873778] 'process raft request' (duration: 777.751292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:20.182647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.391041Z","time spent":"791.570076ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:31:20.182677Z","caller":"traceutil/trace.go:171","msg":"trace[593641741] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"774.716024ms","start":"2026-06-10T08:31:19.407939Z","end":"2026-06-10T08:31:20.182655Z","steps":["trace[593641741] 'process raft request' (duration: 774.583719ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:20.182695Z","caller":"traceutil/trace.go:171","msg":"trace[997919198] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"777.788504ms","start":"2026-06-10T08:31:19.404865Z","end":"2026-06-10T08:31:20.182654Z","steps":["trace[997919198] 'process raft request' (duration: 777.624248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:20.182716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.404662Z","time spent":"778.014229ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:31:20.182714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.407929Z","time spent":"774.765885ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:31:20.18275Z","caller":"traceutil/trace.go:171","msg":"trace[1437613969] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"764.590557ms","start":"2026-06-10T08:31:19.41815Z","end":"2026-06-10T08:31:20.182741Z","steps":["trace[1437613969] 'process raft request' (duration: 764.431993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:20.182779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.418131Z","time spent":"764.633858ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:31:20.182786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.404857Z","time spent":"777.885676ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:31:20.182809Z","caller":"traceutil/trace.go:171","msg":"trace[334552565] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"743.009512ms","start":"2026-06-10T08:31:19.439791Z","end":"2026-06-10T08:31:20.1828Z","steps":["trace[334552565] 'process raft request' (duration: 742.885108ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:20.18281Z","caller":"traceutil/trace.go:171","msg":"trace[887894675] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"752.696305ms","start":"2026-06-10T08:31:19.430082Z","end":"2026-06-10T08:31:20.182779Z","steps":["trace[887894675] 'process raft request' (duration: 752.567102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:20.182844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.439766Z","time spent":"743.061142ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:31:20.182868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.430066Z","time spent":"752.776468ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:31:20.182886Z","caller":"traceutil/trace.go:171","msg":"trace[47138119] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"729.661821ms","start":"2026-06-10T08:31:19.453192Z","end":"2026-06-10T08:31:20.182854Z","steps":["trace[47138119] 'process raft request' (duration: 729.539468ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:20.182945Z","caller":"traceutil/trace.go:171","msg":"trace[300242010] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"729.150918ms","start":"2026-06-10T08:31:19.453788Z","end":"2026-06-10T08:31:20.182939Z","steps":["trace[300242010] 'process raft request' (duration: 728.999534ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:20.182923Z","caller":"traceutil/trace.go:171","msg":"trace[2119300001] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:546; }","duration":"455.157766ms","start":"2026-06-10T08:31:19.727748Z","end":"2026-06-10T08:31:20.182906Z","steps":["trace[2119300001] 'read index received' (duration: 446.649323ms)","trace[2119300001] 'applied index is now lower than readState.Index' (duration: 8.507573ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:31:20.182961Z","caller":"traceutil/trace.go:171","msg":"trace[1295334540] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"622.845257ms","start":"2026-06-10T08:31:19.560105Z","end":"2026-06-10T08:31:20.18295Z","steps":["trace[1295334540] 'process raft request' (duration: 622.733525ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:20.182988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.453772Z","time spent":"729.191679ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:31:20.183036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.453167Z","time spent":"729.781224ms","remote":"127.0.0.1:49778","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-06-10T08:31:20.183066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.319541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:20.183101Z","caller":"traceutil/trace.go:171","msg":"trace[1044255307] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:539; }","duration":"455.392993ms","start":"2026-06-10T08:31:19.727697Z","end":"2026-06-10T08:31:20.18309Z","steps":["trace[1044255307] 'agreement among raft nodes before linearized reading' (duration: 455.303761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:20.183077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.560083Z","time spent":"622.94123ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:31:20.183134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.727678Z","time spent":"455.449194ms","remote":"127.0.0.1:49728","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-06-10T08:31:20.182642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:19.39351Z","time spent":"789.0913ms","remote":"127.0.0.1:49778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:31:23.897019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.25619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:23.89715Z","caller":"traceutil/trace.go:171","msg":"trace[1213002118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"172.413904ms","start":"2026-06-10T08:31:23.724695Z","end":"2026-06-10T08:31:23.897109Z","steps":["trace[1213002118] 'range keys from in-memory index tree' (duration: 172.148607ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:26.851765Z","caller":"traceutil/trace.go:171","msg":"trace[783017901] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"375.230537ms","start":"2026-06-10T08:31:26.476507Z","end":"2026-06-10T08:31:26.851738Z","steps":["trace[783017901] 'process raft request' (duration: 374.701814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:26.851919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:26.476481Z","time spent":"375.359651ms","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:31:27.669885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.833011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:31:27.669966Z","caller":"traceutil/trace.go:171","msg":"trace[1170749056] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"660.412584ms","start":"2026-06-10T08:31:27.009535Z","end":"2026-06-10T08:31:27.669947Z","steps":["trace[1170749056] 'read index received' (duration: 102.47287ms)","trace[1170749056] 'applied index is now lower than readState.Index' (duration: 557.938584ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:31:27.670231Z","caller":"traceutil/trace.go:171","msg":"trace[1768400930] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"661.142832ms","start":"2026-06-10T08:31:27.009077Z","end":"2026-06-10T08:31:27.67022Z","steps":["trace[1768400930] 'process raft request' (duration: 102.916261ms)","trace[1768400930] 'compare' (duration: 557.41818ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:31:27.670283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:27.009065Z","time spent":"661.193404ms","remote":"127.0.0.1:50024","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-06-10T08:31:27.670269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.705312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:27.67064Z","caller":"traceutil/trace.go:171","msg":"trace[466671708] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:638; }","duration":"661.110592ms","start":"2026-06-10T08:31:27.009509Z","end":"2026-06-10T08:31:27.67062Z","steps":["trace[466671708] 'agreement among raft nodes before linearized reading' (duration: 660.582178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:27.670733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:27.009495Z","time spent":"661.184965ms","remote":"127.0.0.1:49876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"info","ts":"2026-06-10T08:31:27.827309Z","caller":"traceutil/trace.go:171","msg":"trace[969565276] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"366.13723ms","start":"2026-06-10T08:31:27.461151Z","end":"2026-06-10T08:31:27.827288Z","steps":["trace[969565276] 'process raft request' (duration: 366.073318ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:27.827387Z","caller":"traceutil/trace.go:171","msg":"trace[1632022873] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"811.887998ms","start":"2026-06-10T08:31:27.015474Z","end":"2026-06-10T08:31:27.827362Z","steps":["trace[1632022873] 'process raft request' (duration: 783.264377ms)","trace[1632022873] 'compare' (duration: 28.361875ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:31:27.827461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:27.46112Z","time spent":"366.251063ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:31:27.827471Z","caller":"traceutil/trace.go:171","msg":"trace[1226332900] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:665; }","duration":"157.444172ms","start":"2026-06-10T08:31:27.670007Z","end":"2026-06-10T08:31:27.827451Z","steps":["trace[1226332900] 'read index received' (duration: 128.743339ms)","trace[1226332900] 'applied index is now lower than readState.Index' (duration: 28.699453ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:31:27.827513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:27.01545Z","time spent":"811.989431ms","remote":"127.0.0.1:49932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:31:27.827614Z","caller":"traceutil/trace.go:171","msg":"trace[2021110695] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"154.412294ms","start":"2026-06-10T08:31:27.673196Z","end":"2026-06-10T08:31:27.827608Z","steps":["trace[2021110695] 'process raft request' (duration: 154.068524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:27.827664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.425728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-06-10T08:31:27.827686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.001712ms","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-06-10T08:31:27.827709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.565356ms","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-06-10T08:31:27.827728Z","caller":"traceutil/trace.go:171","msg":"trace[1087935734] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"655.619488ms","start":"2026-06-10T08:31:27.172103Z","end":"2026-06-10T08:31:27.827722Z","steps":["trace[1087935734] 'agreement among raft nodes before linearized reading' (duration: 655.554526ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:27.827724Z","caller":"traceutil/trace.go:171","msg":"trace[242934079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:641; }","duration":"715.51077ms","start":"2026-06-10T08:31:27.112198Z","end":"2026-06-10T08:31:27.827709Z","steps":["trace[242934079] 'agreement among raft nodes before linearized reading' (duration: 715.361107ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:27.827725Z","caller":"traceutil/trace.go:171","msg":"trace[1862786368] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:641; }","duration":"716.077715ms","start":"2026-06-10T08:31:27.111636Z","end":"2026-06-10T08:31:27.827714Z","steps":["trace[1862786368] 'agreement among raft nodes before linearized reading' (duration: 715.925071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:27.827746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:27.172084Z","time spent":"655.658438ms","remote":"127.0.0.1:50024","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-06-10T08:31:27.827758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:27.112188Z","time spent":"715.563942ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:31:27.827762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:27.111621Z","time spent":"716.132837ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T08:31:27.827844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.391195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:27.8279Z","caller":"traceutil/trace.go:171","msg":"trace[211428336] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"100.488398ms","start":"2026-06-10T08:31:27.727397Z","end":"2026-06-10T08:31:27.827886Z","steps":["trace[211428336] 'agreement among raft nodes before linearized reading' (duration: 100.403276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:30.008128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.404072ms","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-06-10T08:31:30.008216Z","caller":"traceutil/trace.go:171","msg":"trace[1401643092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"109.550316ms","start":"2026-06-10T08:31:29.898649Z","end":"2026-06-10T08:31:30.008199Z","steps":["trace[1401643092] 'range keys from in-memory index tree' (duration: 109.295269ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:30.008518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.884595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-06-10T08:31:30.008514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.153359ms","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-06-10T08:31:30.008559Z","caller":"traceutil/trace.go:171","msg":"trace[772669463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"109.925086ms","start":"2026-06-10T08:31:29.898625Z","end":"2026-06-10T08:31:30.00855Z","steps":["trace[772669463] 'range keys from in-memory index tree' (duration: 109.800582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:30.008583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.825246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:30.008602Z","caller":"traceutil/trace.go:171","msg":"trace[252823747] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"140.279332ms","start":"2026-06-10T08:31:29.868297Z","end":"2026-06-10T08:31:30.008577Z","steps":["trace[252823747] 'range keys from in-memory index tree' (duration: 140.053796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:30.008608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.093672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-10T08:31:30.008659Z","caller":"traceutil/trace.go:171","msg":"trace[311445141] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"276.934618ms","start":"2026-06-10T08:31:29.731706Z","end":"2026-06-10T08:31:30.008641Z","steps":["trace[311445141] 'range keys from in-memory index tree' (duration: 276.757844ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:30.00868Z","caller":"traceutil/trace.go:171","msg":"trace[2118660766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"333.207296ms","start":"2026-06-10T08:31:29.675455Z","end":"2026-06-10T08:31:30.008663Z","steps":["trace[2118660766] 'range keys from in-memory index tree' (duration: 332.935549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:30.008743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:29.675436Z","time spent":"333.298157ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T08:31:30.176804Z","caller":"traceutil/trace.go:171","msg":"trace[1811851775] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"163.293485ms","start":"2026-06-10T08:31:30.013488Z","end":"2026-06-10T08:31:30.176781Z","steps":["trace[1811851775] 'process raft request' (duration: 163.116161ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:30.177817Z","caller":"traceutil/trace.go:171","msg":"trace[882829556] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"164.290931ms","start":"2026-06-10T08:31:30.013512Z","end":"2026-06-10T08:31:30.177803Z","steps":["trace[882829556] 'process raft request' (duration: 164.155997ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:30.178279Z","caller":"traceutil/trace.go:171","msg":"trace[1353343522] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"164.466117ms","start":"2026-06-10T08:31:30.013801Z","end":"2026-06-10T08:31:30.178267Z","steps":["trace[1353343522] 'process raft request' (duration: 164.20024ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:30.178861Z","caller":"traceutil/trace.go:171","msg":"trace[1402565722] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"164.554339ms","start":"2026-06-10T08:31:30.013588Z","end":"2026-06-10T08:31:30.178142Z","steps":["trace[1402565722] 'process raft request' (duration: 164.170968ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:35.35286Z","caller":"traceutil/trace.go:171","msg":"trace[777145122] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"154.779331ms","start":"2026-06-10T08:31:35.198049Z","end":"2026-06-10T08:31:35.352828Z","steps":["trace[777145122] 'process raft request' (duration: 153.570209ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:42.588473Z","caller":"traceutil/trace.go:171","msg":"trace[277221967] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"339.913864ms","start":"2026-06-10T08:31:42.248461Z","end":"2026-06-10T08:31:42.588374Z","steps":["trace[277221967] 'process raft request' (duration: 339.799221ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:42.588753Z","caller":"traceutil/trace.go:171","msg":"trace[1271494410] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"338.945928ms","start":"2026-06-10T08:31:42.249779Z","end":"2026-06-10T08:31:42.588725Z","steps":["trace[1271494410] 'process raft request' (duration: 338.562728ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:42.589342Z","caller":"traceutil/trace.go:171","msg":"trace[287564117] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"337.335465ms","start":"2026-06-10T08:31:42.251992Z","end":"2026-06-10T08:31:42.589327Z","steps":["trace[287564117] 'process raft request' (duration: 336.583586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:42.589359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:42.249761Z","time spent":"339.562903ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:31:42.589472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:42.251983Z","time spent":"337.411407ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:31:42.589036Z","caller":"traceutil/trace.go:171","msg":"trace[239269450] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"341.004471ms","start":"2026-06-10T08:31:42.248013Z","end":"2026-06-10T08:31:42.589017Z","steps":["trace[239269450] 'process raft request' (duration: 293.223837ms)","trace[239269450] 'compare' (duration: 46.771187ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:31:42.589774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:42.248438Z","time spent":"340.720774ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:31:42.589796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:42.247994Z","time spent":"341.671479ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:31:45.171409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.237185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:45.17146Z","caller":"traceutil/trace.go:171","msg":"trace[923778356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"443.328978ms","start":"2026-06-10T08:31:44.72812Z","end":"2026-06-10T08:31:45.171449Z","steps":["trace[923778356] 'range keys from in-memory index tree' (duration: 443.164923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:45.171483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:44.728098Z","time spent":"443.380028ms","remote":"127.0.0.1:49728","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-06-10T08:31:45.171532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.438369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-06-10T08:31:45.171579Z","caller":"traceutil/trace.go:171","msg":"trace[306815601] range","detail":"{range_begin:/registry/masterleases/199.19.213.3; range_end:; response_count:1; response_revision:798; }","duration":"218.516852ms","start":"2026-06-10T08:31:44.95305Z","end":"2026-06-10T08:31:45.171567Z","steps":["trace[306815601] 'range keys from in-memory index tree' (duration: 218.282075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:45.673657Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603551986448763,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:31:46.174572Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603551986448763,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:31:46.260756Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.045341584s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T08:31:46.261285Z","caller":"traceutil/trace.go:171","msg":"trace[1154124999] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"1.118652203s","start":"2026-06-10T08:31:45.142611Z","end":"2026-06-10T08:31:46.261263Z","steps":["trace[1154124999] 'process raft request' (duration: 1.118479949s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:46.261437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:45.142581Z","time spent":"1.118775206s","remote":"127.0.0.1:49994","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-06-10T08:31:46.420788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:45.17251Z","time spent":"1.248273598s","remote":"127.0.0.1:49768","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-10T08:31:46.420879Z","caller":"traceutil/trace.go:171","msg":"trace[475260814] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:830; }","duration":"1.247814147s","start":"2026-06-10T08:31:45.172808Z","end":"2026-06-10T08:31:46.420622Z","steps":["trace[475260814] 'read index received' (duration: 1.08856348s)","trace[475260814] 'applied index is now lower than readState.Index' (duration: 159.249657ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:31:46.420931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.248108584s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:31:46.420989Z","caller":"traceutil/trace.go:171","msg":"trace[259650870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"1.248204137s","start":"2026-06-10T08:31:45.172772Z","end":"2026-06-10T08:31:46.420976Z","steps":["trace[259650870] 'agreement among raft nodes before linearized reading' (duration: 1.248093134s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:46.421022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:45.172759Z","time spent":"1.248257098s","remote":"127.0.0.1:49742","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-06-10T08:31:46.421152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.29702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T08:31:46.421189Z","caller":"traceutil/trace.go:171","msg":"trace[784742159] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:800; }","duration":"424.386922ms","start":"2026-06-10T08:31:45.996792Z","end":"2026-06-10T08:31:46.421179Z","steps":["trace[784742159] 'agreement among raft nodes before linearized reading' (duration: 424.199677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:46.421224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:45.996768Z","time spent":"424.448143ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-10T08:31:46.421395Z","caller":"traceutil/trace.go:171","msg":"trace[1405460548] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"889.119565ms","start":"2026-06-10T08:31:45.531687Z","end":"2026-06-10T08:31:46.420806Z","steps":["trace[1405460548] 'process raft request' (duration: 888.833897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:31:46.422328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:31:45.531657Z","time spent":"889.773132ms","remote":"127.0.0.1:50024","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-06-10T08:32:21.813289Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603551986449300,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:32:22.313764Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603551986449300,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:32:22.389158Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.087109161s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T08:32:22.38947Z","caller":"traceutil/trace.go:171","msg":"trace[1025427659] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1063; }","duration":"1.076772141s","start":"2026-06-10T08:32:21.312675Z","end":"2026-06-10T08:32:22.389447Z","steps":["trace[1025427659] 'read index received' (duration: 1.076623367s)","trace[1025427659] 'applied index is now lower than readState.Index' (duration: 147.934µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:32:22.389517Z","caller":"traceutil/trace.go:171","msg":"trace[1449557192] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"1.087578773s","start":"2026-06-10T08:32:21.301907Z","end":"2026-06-10T08:32:22.389486Z","steps":["trace[1449557192] 'process raft request' (duration: 1.087408599s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:22.389656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:21.30188Z","time spent":"1.087703736s","remote":"127.0.0.1:50024","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-06-10T08:32:22.389667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.076979397s","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-06-10T08:32:22.389734Z","caller":"traceutil/trace.go:171","msg":"trace[629790302] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1023; }","duration":"1.07710056s","start":"2026-06-10T08:32:21.312621Z","end":"2026-06-10T08:32:22.389722Z","steps":["trace[629790302] 'agreement among raft nodes before linearized reading' (duration: 1.076934466s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:22.389772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:21.312599Z","time spent":"1.077163061s","remote":"127.0.0.1:50192","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-06-10T08:32:22.389786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.408353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:32:22.389988Z","caller":"traceutil/trace.go:171","msg":"trace[4658471] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1023; }","duration":"482.66562ms","start":"2026-06-10T08:32:21.907313Z","end":"2026-06-10T08:32:22.389978Z","steps":["trace[4658471] 'agreement among raft nodes before linearized reading' (duration: 482.26944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:22.390042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:21.907297Z","time spent":"482.736421ms","remote":"127.0.0.1:49836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":14,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-06-10T08:32:23.500322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.546189ms","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-06-10T08:32:23.500369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.051186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:32:23.500417Z","caller":"traceutil/trace.go:171","msg":"trace[359075970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1023; }","duration":"719.661482ms","start":"2026-06-10T08:32:22.78072Z","end":"2026-06-10T08:32:23.500382Z","steps":["trace[359075970] 'range keys from in-memory index tree' (duration: 719.403425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:23.500407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.618817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:32:23.500441Z","caller":"traceutil/trace.go:171","msg":"trace[1429845336] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1023; }","duration":"628.158668ms","start":"2026-06-10T08:32:22.872263Z","end":"2026-06-10T08:32:23.500422Z","steps":["trace[1429845336] 'count revisions from in-memory index tree' (duration: 627.986894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:23.500463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:22.78071Z","time spent":"719.743904ms","remote":"127.0.0.1:50024","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-06-10T08:32:23.500481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:22.872246Z","time spent":"628.22391ms","remote":"127.0.0.1:50268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-06-10T08:32:23.500483Z","caller":"traceutil/trace.go:171","msg":"trace[35254144] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1023; }","duration":"773.725139ms","start":"2026-06-10T08:32:22.726731Z","end":"2026-06-10T08:32:23.500456Z","steps":["trace[35254144] 'range keys from in-memory index tree' (duration: 773.519455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:23.50048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.41674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-10T08:32:23.500522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:22.726715Z","time spent":"773.800442ms","remote":"127.0.0.1:49728","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-06-10T08:32:23.500536Z","caller":"traceutil/trace.go:171","msg":"trace[1354317534] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1023; }","duration":"867.513803ms","start":"2026-06-10T08:32:22.633008Z","end":"2026-06-10T08:32:23.500522Z","steps":["trace[1354317534] 'range keys from in-memory index tree' (duration: 867.106502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:23.500576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:22.632982Z","time spent":"867.585615ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T08:32:23.500579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.81666ms","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-06-10T08:32:23.500659Z","caller":"traceutil/trace.go:171","msg":"trace[2016277752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1023; }","duration":"718.929893ms","start":"2026-06-10T08:32:22.781711Z","end":"2026-06-10T08:32:23.500641Z","steps":["trace[2016277752] 'range keys from in-memory index tree' (duration: 718.679866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:23.500695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:22.781703Z","time spent":"718.983825ms","remote":"127.0.0.1:50024","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-06-10T08:32:23.500765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.441552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T08:32:23.500788Z","caller":"traceutil/trace.go:171","msg":"trace[1137662710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1023; }","duration":"720.501723ms","start":"2026-06-10T08:32:22.780279Z","end":"2026-06-10T08:32:23.500781Z","steps":["trace[1137662710] 'range keys from in-memory index tree' (duration: 720.311319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:23.500808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:22.78026Z","time spent":"720.541185ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T08:32:23.500917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.478098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T08:32:23.50095Z","caller":"traceutil/trace.go:171","msg":"trace[1669908893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1023; }","duration":"724.552119ms","start":"2026-06-10T08:32:22.776388Z","end":"2026-06-10T08:32:23.50094Z","steps":["trace[1669908893] 'range keys from in-memory index tree' (duration: 724.239171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:23.501002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:22.776365Z","time spent":"724.630222ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-10T08:32:23.872567Z","caller":"traceutil/trace.go:171","msg":"trace[1321316650] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"367.12068ms","start":"2026-06-10T08:32:23.505426Z","end":"2026-06-10T08:32:23.872546Z","steps":["trace[1321316650] 'process raft request' (duration: 367.008778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:23.87271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:23.505407Z","time spent":"367.236984ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:32:23.877627Z","caller":"traceutil/trace.go:171","msg":"trace[846592343] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"370.881048ms","start":"2026-06-10T08:32:23.506724Z","end":"2026-06-10T08:32:23.877605Z","steps":["trace[846592343] 'process raft request' (duration: 370.834087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:23.87782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:23.506494Z","time spent":"371.238478ms","remote":"127.0.0.1:50024","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-06-10T08:32:23.877627Z","caller":"traceutil/trace.go:171","msg":"trace[2087106067] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"371.663458ms","start":"2026-06-10T08:32:23.505932Z","end":"2026-06-10T08:32:23.877596Z","steps":["trace[2087106067] 'process raft request' (duration: 371.429872ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:23.878015Z","caller":"traceutil/trace.go:171","msg":"trace[1536989676] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"371.661219ms","start":"2026-06-10T08:32:23.506335Z","end":"2026-06-10T08:32:23.877997Z","steps":["trace[1536989676] 'process raft request' (duration: 371.156155ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:23.878024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:23.505926Z","time spent":"372.053049ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:32:23.878009Z","caller":"traceutil/trace.go:171","msg":"trace[1521694203] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"371.287829ms","start":"2026-06-10T08:32:23.50668Z","end":"2026-06-10T08:32:23.877968Z","steps":["trace[1521694203] 'process raft request' (duration: 370.846977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:23.878088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:23.506315Z","time spent":"371.741091ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:32:23.87817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:23.506671Z","time spent":"371.409142ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:32:47.865834Z","caller":"traceutil/trace.go:171","msg":"trace[1184152746] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"121.160437ms","start":"2026-06-10T08:32:47.744648Z","end":"2026-06-10T08:32:47.865808Z","steps":["trace[1184152746] 'process raft request' (duration: 120.968142ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:48.101347Z","caller":"traceutil/trace.go:171","msg":"trace[90573906] linearizableReadLoop","detail":"{readStateIndex:1151; appliedIndex:1149; }","duration":"101.847403ms","start":"2026-06-10T08:32:47.999478Z","end":"2026-06-10T08:32:48.101325Z","steps":["trace[90573906] 'read index received' (duration: 21.879832ms)","trace[90573906] 'applied index is now lower than readState.Index' (duration: 79.964151ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:32:48.101453Z","caller":"traceutil/trace.go:171","msg":"trace[168038461] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"105.115788ms","start":"2026-06-10T08:32:47.996326Z","end":"2026-06-10T08:32:48.101442Z","steps":["trace[168038461] 'process raft request' (duration: 60.03865ms)","trace[168038461] 'compare' (duration: 44.864482ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:32:48.101675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.183931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-10T08:32:48.101659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.634771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T08:32:48.101732Z","caller":"traceutil/trace.go:171","msg":"trace[728590930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1105; }","duration":"102.278453ms","start":"2026-06-10T08:32:47.999425Z","end":"2026-06-10T08:32:48.101703Z","steps":["trace[728590930] 'agreement among raft nodes before linearized reading' (duration: 102.15745ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:48.101773Z","caller":"traceutil/trace.go:171","msg":"trace[1073930931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1105; }","duration":"100.785545ms","start":"2026-06-10T08:32:48.000967Z","end":"2026-06-10T08:32:48.101752Z","steps":["trace[1073930931] 'agreement among raft nodes before linearized reading' (duration: 100.565239ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:48.253902Z","caller":"traceutil/trace.go:171","msg":"trace[1296195715] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"146.721365ms","start":"2026-06-10T08:32:48.107157Z","end":"2026-06-10T08:32:48.253879Z","steps":["trace[1296195715] 'process raft request' (duration: 146.676824ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:48.254045Z","caller":"traceutil/trace.go:171","msg":"trace[200728329] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"148.519893ms","start":"2026-06-10T08:32:48.105482Z","end":"2026-06-10T08:32:48.254002Z","steps":["trace[200728329] 'process raft request' (duration: 111.889255ms)","trace[200728329] 'compare' (duration: 36.3504ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:32:49.020104Z","caller":"traceutil/trace.go:171","msg":"trace[2119274616] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"549.563637ms","start":"2026-06-10T08:32:48.470507Z","end":"2026-06-10T08:32:49.020071Z","steps":["trace[2119274616] 'process raft request' (duration: 474.627619ms)","trace[2119274616] 'compare' (duration: 74.502946ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:32:49.021023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:48.470477Z","time spent":"550.376958ms","remote":"127.0.0.1:50024","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-06-10T08:32:51.50632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.13001359s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-10T08:32:51.506426Z","caller":"traceutil/trace.go:171","msg":"trace[1943156213] linearizableReadLoop","detail":"{readStateIndex:1157; appliedIndex:1156; }","duration":"1.480506692s","start":"2026-06-10T08:32:50.0259Z","end":"2026-06-10T08:32:51.506407Z","steps":["trace[1943156213] 'read index received' (duration: 350.658526ms)","trace[1943156213] 'applied index is now lower than readState.Index' (duration: 1.129846606s)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:32:51.507036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.481122598s","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-06-10T08:32:51.50713Z","caller":"traceutil/trace.go:171","msg":"trace[1383660459] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1110; }","duration":"1.481273532s","start":"2026-06-10T08:32:50.025835Z","end":"2026-06-10T08:32:51.507109Z","steps":["trace[1383660459] 'agreement among raft nodes before linearized reading' (duration: 1.481034256s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:51.507178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:50.0258Z","time spent":"1.481368394s","remote":"127.0.0.1:50024","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":"info","ts":"2026-06-10T08:32:51.51326Z","caller":"traceutil/trace.go:171","msg":"trace[1226722246] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"487.630138ms","start":"2026-06-10T08:32:51.025616Z","end":"2026-06-10T08:32:51.513246Z","steps":["trace[1226722246] 'process raft request' (duration: 487.532104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:51.513326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.407501204s","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-06-10T08:32:51.513354Z","caller":"traceutil/trace.go:171","msg":"trace[1286266638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1111; }","duration":"1.407582326s","start":"2026-06-10T08:32:50.105764Z","end":"2026-06-10T08:32:51.513346Z","steps":["trace[1286266638] 'agreement among raft nodes before linearized reading' (duration: 1.407481274s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:51.513356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:51.025595Z","time spent":"487.7027ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:32:51.513379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:50.105745Z","time spent":"1.407628607s","remote":"127.0.0.1:50024","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-06-10T08:32:51.51348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.255025918s","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-06-10T08:32:51.513518Z","caller":"traceutil/trace.go:171","msg":"trace[274955055] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1111; }","duration":"1.25509801s","start":"2026-06-10T08:32:50.25841Z","end":"2026-06-10T08:32:51.513508Z","steps":["trace[274955055] 'agreement among raft nodes before linearized reading' (duration: 1.255026858s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:51.513549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:50.25839Z","time spent":"1.255149441s","remote":"127.0.0.1:50024","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-06-10T08:32:51.513498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.255022618s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-10T08:32:51.513597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.583487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:32:51.513634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.437742ms","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-06-10T08:32:51.513637Z","caller":"traceutil/trace.go:171","msg":"trace[1272431571] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1111; }","duration":"785.671499ms","start":"2026-06-10T08:32:50.727956Z","end":"2026-06-10T08:32:51.513628Z","steps":["trace[1272431571] 'agreement among raft nodes before linearized reading' (duration: 785.617417ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:51.513656Z","caller":"traceutil/trace.go:171","msg":"trace[837328880] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1111; }","duration":"907.495853ms","start":"2026-06-10T08:32:50.606154Z","end":"2026-06-10T08:32:51.51365Z","steps":["trace[837328880] 'agreement among raft nodes before linearized reading' (duration: 907.455162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:51.513663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:50.727932Z","time spent":"785.72418ms","remote":"127.0.0.1:49728","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-06-10T08:32:51.513677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:50.606132Z","time spent":"907.540524ms","remote":"127.0.0.1:50184","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-06-10T08:32:51.513727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.351919541s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T08:32:51.513724Z","caller":"traceutil/trace.go:171","msg":"trace[1856316677] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1111; }","duration":"1.255192582s","start":"2026-06-10T08:32:50.258427Z","end":"2026-06-10T08:32:51.513619Z","steps":["trace[1856316677] 'agreement among raft nodes before linearized reading' (duration: 1.255002388s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:32:51.513786Z","caller":"traceutil/trace.go:171","msg":"trace[1768096487] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1111; }","duration":"1.352129367s","start":"2026-06-10T08:32:50.161647Z","end":"2026-06-10T08:32:51.513776Z","steps":["trace[1768096487] 'agreement among raft nodes before linearized reading' (duration: 1.35185733s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:51.513838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:50.258408Z","time spent":"1.255417088s","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T08:32:51.513856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:50.161627Z","time spent":"1.352221758s","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T08:32:52.060627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.362358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:32:52.060713Z","caller":"traceutil/trace.go:171","msg":"trace[1994062404] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1116; }","duration":"332.494402ms","start":"2026-06-10T08:32:51.728199Z","end":"2026-06-10T08:32:52.060693Z","steps":["trace[1994062404] 'range keys from in-memory index tree' (duration: 332.246696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:32:52.060757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:32:51.728182Z","time spent":"332.565914ms","remote":"127.0.0.1:49728","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-06-10T08:33:08.880031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031831912s","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-06-10T08:33:08.880139Z","caller":"traceutil/trace.go:171","msg":"trace[1705332326] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1219; }","duration":"1.032010717s","start":"2026-06-10T08:33:07.8481Z","end":"2026-06-10T08:33:08.880111Z","steps":["trace[1705332326] 'count revisions from in-memory index tree' (duration: 1.03172175s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:08.880217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:07.84808Z","time spent":"1.03211572s","remote":"127.0.0.1:49876","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":"warn","ts":"2026-06-10T08:33:09.227421Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603551986449784,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:33:09.739652Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603551986449784,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T08:33:09.858209Z","caller":"traceutil/trace.go:171","msg":"trace[1512025063] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"1.651782108s","start":"2026-06-10T08:33:08.206405Z","end":"2026-06-10T08:33:09.858187Z","steps":["trace[1512025063] 'process raft request' (duration: 1.651639785s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:09.85834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:08.206378Z","time spent":"1.651891372s","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:33:09.8604Z","caller":"traceutil/trace.go:171","msg":"trace[35362281] linearizableReadLoop","detail":"{readStateIndex:1273; appliedIndex:1271; }","duration":"1.133187992s","start":"2026-06-10T08:33:08.727193Z","end":"2026-06-10T08:33:09.860381Z","steps":["trace[35362281] 'read index received' (duration: 1.1308317s)","trace[35362281] 'applied index is now lower than readState.Index' (duration: 2.355752ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:33:09.86047Z","caller":"traceutil/trace.go:171","msg":"trace[1898479582] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"275.372738ms","start":"2026-06-10T08:33:09.585092Z","end":"2026-06-10T08:33:09.860465Z","steps":["trace[1898479582] 'process raft request' (duration: 275.224064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:09.860603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.133397447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:33:09.86062Z","caller":"traceutil/trace.go:171","msg":"trace[1841410890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1221; }","duration":"1.133459719s","start":"2026-06-10T08:33:08.727155Z","end":"2026-06-10T08:33:09.860615Z","steps":["trace[1841410890] 'agreement among raft nodes before linearized reading' (duration: 1.133417588s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:09.860635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:08.727137Z","time spent":"1.133493831s","remote":"127.0.0.1:49728","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-06-10T08:33:09.860782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.85161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T08:33:09.86082Z","caller":"traceutil/trace.go:171","msg":"trace[129715492] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1221; }","duration":"257.918112ms","start":"2026-06-10T08:33:09.60289Z","end":"2026-06-10T08:33:09.860808Z","steps":["trace[129715492] 'agreement among raft nodes before linearized reading' (duration: 257.790769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:09.86087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.242134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T08:33:09.860887Z","caller":"traceutil/trace.go:171","msg":"trace[1822648882] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1221; }","duration":"252.286045ms","start":"2026-06-10T08:33:09.608596Z","end":"2026-06-10T08:33:09.860882Z","steps":["trace[1822648882] 'agreement among raft nodes before linearized reading' (duration: 252.211963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:09.860961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.411758ms","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-06-10T08:33:09.860976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.552225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T08:33:09.86098Z","caller":"traceutil/trace.go:171","msg":"trace[628083788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1221; }","duration":"252.463109ms","start":"2026-06-10T08:33:09.608512Z","end":"2026-06-10T08:33:09.860975Z","steps":["trace[628083788] 'agreement among raft nodes before linearized reading' (duration: 252.407178ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:09.860993Z","caller":"traceutil/trace.go:171","msg":"trace[1217792198] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1221; }","duration":"251.589137ms","start":"2026-06-10T08:33:09.6094Z","end":"2026-06-10T08:33:09.860989Z","steps":["trace[1217792198] 'agreement among raft nodes before linearized reading' (duration: 251.546176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:09.861059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.084018ms","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-06-10T08:33:09.86107Z","caller":"traceutil/trace.go:171","msg":"trace[1936440210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1221; }","duration":"255.115159ms","start":"2026-06-10T08:33:09.605951Z","end":"2026-06-10T08:33:09.861066Z","steps":["trace[1936440210] 'agreement among raft nodes before linearized reading' (duration: 255.077668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:26.50893Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603551986449946,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:33:27.010065Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603551986449946,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:33:27.51071Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603551986449946,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:33:27.730352Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.72714949s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-10T08:33:27.826016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.083672059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:33:27.826083Z","caller":"traceutil/trace.go:171","msg":"trace[1761152758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1293; }","duration":"2.083770192s","start":"2026-06-10T08:33:25.742297Z","end":"2026-06-10T08:33:27.826067Z","steps":["trace[1761152758] 'range keys from in-memory index tree' (duration: 2.083610258s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:27.826111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:25.742282Z","time spent":"2.083822103s","remote":"127.0.0.1:49728","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-06-10T08:33:27.825982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.087867048s","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-06-10T08:33:27.826208Z","caller":"traceutil/trace.go:171","msg":"trace[61701684] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1293; }","duration":"2.088111234s","start":"2026-06-10T08:33:25.73809Z","end":"2026-06-10T08:33:27.826201Z","steps":["trace[61701684] 'range keys from in-memory index tree' (duration: 2.087853088s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:27.826469Z","caller":"traceutil/trace.go:171","msg":"trace[1207998301] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"1.823350844s","start":"2026-06-10T08:33:26.003107Z","end":"2026-06-10T08:33:27.826458Z","steps":["trace[1207998301] 'process raft request' (duration: 1.727416606s)","trace[1207998301] 'compare' (duration: 95.283181ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:33:27.826552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:26.003087Z","time spent":"1.823409495s","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":532,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:33:27.826651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.818540898s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T08:33:27.826701Z","caller":"traceutil/trace.go:171","msg":"trace[1418201998] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1294; }","duration":"1.81861267s","start":"2026-06-10T08:33:26.008074Z","end":"2026-06-10T08:33:27.826686Z","steps":["trace[1418201998] 'agreement among raft nodes before linearized reading' (duration: 1.818466946s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:27.826734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:26.008064Z","time spent":"1.818661971s","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T08:33:27.826413Z","caller":"traceutil/trace.go:171","msg":"trace[284437769] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1349; }","duration":"1.818284921s","start":"2026-06-10T08:33:26.008101Z","end":"2026-06-10T08:33:27.826386Z","steps":["trace[284437769] 'read index received' (duration: 1.722349314s)","trace[284437769] 'applied index is now lower than readState.Index' (duration: 95.934187ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:33:27.8278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.816196617s","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-06-10T08:33:27.827839Z","caller":"traceutil/trace.go:171","msg":"trace[1384075001] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1294; }","duration":"1.816280949s","start":"2026-06-10T08:33:26.011545Z","end":"2026-06-10T08:33:27.827826Z","steps":["trace[1384075001] 'agreement among raft nodes before linearized reading' (duration: 1.816108275s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:27.827895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:26.011529Z","time spent":"1.816336051s","remote":"127.0.0.1:50024","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-06-10T08:33:27.828266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.814491642s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T08:33:27.828325Z","caller":"traceutil/trace.go:171","msg":"trace[728983872] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1294; }","duration":"1.814631006s","start":"2026-06-10T08:33:26.01368Z","end":"2026-06-10T08:33:27.828311Z","steps":["trace[728983872] 'agreement among raft nodes before linearized reading' (duration: 1.814494002s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:27.828357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:26.013659Z","time spent":"1.814690498s","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T08:33:27.828373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.813633511s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-10T08:33:27.828278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.814684078s","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-06-10T08:33:27.828439Z","caller":"traceutil/trace.go:171","msg":"trace[385468536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1294; }","duration":"1.813719333s","start":"2026-06-10T08:33:26.014703Z","end":"2026-06-10T08:33:27.828422Z","steps":["trace[385468536] 'agreement among raft nodes before linearized reading' (duration: 1.813506057s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:27.82845Z","caller":"traceutil/trace.go:171","msg":"trace[867822441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1294; }","duration":"1.814867362s","start":"2026-06-10T08:33:26.013571Z","end":"2026-06-10T08:33:27.828438Z","steps":["trace[867822441] 'agreement among raft nodes before linearized reading' (duration: 1.814639036s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:27.828478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:26.014696Z","time spent":"1.813774024s","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T08:33:27.828488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:26.013563Z","time spent":"1.814915313s","remote":"127.0.0.1:50024","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":"info","ts":"2026-06-10T08:33:30.037765Z","caller":"traceutil/trace.go:171","msg":"trace[1602087692] linearizableReadLoop","detail":"{readStateIndex:1357; appliedIndex:1356; }","duration":"152.287231ms","start":"2026-06-10T08:33:29.885449Z","end":"2026-06-10T08:33:30.037737Z","steps":["trace[1602087692] 'read index received' (duration: 152.029424ms)","trace[1602087692] 'applied index is now lower than readState.Index' (duration: 256.677µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:33:30.037932Z","caller":"traceutil/trace.go:171","msg":"trace[582302200] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"204.138726ms","start":"2026-06-10T08:33:29.833759Z","end":"2026-06-10T08:33:30.037898Z","steps":["trace[582302200] 'process raft request' (duration: 203.802976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:30.038213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.750123ms","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-06-10T08:33:30.038272Z","caller":"traceutil/trace.go:171","msg":"trace[311566554] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1301; }","duration":"152.874966ms","start":"2026-06-10T08:33:29.885383Z","end":"2026-06-10T08:33:30.038258Z","steps":["trace[311566554] 'agreement among raft nodes before linearized reading' (duration: 152.699482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:30.038366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.230473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-10T08:33:30.038428Z","caller":"traceutil/trace.go:171","msg":"trace[597637891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1301; }","duration":"112.325316ms","start":"2026-06-10T08:33:29.926089Z","end":"2026-06-10T08:33:30.038414Z","steps":["trace[597637891] 'agreement among raft nodes before linearized reading' (duration: 112.120151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:30.038451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.396318ms","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-06-10T08:33:30.038507Z","caller":"traceutil/trace.go:171","msg":"trace[1306338205] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1301; }","duration":"112.50493ms","start":"2026-06-10T08:33:29.925989Z","end":"2026-06-10T08:33:30.038494Z","steps":["trace[1306338205] 'agreement among raft nodes before linearized reading' (duration: 112.381137ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:30.038562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.342857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-10T08:33:30.038583Z","caller":"traceutil/trace.go:171","msg":"trace[53871269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1301; }","duration":"112.378867ms","start":"2026-06-10T08:33:29.926197Z","end":"2026-06-10T08:33:30.038576Z","steps":["trace[53871269] 'agreement among raft nodes before linearized reading' (duration: 112.324726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:30.038525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.536862ms","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-06-10T08:33:30.038721Z","caller":"traceutil/trace.go:171","msg":"trace[798027363] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1301; }","duration":"112.8488ms","start":"2026-06-10T08:33:29.925854Z","end":"2026-06-10T08:33:30.038702Z","steps":["trace[798027363] 'agreement among raft nodes before linearized reading' (duration: 112.325786ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:30.183753Z","caller":"traceutil/trace.go:171","msg":"trace[1342851675] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"141.312215ms","start":"2026-06-10T08:33:30.042408Z","end":"2026-06-10T08:33:30.18372Z","steps":["trace[1342851675] 'process raft request' (duration: 64.928337ms)","trace[1342851675] 'compare' (duration: 76.213433ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:33:30.220935Z","caller":"traceutil/trace.go:171","msg":"trace[505093860] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"177.594894ms","start":"2026-06-10T08:33:30.043307Z","end":"2026-06-10T08:33:30.220902Z","steps":["trace[505093860] 'process raft request' (duration: 177.219594ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:30.220957Z","caller":"traceutil/trace.go:171","msg":"trace[1569168173] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"177.418098ms","start":"2026-06-10T08:33:30.043504Z","end":"2026-06-10T08:33:30.220922Z","steps":["trace[1569168173] 'process raft request' (duration: 177.055539ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:30.221007Z","caller":"traceutil/trace.go:171","msg":"trace[1930054026] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"177.400697ms","start":"2026-06-10T08:33:30.043561Z","end":"2026-06-10T08:33:30.220962Z","steps":["trace[1930054026] 'process raft request' (duration: 177.032478ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:30.221503Z","caller":"traceutil/trace.go:171","msg":"trace[2093982303] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"178.153687ms","start":"2026-06-10T08:33:30.042978Z","end":"2026-06-10T08:33:30.221132Z","steps":["trace[2093982303] 'process raft request' (duration: 177.438359ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:31.282161Z","caller":"traceutil/trace.go:171","msg":"trace[1660780701] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"338.92306ms","start":"2026-06-10T08:33:30.943213Z","end":"2026-06-10T08:33:31.282136Z","steps":["trace[1660780701] 'process raft request' (duration: 338.766436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:31.282479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:30.943191Z","time spent":"339.044173ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:33:31.648165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.088676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:33:31.648243Z","caller":"traceutil/trace.go:171","msg":"trace[1069573166] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1309; }","duration":"113.218399ms","start":"2026-06-10T08:33:31.535007Z","end":"2026-06-10T08:33:31.648225Z","steps":["trace[1069573166] 'count revisions from in-memory index tree' (duration: 112.990534ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:31.964056Z","caller":"traceutil/trace.go:171","msg":"trace[1456923293] linearizableReadLoop","detail":"{readStateIndex:1367; appliedIndex:1366; }","duration":"238.068813ms","start":"2026-06-10T08:33:31.725964Z","end":"2026-06-10T08:33:31.964033Z","steps":["trace[1456923293] 'read index received' (duration: 237.906459ms)","trace[1456923293] 'applied index is now lower than readState.Index' (duration: 161.394µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:33:31.964222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.243528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:33:31.964292Z","caller":"traceutil/trace.go:171","msg":"trace[1011938919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1310; }","duration":"238.34329ms","start":"2026-06-10T08:33:31.725937Z","end":"2026-06-10T08:33:31.964281Z","steps":["trace[1011938919] 'agreement among raft nodes before linearized reading' (duration: 238.179106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:31.964234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.550684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:33:31.964455Z","caller":"traceutil/trace.go:171","msg":"trace[493820412] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1310; }","duration":"158.77687ms","start":"2026-06-10T08:33:31.805604Z","end":"2026-06-10T08:33:31.964381Z","steps":["trace[493820412] 'agreement among raft nodes before linearized reading' (duration: 158.561964ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:31.964094Z","caller":"traceutil/trace.go:171","msg":"trace[248531776] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"241.412411ms","start":"2026-06-10T08:33:31.722652Z","end":"2026-06-10T08:33:31.964065Z","steps":["trace[248531776] 'process raft request' (duration: 241.246096ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:36.209264Z","caller":"traceutil/trace.go:171","msg":"trace[231642875] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"149.381294ms","start":"2026-06-10T08:33:36.059857Z","end":"2026-06-10T08:33:36.209238Z","steps":["trace[231642875] 'process raft request' (duration: 149.140668ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:39.397834Z","caller":"traceutil/trace.go:171","msg":"trace[328780786] linearizableReadLoop","detail":"{readStateIndex:1434; appliedIndex:1433; }","duration":"214.927839ms","start":"2026-06-10T08:33:39.182876Z","end":"2026-06-10T08:33:39.397804Z","steps":["trace[328780786] 'read index received' (duration: 214.744814ms)","trace[328780786] 'applied index is now lower than readState.Index' (duration: 181.705µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:33:39.397915Z","caller":"traceutil/trace.go:171","msg":"trace[772083938] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"366.279555ms","start":"2026-06-10T08:33:39.031585Z","end":"2026-06-10T08:33:39.397864Z","steps":["trace[772083938] 'process raft request' (duration: 366.010178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:39.397994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.101273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:33:39.39805Z","caller":"traceutil/trace.go:171","msg":"trace[218429479] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1376; }","duration":"215.219217ms","start":"2026-06-10T08:33:39.182818Z","end":"2026-06-10T08:33:39.398037Z","steps":["trace[218429479] 'agreement among raft nodes before linearized reading' (duration: 215.102594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:39.398078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:39.031564Z","time spent":"366.429319ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:33:40.728413Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16371603551986450099,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:33:41.0993Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.037250724s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T08:33:41.10243Z","caller":"traceutil/trace.go:171","msg":"trace[1192073132] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"881.371609ms","start":"2026-06-10T08:33:40.221034Z","end":"2026-06-10T08:33:41.102406Z","steps":["trace[1192073132] 'process raft request' (duration: 881.116233ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:33:41.102593Z","caller":"traceutil/trace.go:171","msg":"trace[440263130] linearizableReadLoop","detail":"{readStateIndex:1437; appliedIndex:1434; }","duration":"874.895491ms","start":"2026-06-10T08:33:40.227678Z","end":"2026-06-10T08:33:41.102573Z","steps":["trace[440263130] 'read index received' (duration: 871.862241ms)","trace[440263130] 'applied index is now lower than readState.Index' (duration: 3.0324ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:33:41.102661Z","caller":"traceutil/trace.go:171","msg":"trace[1482904395] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"575.920445ms","start":"2026-06-10T08:33:40.526731Z","end":"2026-06-10T08:33:41.102652Z","steps":["trace[1482904395] 'process raft request' (duration: 575.629567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:41.102722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:40.221006Z","time spent":"881.498053ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:33:41.102746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:40.526707Z","time spent":"575.971446ms","remote":"127.0.0.1:50024","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-06-10T08:33:41.102909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.236119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-10T08:33:41.102935Z","caller":"traceutil/trace.go:171","msg":"trace[1056137096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1378; }","duration":"875.290671ms","start":"2026-06-10T08:33:40.227638Z","end":"2026-06-10T08:33:41.102929Z","steps":["trace[1056137096] 'agreement among raft nodes before linearized reading' (duration: 875.183918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:41.102955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:40.227626Z","time spent":"875.323921ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T08:33:41.103051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.3023ms","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-06-10T08:33:41.103071Z","caller":"traceutil/trace.go:171","msg":"trace[440851034] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1378; }","duration":"839.33907ms","start":"2026-06-10T08:33:40.263727Z","end":"2026-06-10T08:33:41.103066Z","steps":["trace[440851034] 'agreement among raft nodes before linearized reading' (duration: 839.283149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:41.103088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:40.26372Z","time spent":"839.363631ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T08:33:41.10309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.836775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:33:41.103151Z","caller":"traceutil/trace.go:171","msg":"trace[1934439963] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1378; }","duration":"375.934477ms","start":"2026-06-10T08:33:40.727206Z","end":"2026-06-10T08:33:41.103141Z","steps":["trace[1934439963] 'agreement among raft nodes before linearized reading' (duration: 375.848945ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:41.103138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.740487ms","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-06-10T08:33:41.103178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:40.72719Z","time spent":"375.983088ms","remote":"127.0.0.1:49728","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-06-10T08:33:41.1032Z","caller":"traceutil/trace.go:171","msg":"trace[1676102105] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1378; }","duration":"835.837319ms","start":"2026-06-10T08:33:40.267347Z","end":"2026-06-10T08:33:41.103184Z","steps":["trace[1676102105] 'agreement among raft nodes before linearized reading' (duration: 835.660665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:41.103232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:40.267335Z","time spent":"835.89104ms","remote":"127.0.0.1:50024","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-06-10T08:33:41.103434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.183694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-10T08:33:41.103496Z","caller":"traceutil/trace.go:171","msg":"trace[1659070837] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1378; }","duration":"775.285107ms","start":"2026-06-10T08:33:40.328195Z","end":"2026-06-10T08:33:41.10348Z","steps":["trace[1659070837] 'agreement among raft nodes before linearized reading' (duration: 774.915196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:41.103568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:40.328177Z","time spent":"775.379279ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-10T08:33:41.104125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.077543ms","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-06-10T08:33:41.104216Z","caller":"traceutil/trace.go:171","msg":"trace[1483889267] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1378; }","duration":"842.173495ms","start":"2026-06-10T08:33:40.262014Z","end":"2026-06-10T08:33:41.104188Z","steps":["trace[1483889267] 'agreement among raft nodes before linearized reading' (duration: 840.86344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:41.104267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:40.261966Z","time spent":"842.290998ms","remote":"127.0.0.1:50024","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-06-10T08:33:41.104359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.608914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-10T08:33:41.104454Z","caller":"traceutil/trace.go:171","msg":"trace[50917865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1378; }","duration":"841.119578ms","start":"2026-06-10T08:33:40.263322Z","end":"2026-06-10T08:33:41.104442Z","steps":["trace[50917865] 'agreement among raft nodes before linearized reading' (duration: 839.756502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:33:41.104583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:33:40.263312Z","time spent":"841.262241ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T08:35:21.901061Z","caller":"traceutil/trace.go:171","msg":"trace[1528846982] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"200.373703ms","start":"2026-06-10T08:35:21.700663Z","end":"2026-06-10T08:35:21.901037Z","steps":["trace[1528846982] 'process raft request' (duration: 136.313383ms)","trace[1528846982] 'compare' (duration: 63.896716ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:35:21.901392Z","caller":"traceutil/trace.go:171","msg":"trace[1301060095] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1920; }","duration":"173.248166ms","start":"2026-06-10T08:35:21.728134Z","end":"2026-06-10T08:35:21.901382Z","steps":["trace[1301060095] 'read index received' (duration: 23.858372ms)","trace[1301060095] 'applied index is now lower than readState.Index' (duration: 149.389094ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:35:21.901493Z","caller":"traceutil/trace.go:171","msg":"trace[1287283609] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"200.715762ms","start":"2026-06-10T08:35:21.700766Z","end":"2026-06-10T08:35:21.901482Z","steps":["trace[1287283609] 'process raft request' (duration: 200.238529ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:35:21.901561Z","caller":"traceutil/trace.go:171","msg":"trace[1607363405] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"200.3259ms","start":"2026-06-10T08:35:21.701228Z","end":"2026-06-10T08:35:21.901554Z","steps":["trace[1607363405] 'process raft request' (duration: 200.094685ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:35:21.901732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.583424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:35:21.901995Z","caller":"traceutil/trace.go:171","msg":"trace[312971212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1844; }","duration":"173.707158ms","start":"2026-06-10T08:35:21.728084Z","end":"2026-06-10T08:35:21.901791Z","steps":["trace[312971212] 'agreement among raft nodes before linearized reading' (duration: 173.539633ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:35:22.490843Z","caller":"traceutil/trace.go:171","msg":"trace[748940514] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"129.30262ms","start":"2026-06-10T08:35:22.361515Z","end":"2026-06-10T08:35:22.490817Z","steps":["trace[748940514] 'process raft request' (duration: 129.133256ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:35:38.166712Z","caller":"traceutil/trace.go:171","msg":"trace[1341805424] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"161.206871ms","start":"2026-06-10T08:35:38.005448Z","end":"2026-06-10T08:35:38.166655Z","steps":["trace[1341805424] 'process raft request' (duration: 160.838232ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:35:38.390118Z","caller":"traceutil/trace.go:171","msg":"trace[1033729790] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"384.379978ms","start":"2026-06-10T08:35:38.005665Z","end":"2026-06-10T08:35:38.390045Z","steps":["trace[1033729790] 'process raft request' (duration: 317.372062ms)","trace[1033729790] 'compare' (duration: 66.833142ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:35:38.390214Z","caller":"traceutil/trace.go:171","msg":"trace[1454427834] linearizableReadLoop","detail":"{readStateIndex:2002; appliedIndex:1999; }","duration":"346.392779ms","start":"2026-06-10T08:35:38.043781Z","end":"2026-06-10T08:35:38.390174Z","steps":["trace[1454427834] 'read index received' (duration: 122.636717ms)","trace[1454427834] 'applied index is now lower than readState.Index' (duration: 223.754302ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:35:38.390306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:35:38.00564Z","time spent":"384.578434ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:35:38.390337Z","caller":"traceutil/trace.go:171","msg":"trace[1922273221] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"383.813054ms","start":"2026-06-10T08:35:38.006488Z","end":"2026-06-10T08:35:38.390301Z","steps":["trace[1922273221] 'process raft request' (duration: 383.512636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:35:38.390408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.618365ms","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:531"} {"level":"info","ts":"2026-06-10T08:35:38.390452Z","caller":"traceutil/trace.go:171","msg":"trace[1692757141] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1920; }","duration":"346.710917ms","start":"2026-06-10T08:35:38.043731Z","end":"2026-06-10T08:35:38.390442Z","steps":["trace[1692757141] 'agreement among raft nodes before linearized reading' (duration: 346.542503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:35:38.390472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:35:38.006474Z","time spent":"383.924037ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:35:38.390538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:35:38.04371Z","time spent":"346.767509ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-06-10T08:35:40.123732Z","caller":"traceutil/trace.go:171","msg":"trace[1561898651] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"114.34596ms","start":"2026-06-10T08:35:40.009361Z","end":"2026-06-10T08:35:40.123707Z","steps":["trace[1561898651] 'process raft request' (duration: 55.334762ms)","trace[1561898651] 'compare' (duration: 58.904796ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:35:40.418944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.76267ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-10T08:35:40.419092Z","caller":"traceutil/trace.go:171","msg":"trace[593764015] linearizableReadLoop","detail":"{readStateIndex:2010; appliedIndex:2009; }","duration":"177.342552ms","start":"2026-06-10T08:35:40.241699Z","end":"2026-06-10T08:35:40.419042Z","steps":["trace[593764015] 'read index received' (duration: 36.811µs)","trace[593764015] 'applied index is now lower than readState.Index' (duration: 177.304331ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:35:40.419236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.541167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:35:40.419274Z","caller":"traceutil/trace.go:171","msg":"trace[165080902] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1927; }","duration":"177.621659ms","start":"2026-06-10T08:35:40.24164Z","end":"2026-06-10T08:35:40.419262Z","steps":["trace[165080902] 'agreement among raft nodes before linearized reading' (duration: 177.540247ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:35:40.591667Z","caller":"traceutil/trace.go:171","msg":"trace[2053242618] linearizableReadLoop","detail":"{readStateIndex:2012; appliedIndex:2010; }","duration":"144.726293ms","start":"2026-06-10T08:35:40.446917Z","end":"2026-06-10T08:35:40.591644Z","steps":["trace[2053242618] 'read index received' (duration: 55.98923ms)","trace[2053242618] 'applied index is now lower than readState.Index' (duration: 88.736153ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:35:40.591932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.977309ms","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:531"} {"level":"info","ts":"2026-06-10T08:35:40.591986Z","caller":"traceutil/trace.go:171","msg":"trace[378588968] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1929; }","duration":"145.093052ms","start":"2026-06-10T08:35:40.446879Z","end":"2026-06-10T08:35:40.591972Z","steps":["trace[378588968] 'agreement among raft nodes before linearized reading' (duration: 144.853366ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:35:40.592209Z","caller":"traceutil/trace.go:171","msg":"trace[188502919] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"168.306447ms","start":"2026-06-10T08:35:40.423806Z","end":"2026-06-10T08:35:40.592113Z","steps":["trace[188502919] 'process raft request' (duration: 130.018299ms)","trace[188502919] 'compare' (duration: 37.682142ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:37:28.413107Z","caller":"traceutil/trace.go:171","msg":"trace[321899820] linearizableReadLoop","detail":"{readStateIndex:2549; appliedIndex:2548; }","duration":"103.676358ms","start":"2026-06-10T08:37:28.309409Z","end":"2026-06-10T08:37:28.413085Z","steps":["trace[321899820] 'read index received' (duration: 103.468982ms)","trace[321899820] 'applied index is now lower than readState.Index' (duration: 206.536µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:37:28.413259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.821002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:37:28.413306Z","caller":"traceutil/trace.go:171","msg":"trace[1758301421] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:2444; }","duration":"103.913605ms","start":"2026-06-10T08:37:28.309377Z","end":"2026-06-10T08:37:28.413291Z","steps":["trace[1758301421] 'agreement among raft nodes before linearized reading' (duration: 103.805122ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:37:28.413587Z","caller":"traceutil/trace.go:171","msg":"trace[425273832] transaction","detail":"{read_only:false; response_revision:2444; number_of_response:1; }","duration":"421.632568ms","start":"2026-06-10T08:37:27.991916Z","end":"2026-06-10T08:37:28.413549Z","steps":["trace[425273832] 'process raft request' (duration: 421.042482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:37:28.41378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:37:27.991882Z","time spent":"421.770122ms","remote":"127.0.0.1:50024","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-06-10T08:37:38.129556Z","caller":"traceutil/trace.go:171","msg":"trace[288218946] transaction","detail":"{read_only:false; response_revision:2495; number_of_response:1; }","duration":"375.338408ms","start":"2026-06-10T08:37:37.754185Z","end":"2026-06-10T08:37:38.129523Z","steps":["trace[288218946] 'process raft request' (duration: 375.04767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:37:38.129785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:37:37.754122Z","time spent":"375.523483ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure: >"}