{"level":"warn","ts":"2026-04-20T08:10:39.441409Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T08:10:39.44148Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.236: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.236:2380","--initial-cluster=instance=https://199.19.213.236:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.236:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.236:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-20T08:10:39.441536Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T08:10:39.441544Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.236:2380"]} {"level":"info","ts":"2026-04-20T08:10:39.44156Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T08:10:39.442168Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.236:2379"]} {"level":"info","ts":"2026-04-20T08:10:39.442246Z","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.236:2380"],"listen-peer-urls":["https://199.19.213.236:2380"],"advertise-client-urls":["https://199.19.213.236:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.236:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.236:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-20T08:10:39.447132Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.714126ms"} {"level":"info","ts":"2026-04-20T08:10:39.461268Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f20dfa43a2e4607","cluster-id":"85a3671ea9bffea4"} {"level":"info","ts":"2026-04-20T08:10:39.461378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f20dfa43a2e4607 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T08:10:39.46142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f20dfa43a2e4607 became follower at term 0"} {"level":"info","ts":"2026-04-20T08:10:39.461446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f20dfa43a2e4607 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T08:10:39.461465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f20dfa43a2e4607 became follower at term 1"} {"level":"info","ts":"2026-04-20T08:10:39.461523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f20dfa43a2e4607 switched to configuration voters=(6854724529301636615)"} {"level":"warn","ts":"2026-04-20T08:10:39.470257Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T08:10:39.471969Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T08:10:39.473644Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-20T08:10:39.475232Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f20dfa43a2e4607","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T08:10:39.475534Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f20dfa43a2e4607","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T08:10:39.475653Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:10:39.475694Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:10:39.475703Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:10:39.479931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f20dfa43a2e4607 switched to configuration voters=(6854724529301636615)"} {"level":"info","ts":"2026-04-20T08:10:39.480722Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"85a3671ea9bffea4","local-member-id":"5f20dfa43a2e4607","added-peer-id":"5f20dfa43a2e4607","added-peer-peer-urls":["https://199.19.213.236:2380"]} {"level":"info","ts":"2026-04-20T08:10:39.481865Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T08:10:39.482054Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f20dfa43a2e4607","initial-advertise-peer-urls":["https://199.19.213.236:2380"],"listen-peer-urls":["https://199.19.213.236:2380"],"advertise-client-urls":["https://199.19.213.236:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.236:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T08:10:39.482793Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T08:10:39.482867Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.236:2380"} {"level":"info","ts":"2026-04-20T08:10:39.482925Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.236:2380"} {"level":"info","ts":"2026-04-20T08:10:40.262095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f20dfa43a2e4607 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T08:10:40.262158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f20dfa43a2e4607 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T08:10:40.262181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f20dfa43a2e4607 received MsgPreVoteResp from 5f20dfa43a2e4607 at term 1"} {"level":"info","ts":"2026-04-20T08:10:40.26222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f20dfa43a2e4607 became candidate at term 2"} {"level":"info","ts":"2026-04-20T08:10:40.262237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f20dfa43a2e4607 received MsgVoteResp from 5f20dfa43a2e4607 at term 2"} {"level":"info","ts":"2026-04-20T08:10:40.262253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f20dfa43a2e4607 became leader at term 2"} {"level":"info","ts":"2026-04-20T08:10:40.262272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f20dfa43a2e4607 elected leader 5f20dfa43a2e4607 at term 2"} {"level":"info","ts":"2026-04-20T08:10:40.263523Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f20dfa43a2e4607","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.236:2379]}","request-path":"/0/members/5f20dfa43a2e4607/attributes","cluster-id":"85a3671ea9bffea4","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T08:10:40.263882Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:10:40.265093Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:10:40.265645Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:10:40.265993Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T08:10:40.266035Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T08:10:40.266098Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"85a3671ea9bffea4","local-member-id":"5f20dfa43a2e4607","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:10:40.266232Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:10:40.266274Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:10:40.269257Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.236:2379"} {"level":"info","ts":"2026-04-20T08:10:40.269631Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-20T08:10:42.053677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.115746ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-20T08:10:42.054061Z","caller":"traceutil/trace.go:171","msg":"trace[1237409563] linearizableReadLoop","detail":"{readStateIndex:66; appliedIndex:64; }","duration":"216.5966ms","start":"2026-04-20T08:10:41.837446Z","end":"2026-04-20T08:10:42.054043Z","steps":["trace[1237409563] 'read index received' (duration: 4.490511ms)","trace[1237409563] 'applied index is now lower than readState.Index' (duration: 212.105089ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:10:42.053999Z","caller":"traceutil/trace.go:171","msg":"trace[2018479422] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"355.159766ms","start":"2026-04-20T08:10:41.6988Z","end":"2026-04-20T08:10:42.05396Z","steps":["trace[2018479422] 'process raft request' (duration: 105.160362ms)","trace[2018479422] 'compare' (duration: 248.976604ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:10:42.054231Z","caller":"traceutil/trace.go:171","msg":"trace[841998109] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"354.178096ms","start":"2026-04-20T08:10:41.699971Z","end":"2026-04-20T08:10:42.05415Z","steps":["trace[841998109] 'process raft request' (duration: 353.914251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:10:42.054244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:10:41.698781Z","time spent":"355.36423ms","remote":"127.0.0.1:42284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":565,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T08:10:42.05427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.814844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T08:10:42.054359Z","caller":"traceutil/trace.go:171","msg":"trace[486460697] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:62; }","duration":"216.939577ms","start":"2026-04-20T08:10:41.837406Z","end":"2026-04-20T08:10:42.054346Z","steps":["trace[486460697] 'agreement among raft nodes before linearized reading' (duration: 216.714682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:10:42.054842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:10:41.69996Z","time spent":"354.354889ms","remote":"127.0.0.1:42270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1121,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:10:42.32373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.873803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-20T08:10:42.324079Z","caller":"traceutil/trace.go:171","msg":"trace[267239024] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"263.911225ms","start":"2026-04-20T08:10:42.060144Z","end":"2026-04-20T08:10:42.324056Z","steps":["trace[267239024] 'process raft request' (duration: 263.851924ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:10:42.324279Z","caller":"traceutil/trace.go:171","msg":"trace[960056363] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"266.569968ms","start":"2026-04-20T08:10:42.057674Z","end":"2026-04-20T08:10:42.324244Z","steps":["trace[960056363] 'process raft request' (duration: 118.123013ms)","trace[960056363] 'compare' (duration: 147.688739ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:10:42.324536Z","caller":"traceutil/trace.go:171","msg":"trace[1499068183] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"265.272792ms","start":"2026-04-20T08:10:42.059192Z","end":"2026-04-20T08:10:42.324464Z","steps":["trace[1499068183] 'process raft request' (duration: 264.6416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:09.06032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.101342ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:11:09.06084Z","caller":"traceutil/trace.go:171","msg":"trace[427758556] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"194.017873ms","start":"2026-04-20T08:11:08.866778Z","end":"2026-04-20T08:11:09.060796Z","steps":["trace[427758556] 'process raft request' (duration: 193.85366ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:09.060883Z","caller":"traceutil/trace.go:171","msg":"trace[1206539974] transaction","detail":"{read_only:false; number_of_response:0; response_revision:524; }","duration":"192.81973ms","start":"2026-04-20T08:11:08.86802Z","end":"2026-04-20T08:11:09.060839Z","steps":["trace[1206539974] 'process raft request' (duration: 192.666647ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:09.060931Z","caller":"traceutil/trace.go:171","msg":"trace[1342271257] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"191.162425ms","start":"2026-04-20T08:11:08.869701Z","end":"2026-04-20T08:11:09.060864Z","steps":["trace[1342271257] 'process raft request' (duration: 191.018042ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:09.06088Z","caller":"traceutil/trace.go:171","msg":"trace[1181319932] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"199.787361ms","start":"2026-04-20T08:11:08.860984Z","end":"2026-04-20T08:11:09.060772Z","steps":["trace[1181319932] 'process raft request' (duration: 87.139988ms)","trace[1181319932] 'compare' (duration: 111.94567ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:11:09.061082Z","caller":"traceutil/trace.go:171","msg":"trace[1978103552] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"191.055633ms","start":"2026-04-20T08:11:08.870003Z","end":"2026-04-20T08:11:09.061059Z","steps":["trace[1978103552] 'process raft request' (duration: 190.781508ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:09.061215Z","caller":"traceutil/trace.go:171","msg":"trace[818079985] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"179.763874ms","start":"2026-04-20T08:11:08.881436Z","end":"2026-04-20T08:11:09.0612Z","steps":["trace[818079985] 'process raft request' (duration: 179.409487ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:09.061209Z","caller":"traceutil/trace.go:171","msg":"trace[624668315] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:541; }","duration":"191.856121ms","start":"2026-04-20T08:11:08.869333Z","end":"2026-04-20T08:11:09.061189Z","steps":["trace[624668315] 'read index received' (duration: 79.184097ms)","trace[624668315] 'applied index is now lower than readState.Index' (duration: 112.671034ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:11:09.061409Z","caller":"traceutil/trace.go:171","msg":"trace[268953179] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"194.708567ms","start":"2026-04-20T08:11:08.866677Z","end":"2026-04-20T08:11:09.061386Z","steps":["trace[268953179] 'process raft request' (duration: 193.86167ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:09.061339Z","caller":"traceutil/trace.go:171","msg":"trace[1560296090] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"174.610209ms","start":"2026-04-20T08:11:08.886647Z","end":"2026-04-20T08:11:09.061258Z","steps":["trace[1560296090] 'process raft request' (duration: 174.260042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:09.06144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.095605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-04-20T08:11:09.061558Z","caller":"traceutil/trace.go:171","msg":"trace[349544775] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:528; }","duration":"192.242508ms","start":"2026-04-20T08:11:08.8693Z","end":"2026-04-20T08:11:09.061543Z","steps":["trace[349544775] 'agreement among raft nodes before linearized reading' (duration: 191.979633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:10.836944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.15668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:208485"} {"level":"info","ts":"2026-04-20T08:11:10.837032Z","caller":"traceutil/trace.go:171","msg":"trace[300598239] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:583; }","duration":"239.286082ms","start":"2026-04-20T08:11:10.597729Z","end":"2026-04-20T08:11:10.837015Z","steps":["trace[300598239] 'range keys from in-memory index tree' (duration: 238.976156ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:15.95351Z","caller":"traceutil/trace.go:171","msg":"trace[1744943641] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"339.785709ms","start":"2026-04-20T08:11:15.613701Z","end":"2026-04-20T08:11:15.953487Z","steps":["trace[1744943641] 'read index received' (duration: 339.280509ms)","trace[1744943641] 'applied index is now lower than readState.Index' (duration: 504.36µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:11:15.953547Z","caller":"traceutil/trace.go:171","msg":"trace[1651268205] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"437.276296ms","start":"2026-04-20T08:11:15.516255Z","end":"2026-04-20T08:11:15.953532Z","steps":["trace[1651268205] 'process raft request' (duration: 436.766905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:15.953649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:11:15.51623Z","time spent":"437.361608ms","remote":"127.0.0.1:42350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T08:11:15.953893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.145097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-20T08:11:15.953999Z","caller":"traceutil/trace.go:171","msg":"trace[482034587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"340.309649ms","start":"2026-04-20T08:11:15.613669Z","end":"2026-04-20T08:11:15.953979Z","steps":["trace[482034587] 'agreement among raft nodes before linearized reading' (duration: 339.918522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:15.95407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:11:15.613631Z","time spent":"340.429992ms","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T08:11:34.079126Z","caller":"traceutil/trace.go:171","msg":"trace[1809928072] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"117.360519ms","start":"2026-04-20T08:11:33.96174Z","end":"2026-04-20T08:11:34.079101Z","steps":["trace[1809928072] 'process raft request' (duration: 117.185145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:12:08.541989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.297286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-20T08:12:08.542078Z","caller":"traceutil/trace.go:171","msg":"trace[1737183336] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:994; }","duration":"209.446249ms","start":"2026-04-20T08:12:08.332611Z","end":"2026-04-20T08:12:08.542057Z","steps":["trace[1737183336] 'range keys from in-memory index tree' (duration: 209.100371ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:12:08.64857Z","caller":"traceutil/trace.go:171","msg":"trace[1442251492] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"102.402322ms","start":"2026-04-20T08:12:08.546144Z","end":"2026-04-20T08:12:08.648547Z","steps":["trace[1442251492] 'process raft request' (duration: 102.223059ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:12:08.767125Z","caller":"traceutil/trace.go:171","msg":"trace[308689242] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1028; }","duration":"169.261124ms","start":"2026-04-20T08:12:08.597839Z","end":"2026-04-20T08:12:08.7671Z","steps":["trace[308689242] 'read index received' (duration: 50.596154ms)","trace[308689242] 'applied index is now lower than readState.Index' (duration: 118.66346ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:12:08.767363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.510379ms","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-04-20T08:12:08.767424Z","caller":"traceutil/trace.go:171","msg":"trace[271682444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:995; }","duration":"169.611341ms","start":"2026-04-20T08:12:08.597782Z","end":"2026-04-20T08:12:08.767394Z","steps":["trace[271682444] 'agreement among raft nodes before linearized reading' (duration: 169.407307ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:12:43.91099Z","caller":"traceutil/trace.go:171","msg":"trace[1788653970] linearizableReadLoop","detail":"{readStateIndex:1205; appliedIndex:1204; }","duration":"141.698876ms","start":"2026-04-20T08:12:43.769264Z","end":"2026-04-20T08:12:43.910963Z","steps":["trace[1788653970] 'read index received' (duration: 141.483332ms)","trace[1788653970] 'applied index is now lower than readState.Index' (duration: 214.414µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:12:43.91112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.83578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:12:43.911164Z","caller":"traceutil/trace.go:171","msg":"trace[280925187] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1161; }","duration":"141.950692ms","start":"2026-04-20T08:12:43.769199Z","end":"2026-04-20T08:12:43.911149Z","steps":["trace[280925187] 'agreement among raft nodes before linearized reading' (duration: 141.8641ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:12:43.911137Z","caller":"traceutil/trace.go:171","msg":"trace[1677602960] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"256.916438ms","start":"2026-04-20T08:12:43.654167Z","end":"2026-04-20T08:12:43.911084Z","steps":["trace[1677602960] 'process raft request' (duration: 256.612052ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:01.598868Z","caller":"traceutil/trace.go:171","msg":"trace[1753209356] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"215.239127ms","start":"2026-04-20T08:13:01.383601Z","end":"2026-04-20T08:13:01.59884Z","steps":["trace[1753209356] 'process raft request' (duration: 132.330562ms)","trace[1753209356] 'compare' (duration: 82.743572ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:13:01.598914Z","caller":"traceutil/trace.go:171","msg":"trace[752607836] linearizableReadLoop","detail":"{readStateIndex:1289; appliedIndex:1288; }","duration":"202.543455ms","start":"2026-04-20T08:13:01.39633Z","end":"2026-04-20T08:13:01.598873Z","steps":["trace[752607836] 'read index received' (duration: 119.713511ms)","trace[752607836] 'applied index is now lower than readState.Index' (duration: 82.826744ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:13:01.599141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.79435ms","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-04-20T08:13:01.599143Z","caller":"traceutil/trace.go:171","msg":"trace[480313270] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"157.947764ms","start":"2026-04-20T08:13:01.440926Z","end":"2026-04-20T08:13:01.598874Z","steps":["trace[480313270] 'process raft request' (duration: 157.869232ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:01.599195Z","caller":"traceutil/trace.go:171","msg":"trace[542459891] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1243; }","duration":"202.885661ms","start":"2026-04-20T08:13:01.396296Z","end":"2026-04-20T08:13:01.599181Z","steps":["trace[542459891] 'agreement among raft nodes before linearized reading' (duration: 202.801519ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:01.730639Z","caller":"traceutil/trace.go:171","msg":"trace[1317816262] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"123.696401ms","start":"2026-04-20T08:13:01.606917Z","end":"2026-04-20T08:13:01.730614Z","steps":["trace[1317816262] 'read index received' (duration: 109.888875ms)","trace[1317816262] 'applied index is now lower than readState.Index' (duration: 13.806166ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:13:01.730777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.840283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:13:01.730861Z","caller":"traceutil/trace.go:171","msg":"trace[1462293901] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1244; }","duration":"123.925275ms","start":"2026-04-20T08:13:01.606881Z","end":"2026-04-20T08:13:01.730806Z","steps":["trace[1462293901] 'agreement among raft nodes before linearized reading' (duration: 123.827003ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:01.730846Z","caller":"traceutil/trace.go:171","msg":"trace[406241613] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"128.497625ms","start":"2026-04-20T08:13:01.602279Z","end":"2026-04-20T08:13:01.730777Z","steps":["trace[406241613] 'process raft request' (duration: 114.556967ms)","trace[406241613] 'compare' (duration: 13.645122ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:13:13.344634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.264727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:13:13.344704Z","caller":"traceutil/trace.go:171","msg":"trace[70975519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1324; }","duration":"266.39384ms","start":"2026-04-20T08:13:13.078294Z","end":"2026-04-20T08:13:13.344688Z","steps":["trace[70975519] 'range keys from in-memory index tree' (duration: 266.166186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:13.344797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.228387ms","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-04-20T08:13:13.344954Z","caller":"traceutil/trace.go:171","msg":"trace[2088804916] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1324; }","duration":"222.506633ms","start":"2026-04-20T08:13:13.122428Z","end":"2026-04-20T08:13:13.344934Z","steps":["trace[2088804916] 'range keys from in-memory index tree' (duration: 222.209587ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:13.397773Z","caller":"traceutil/trace.go:171","msg":"trace[1464197003] linearizableReadLoop","detail":"{readStateIndex:1374; appliedIndex:1373; }","duration":"275.812348ms","start":"2026-04-20T08:13:13.121938Z","end":"2026-04-20T08:13:13.39775Z","steps":["trace[1464197003] 'read index received' (duration: 275.594984ms)","trace[1464197003] 'applied index is now lower than readState.Index' (duration: 216.644µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:13:13.39787Z","caller":"traceutil/trace.go:171","msg":"trace[1910434838] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"316.570932ms","start":"2026-04-20T08:13:13.081289Z","end":"2026-04-20T08:13:13.39786Z","steps":["trace[1910434838] 'process raft request' (duration: 316.326097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:13.397969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:13:13.081263Z","time spent":"316.633324ms","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:13:13.398103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.31894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.236\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T08:13:13.398173Z","caller":"traceutil/trace.go:171","msg":"trace[1661121661] range","detail":"{range_begin:/registry/masterleases/199.19.213.236; range_end:; response_count:1; response_revision:1325; }","duration":"213.422872ms","start":"2026-04-20T08:13:13.18473Z","end":"2026-04-20T08:13:13.398153Z","steps":["trace[1661121661] 'agreement among raft nodes before linearized reading' (duration: 213.241328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:13:13.398952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.003452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-20T08:13:13.399236Z","caller":"traceutil/trace.go:171","msg":"trace[2073433891] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1325; }","duration":"277.37673ms","start":"2026-04-20T08:13:13.121844Z","end":"2026-04-20T08:13:13.399221Z","steps":["trace[2073433891] 'agreement among raft nodes before linearized reading' (duration: 276.461781ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:16:55.773633Z","caller":"traceutil/trace.go:171","msg":"trace[1631256436] linearizableReadLoop","detail":"{readStateIndex:2480; appliedIndex:2479; }","duration":"170.676856ms","start":"2026-04-20T08:16:55.602939Z","end":"2026-04-20T08:16:55.773616Z","steps":["trace[1631256436] 'read index received' (duration: 170.527583ms)","trace[1631256436] 'applied index is now lower than readState.Index' (duration: 148.353µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:16:55.773685Z","caller":"traceutil/trace.go:171","msg":"trace[2098743801] transaction","detail":"{read_only:false; response_revision:2384; number_of_response:1; }","duration":"171.85593ms","start":"2026-04-20T08:16:55.6018Z","end":"2026-04-20T08:16:55.773656Z","steps":["trace[2098743801] 'process raft request' (duration: 171.663066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:16:55.773812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.857391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-20T08:16:55.773843Z","caller":"traceutil/trace.go:171","msg":"trace[452010385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2384; }","duration":"170.914032ms","start":"2026-04-20T08:16:55.602921Z","end":"2026-04-20T08:16:55.773835Z","steps":["trace[452010385] 'agreement among raft nodes before linearized reading' (duration: 170.793708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:16:55.773961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.954583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-04-20T08:16:55.773978Z","caller":"traceutil/trace.go:171","msg":"trace[1702928630] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:2384; }","duration":"119.001344ms","start":"2026-04-20T08:16:55.65497Z","end":"2026-04-20T08:16:55.773972Z","steps":["trace[1702928630] 'agreement among raft nodes before linearized reading' (duration: 118.949503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:16:55.775158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.39318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:130 size:100144"} {"level":"info","ts":"2026-04-20T08:16:55.775235Z","caller":"traceutil/trace.go:171","msg":"trace[2131876570] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:130; response_revision:2384; }","duration":"165.497892ms","start":"2026-04-20T08:16:55.609719Z","end":"2026-04-20T08:16:55.775217Z","steps":["trace[2131876570] 'agreement among raft nodes before linearized reading' (duration: 164.189936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:16:58.026391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000006519s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-20T08:16:58.026754Z","caller":"traceutil/trace.go:171","msg":"trace[983688451] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000162892s","start":"2026-04-20T08:16:56.026314Z","end":"2026-04-20T08:16:58.026477Z","steps":["trace[983688451] 'agreement among raft nodes before linearized reading' (duration: 2.000032699s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:16:58.026933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:56.026298Z","time spent":"2.000502338s","remote":"127.0.0.1:41770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/20 08:16:58 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T08:17:00.026641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999868075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-20T08:17:00.026729Z","caller":"traceutil/trace.go:171","msg":"trace[1908122644] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000076069s","start":"2026-04-20T08:16:58.026633Z","end":"2026-04-20T08:17:00.026709Z","steps":["trace[1908122644] 'agreement among raft nodes before linearized reading' (duration: 1.999962196s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:00.026779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:58.026615Z","time spent":"2.00015401s","remote":"127.0.0.1:41782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T08:17:01.329916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:56.331167Z","time spent":"4.998739875s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/04/20 08:17:01 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T08:17:01.37376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.99902334s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-20T08:17:01.373857Z","caller":"traceutil/trace.go:171","msg":"trace[321572940] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999191354s","start":"2026-04-20T08:16:56.374645Z","end":"2026-04-20T08:17:01.373837Z","steps":["trace[321572940] 'agreement among raft nodes before linearized reading' (duration: 4.999058171s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:01.373905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:56.374625Z","time spent":"4.999270555s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T08:17:01.375538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999801296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-20T08:17:01.375608Z","caller":"traceutil/trace.go:171","msg":"trace[123408239] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999896957s","start":"2026-04-20T08:16:56.375693Z","end":"2026-04-20T08:17:01.37559Z","steps":["trace[123408239] 'agreement among raft nodes before linearized reading' (duration: 4.999818406s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:01.37568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:56.375683Z","time spent":"4.999982409s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/04/20 08:17:01 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T08:17:02.034466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.0001109s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-20T08:17:02.034548Z","caller":"traceutil/trace.go:171","msg":"trace[1891286027] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000230203s","start":"2026-04-20T08:17:00.0343Z","end":"2026-04-20T08:17:02.03453Z","steps":["trace[1891286027] 'agreement among raft nodes before linearized reading' (duration: 2.000121241s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:02.0346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:17:00.034291Z","time spent":"2.000294784s","remote":"127.0.0.1:41770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T08:17:02.15604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999571752s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-20T08:17:02.156137Z","caller":"traceutil/trace.go:171","msg":"trace[2099209701] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999730005s","start":"2026-04-20T08:16:57.156387Z","end":"2026-04-20T08:17:02.156117Z","steps":["trace[2099209701] 'agreement among raft nodes before linearized reading' (duration: 4.999603073s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:02.156184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:57.156369Z","time spent":"4.999804927s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/04/20 08:17:02 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T08:17:02.778829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:55.777802Z","time spent":"7.000998989s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-04-20T08:17:03.552722Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"7.221402859s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-20T08:17:03.553199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.632166ms","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-04-20T08:17:03.553338Z","caller":"traceutil/trace.go:171","msg":"trace[1112116052] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2384; }","duration":"430.828711ms","start":"2026-04-20T08:17:03.122487Z","end":"2026-04-20T08:17:03.553316Z","steps":["trace[1112116052] 'range keys from in-memory index tree' (duration: 430.615686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.554219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.705674729s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:17:03.554432Z","caller":"traceutil/trace.go:171","msg":"trace[1337596714] linearizableReadLoop","detail":"{readStateIndex:2481; appliedIndex:2480; }","duration":"7.715963826s","start":"2026-04-20T08:16:55.838455Z","end":"2026-04-20T08:17:03.554419Z","steps":["trace[1337596714] 'read index received' (duration: 9.96633ms)","trace[1337596714] 'applied index is now lower than readState.Index' (duration: 7.705996446s)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:17:03.556585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.718118161s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-20T08:17:03.556656Z","caller":"traceutil/trace.go:171","msg":"trace[308903009] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2386; }","duration":"7.718216522s","start":"2026-04-20T08:16:55.83842Z","end":"2026-04-20T08:17:03.556636Z","steps":["trace[308903009] 'agreement among raft nodes before linearized reading' (duration: 7.717291673s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.556755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:55.838406Z","time spent":"7.718320384s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-20T08:17:03.57659Z","caller":"traceutil/trace.go:171","msg":"trace[771680288] transaction","detail":"{read_only:false; response_revision:2387; number_of_response:1; }","duration":"4.19431205s","start":"2026-04-20T08:16:59.382255Z","end":"2026-04-20T08:17:03.576567Z","steps":["trace[771680288] 'process raft request' (duration: 4.194101396s)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:17:03.576661Z","caller":"traceutil/trace.go:171","msg":"trace[2036181220] transaction","detail":"{read_only:false; response_revision:2388; number_of_response:1; }","duration":"3.545826846s","start":"2026-04-20T08:17:00.030778Z","end":"2026-04-20T08:17:03.576605Z","steps":["trace[2036181220] 'process raft request' (duration: 3.545693703s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.577668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.627321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-20T08:17:03.577733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:17:00.030757Z","time spent":"3.546913337s","remote":"127.0.0.1:41852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T08:17:03.577763Z","caller":"traceutil/trace.go:171","msg":"trace[18102787] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2390; }","duration":"199.738033ms","start":"2026-04-20T08:17:03.378012Z","end":"2026-04-20T08:17:03.57775Z","steps":["trace[18102787] 'agreement among raft nodes before linearized reading' (duration: 199.59516ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:17:03.57688Z","caller":"traceutil/trace.go:171","msg":"trace[1722284374] transaction","detail":"{read_only:false; response_revision:2389; number_of_response:1; }","duration":"914.763794ms","start":"2026-04-20T08:17:02.662095Z","end":"2026-04-20T08:17:03.576859Z","steps":["trace[1722284374] 'process raft request' (duration: 914.431388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.577053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.967228347s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:17:03.578228Z","caller":"traceutil/trace.go:171","msg":"trace[934571740] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2390; }","duration":"1.968421191s","start":"2026-04-20T08:17:01.609783Z","end":"2026-04-20T08:17:03.578204Z","steps":["trace[934571740] 'agreement among raft nodes before linearized reading' (duration: 1.967229597s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.578323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:17:01.609768Z","time spent":"1.968537393s","remote":"127.0.0.1:41770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T08:17:03.578208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:17:02.662068Z","time spent":"915.999328ms","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:17:03.57722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.721321345s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-04-20T08:17:03.578595Z","caller":"traceutil/trace.go:171","msg":"trace[1307692626] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:2390; }","duration":"7.722733634s","start":"2026-04-20T08:16:55.855835Z","end":"2026-04-20T08:17:03.578568Z","steps":["trace[1307692626] 'agreement among raft nodes before linearized reading' (duration: 7.721112941s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.57864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:55.855816Z","time spent":"7.722813825s","remote":"127.0.0.1:41992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":774,"request content":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" "} {"level":"warn","ts":"2026-04-20T08:17:03.577312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.245908345s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:550"} {"level":"warn","ts":"2026-04-20T08:17:03.57735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.124767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.236\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-20T08:17:03.577362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.980732068s","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:534"} {"level":"info","ts":"2026-04-20T08:17:03.579225Z","caller":"traceutil/trace.go:171","msg":"trace[240568933] range","detail":"{range_begin:/registry/masterleases/199.19.213.236; range_end:; response_count:1; response_revision:2390; }","duration":"382.022195ms","start":"2026-04-20T08:17:03.197179Z","end":"2026-04-20T08:17:03.579201Z","steps":["trace[240568933] 'agreement among raft nodes before linearized reading' (duration: 380.093326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.577354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.330606ms","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-04-20T08:17:03.57958Z","caller":"traceutil/trace.go:171","msg":"trace[1233097382] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2390; }","duration":"203.561591ms","start":"2026-04-20T08:17:03.375961Z","end":"2026-04-20T08:17:03.579522Z","steps":["trace[1233097382] 'agreement among raft nodes before linearized reading' (duration: 201.163902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.577394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.056615818s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:17:03.579747Z","caller":"traceutil/trace.go:171","msg":"trace[816023687] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:2390; }","duration":"1.059002966s","start":"2026-04-20T08:17:02.520731Z","end":"2026-04-20T08:17:03.579734Z","steps":["trace[816023687] 'agreement among raft nodes before linearized reading' (duration: 1.056641438s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.579792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:17:02.520711Z","time spent":"1.059067627s","remote":"127.0.0.1:42272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-20T08:17:03.577407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.371082488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-04-20T08:17:03.580037Z","caller":"traceutil/trace.go:171","msg":"trace[833494333] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2390; }","duration":"6.373695601s","start":"2026-04-20T08:16:57.206321Z","end":"2026-04-20T08:17:03.580017Z","steps":["trace[833494333] 'agreement among raft nodes before linearized reading' (duration: 6.371052087s)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:17:03.579351Z","caller":"traceutil/trace.go:171","msg":"trace[348942929] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2390; }","duration":"3.982741869s","start":"2026-04-20T08:16:59.59659Z","end":"2026-04-20T08:17:03.579332Z","steps":["trace[348942929] 'agreement among raft nodes before linearized reading' (duration: 3.980734068s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.577429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.542495469s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T08:17:03.577457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.055693123s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-04-20T08:17:03.577465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.956758615s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T08:17:03.577472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.798837892s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-20T08:17:03.577487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.707886113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/kubeadm-certs\" ","response":"range_response_count:1 size:11443"} {"level":"warn","ts":"2026-04-20T08:17:03.577543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.096555441s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-04-20T08:17:03.576719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:59.382232Z","time spent":"4.194417823s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:17:03.577575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.228176288s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T08:17:03.577569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.898146723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T08:17:03.577611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.931763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T08:17:03.579449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:17:03.19716Z","time spent":"382.27259ms","remote":"127.0.0.1:41808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.236\" "} {"level":"info","ts":"2026-04-20T08:17:03.581009Z","caller":"traceutil/trace.go:171","msg":"trace[1298045115] range","detail":"{range_begin:/registry/secrets/kube-system/kubeadm-certs; range_end:; response_count:1; response_revision:2390; }","duration":"7.711366573s","start":"2026-04-20T08:16:55.869581Z","end":"2026-04-20T08:17:03.580948Z","steps":["trace[1298045115] 'agreement among raft nodes before linearized reading' (duration: 7.707885883s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.58106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:55.869575Z","time spent":"7.711466865s","remote":"127.0.0.1:41866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":11466,"request content":"key:\"/registry/secrets/kube-system/kubeadm-certs\" "} {"level":"info","ts":"2026-04-20T08:17:03.581121Z","caller":"traceutil/trace.go:171","msg":"trace[1963956050] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2390; }","duration":"5.100154552s","start":"2026-04-20T08:16:58.480948Z","end":"2026-04-20T08:17:03.581102Z","steps":["trace[1963956050] 'agreement among raft nodes before linearized reading' (duration: 5.09656106s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.581217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:58.480928Z","time spent":"5.100272706s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-20T08:17:03.58125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:59.59657Z","time spent":"3.984668148s","remote":"127.0.0.1:42062","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":"info","ts":"2026-04-20T08:17:03.581331Z","caller":"traceutil/trace.go:171","msg":"trace[431574554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2390; }","duration":"1.546416378s","start":"2026-04-20T08:17:02.034904Z","end":"2026-04-20T08:17:03.58132Z","steps":["trace[431574554] 'agreement among raft nodes before linearized reading' (duration: 1.542508179s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.581357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:17:02.03489Z","time spent":"1.54646082s","remote":"127.0.0.1:41782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T08:17:03.581482Z","caller":"traceutil/trace.go:171","msg":"trace[1910445751] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2390; }","duration":"5.232114758s","start":"2026-04-20T08:16:58.349355Z","end":"2026-04-20T08:17:03.58147Z","steps":["trace[1910445751] 'agreement among raft nodes before linearized reading' (duration: 5.228204979s)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:17:03.581495Z","caller":"traceutil/trace.go:171","msg":"trace[1861882129] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2390; }","duration":"7.059760795s","start":"2026-04-20T08:16:56.521725Z","end":"2026-04-20T08:17:03.581486Z","steps":["trace[1861882129] 'agreement among raft nodes before linearized reading' (duration: 7.055698872s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.581523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:58.349335Z","time spent":"5.232175549s","remote":"127.0.0.1:42120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-20T08:17:03.581531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:56.521704Z","time spent":"7.059818067s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-04-20T08:17:03.581643Z","caller":"traceutil/trace.go:171","msg":"trace[44457259] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2390; }","duration":"1.960971791s","start":"2026-04-20T08:17:01.620662Z","end":"2026-04-20T08:17:03.581634Z","steps":["trace[44457259] 'agreement among raft nodes before linearized reading' (duration: 1.956783566s)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:17:03.581646Z","caller":"traceutil/trace.go:171","msg":"trace[1329701371] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2390; }","duration":"4.902265767s","start":"2026-04-20T08:16:58.679369Z","end":"2026-04-20T08:17:03.581634Z","steps":["trace[1329701371] 'agreement among raft nodes before linearized reading' (duration: 4.898138543s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.581677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:17:01.620634Z","time spent":"1.961031141s","remote":"127.0.0.1:42212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T08:17:03.581683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:58.679351Z","time spent":"4.902321148s","remote":"127.0.0.1:42206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-20T08:17:03.581802Z","caller":"traceutil/trace.go:171","msg":"trace[993798274] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2390; }","duration":"131.121098ms","start":"2026-04-20T08:17:03.450671Z","end":"2026-04-20T08:17:03.581792Z","steps":["trace[993798274] 'agreement among raft nodes before linearized reading' (duration: 126.922753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.580108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:57.206229Z","time spent":"6.373859274s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-20T08:17:03.578787Z","caller":"traceutil/trace.go:171","msg":"trace[451358594] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:2390; }","duration":"2.247405486s","start":"2026-04-20T08:17:01.331353Z","end":"2026-04-20T08:17:03.578759Z","steps":["trace[451358594] 'agreement among raft nodes before linearized reading' (duration: 2.245906455s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.582204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:17:01.331332Z","time spent":"2.250858436s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":573,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-04-20T08:17:03.581804Z","caller":"traceutil/trace.go:171","msg":"trace[581785040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2390; }","duration":"5.803218391s","start":"2026-04-20T08:16:57.778574Z","end":"2026-04-20T08:17:03.581792Z","steps":["trace[581785040] 'agreement among raft nodes before linearized reading' (duration: 5.798797061s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:17:03.582384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:16:57.778544Z","time spent":"5.803828592s","remote":"127.0.0.1:42062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}