{"level":"warn","ts":"2026-05-19T13:13:22.927024Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T13:13:22.92712Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-19T13:13:22.927199Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T13:13:22.927211Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-05-19T13:13:22.927228Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-19T13:13:22.927983Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-05-19T13:13:22.928053Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-19T13:13:22.934665Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.39546ms"} {"level":"info","ts":"2026-05-19T13:13:22.940201Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-05-19T13:13:22.940282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T13:13:22.940308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-05-19T13:13:22.940321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T13:13:22.940351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-05-19T13:13:22.940405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-05-19T13:13:22.947486Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T13:13:22.949948Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T13:13:22.952421Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-19T13:13:22.955138Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T13:13:22.955349Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T13:13:22.955542Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T13:13:22.95569Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T13:13:22.955947Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T13:13:22.956812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-05-19T13:13:22.957563Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-05-19T13:13:22.959894Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-19T13:13:22.960042Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-05-19T13:13:22.960075Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-05-19T13:13:22.960311Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T13:13:22.960413Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T13:13:23.041136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T13:13:23.041213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T13:13:23.041252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-05-19T13:13:23.041278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-05-19T13:13:23.041289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-05-19T13:13:23.041363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-05-19T13:13:23.0415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-05-19T13:13:23.06308Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:13:23.35537Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T13:13:23.35569Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T13:13:23.355777Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T13:13:23.355911Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T13:13:23.356015Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T13:13:23.357338Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T13:13:23.361089Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-05-19T13:13:23.51916Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:13:23.519286Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:13:23.519326Z","caller":"traceutil/trace.go:171","msg":"trace[1229881441] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"115.167585ms","start":"2026-05-19T13:13:23.404148Z","end":"2026-05-19T13:13:23.519316Z","steps":["trace[1229881441] 'read index received' (duration: 115.00248ms)","trace[1229881441] 'applied index is now lower than readState.Index' (duration: 164.295µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:13:23.519476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.242638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:13:23.519511Z","caller":"traceutil/trace.go:171","msg":"trace[412312076] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"115.318218ms","start":"2026-05-19T13:13:23.404184Z","end":"2026-05-19T13:13:23.519502Z","steps":["trace[412312076] 'agreement among raft nodes before linearized reading' (duration: 115.197466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:13:23.519489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.316689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:13:23.519567Z","caller":"traceutil/trace.go:171","msg":"trace[2033001521] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"115.411821ms","start":"2026-05-19T13:13:23.404143Z","end":"2026-05-19T13:13:23.519555Z","steps":["trace[2033001521] 'agreement among raft nodes before linearized reading' (duration: 115.207576ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:13:23.520395Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-19T13:13:23.680617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.964347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:13:23.680701Z","caller":"traceutil/trace.go:171","msg":"trace[1653903169] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"102.07338ms","start":"2026-05-19T13:13:23.578615Z","end":"2026-05-19T13:13:23.680688Z","steps":["trace[1653903169] 'range keys from in-memory index tree' (duration: 101.846894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:13:23.680924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.027962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:13:23.68095Z","caller":"traceutil/trace.go:171","msg":"trace[672152445] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"113.065764ms","start":"2026-05-19T13:13:23.567878Z","end":"2026-05-19T13:13:23.680943Z","steps":["trace[672152445] 'range keys from in-memory index tree' (duration: 112.999812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:13:23.681193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.191837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:13:23.681219Z","caller":"traceutil/trace.go:171","msg":"trace[1346266174] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"113.252109ms","start":"2026-05-19T13:13:23.56796Z","end":"2026-05-19T13:13:23.681212Z","steps":["trace[1346266174] 'count revisions from in-memory index tree' (duration: 113.174277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:13:23.68141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.713459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:13:23.681486Z","caller":"traceutil/trace.go:171","msg":"trace[2107184289] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"102.813252ms","start":"2026-05-19T13:13:23.578659Z","end":"2026-05-19T13:13:23.681472Z","steps":["trace[2107184289] 'count revisions from in-memory index tree' (duration: 102.678488ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:13:56.314559Z","caller":"traceutil/trace.go:171","msg":"trace[1134801583] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"238.821986ms","start":"2026-05-19T13:13:56.075714Z","end":"2026-05-19T13:13:56.314536Z","steps":["trace[1134801583] 'read index received' (duration: 184.399319ms)","trace[1134801583] 'applied index is now lower than readState.Index' (duration: 54.421397ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:13:56.315015Z","caller":"traceutil/trace.go:171","msg":"trace[1252894266] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"246.563617ms","start":"2026-05-19T13:13:56.068409Z","end":"2026-05-19T13:13:56.314973Z","steps":["trace[1252894266] 'process raft request' (duration: 191.786523ms)","trace[1252894266] 'compare' (duration: 53.944006ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:13:56.31524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.516592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:13:56.315292Z","caller":"traceutil/trace.go:171","msg":"trace[1789289489] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:551; }","duration":"239.622214ms","start":"2026-05-19T13:13:56.075657Z","end":"2026-05-19T13:13:56.315279Z","steps":["trace[1789289489] 'agreement among raft nodes before linearized reading' (duration: 239.460261ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:13:57.302856Z","caller":"traceutil/trace.go:171","msg":"trace[2067175885] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"123.806065ms","start":"2026-05-19T13:13:57.179008Z","end":"2026-05-19T13:13:57.302815Z","steps":["trace[2067175885] 'process raft request' (duration: 122.834314ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:13:57.961129Z","caller":"traceutil/trace.go:171","msg":"trace[2068913594] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"116.046564ms","start":"2026-05-19T13:13:57.845043Z","end":"2026-05-19T13:13:57.961089Z","steps":["trace[2068913594] 'process raft request' (duration: 115.803099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:13:58.359917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.884598ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T13:13:58.360132Z","caller":"traceutil/trace.go:171","msg":"trace[789247480] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:587; }","duration":"283.925682ms","start":"2026-05-19T13:13:58.076148Z","end":"2026-05-19T13:13:58.360073Z","steps":["trace[789247480] 'read index received' (duration: 37.02µs)","trace[789247480] 'applied index is now lower than readState.Index' (duration: 283.886472ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:13:58.360231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.069196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:13:58.360421Z","caller":"traceutil/trace.go:171","msg":"trace[939294055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"284.23327ms","start":"2026-05-19T13:13:58.076133Z","end":"2026-05-19T13:13:58.360366Z","steps":["trace[939294055] 'agreement among raft nodes before linearized reading' (duration: 284.039115ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:13:58.360537Z","caller":"traceutil/trace.go:171","msg":"trace[1017787514] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"477.170514ms","start":"2026-05-19T13:13:57.883114Z","end":"2026-05-19T13:13:58.360284Z","steps":["trace[1017787514] 'process raft request' (duration: 101.343771ms)","trace[1017787514] 'compare' (duration: 371.432417ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:13:58.360785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:13:57.883075Z","time spent":"477.559993ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:13:58.521964Z","caller":"traceutil/trace.go:171","msg":"trace[1704439739] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"387.354003ms","start":"2026-05-19T13:13:58.134545Z","end":"2026-05-19T13:13:58.521899Z","steps":["trace[1704439739] 'process raft request' (duration: 382.481896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:13:58.522211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:13:58.134526Z","time spent":"387.557037ms","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:13:58.52811Z","caller":"traceutil/trace.go:171","msg":"trace[1648686264] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"107.55596ms","start":"2026-05-19T13:13:58.420525Z","end":"2026-05-19T13:13:58.528081Z","steps":["trace[1648686264] 'process raft request' (duration: 107.338505ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:15:26.814636Z","caller":"traceutil/trace.go:171","msg":"trace[1218171450] linearizableReadLoop","detail":"{readStateIndex:1862; appliedIndex:1861; }","duration":"135.787391ms","start":"2026-05-19T13:15:26.678815Z","end":"2026-05-19T13:15:26.814602Z","steps":["trace[1218171450] 'read index received' (duration: 135.510477ms)","trace[1218171450] 'applied index is now lower than readState.Index' (duration: 275.654µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:15:26.814955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.119467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-05-19T13:15:26.815007Z","caller":"traceutil/trace.go:171","msg":"trace[1676106524] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1791; }","duration":"136.255868ms","start":"2026-05-19T13:15:26.678735Z","end":"2026-05-19T13:15:26.814991Z","steps":["trace[1676106524] 'agreement among raft nodes before linearized reading' (duration: 136.008534ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:15:26.815174Z","caller":"traceutil/trace.go:171","msg":"trace[486446457] transaction","detail":"{read_only:false; response_revision:1791; number_of_response:1; }","duration":"173.919541ms","start":"2026-05-19T13:15:26.64108Z","end":"2026-05-19T13:15:26.814999Z","steps":["trace[486446457] 'process raft request' (duration: 173.340243ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:16:15.678193Z","caller":"traceutil/trace.go:171","msg":"trace[1790172913] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"105.887823ms","start":"2026-05-19T13:16:15.572279Z","end":"2026-05-19T13:16:15.678167Z","steps":["trace[1790172913] 'process raft request' (duration: 105.630769ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:16:16.043701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.801917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T13:16:16.043787Z","caller":"traceutil/trace.go:171","msg":"trace[1041023555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2103; }","duration":"223.931968ms","start":"2026-05-19T13:16:15.819834Z","end":"2026-05-19T13:16:16.043766Z","steps":["trace[1041023555] 'range keys from in-memory index tree' (duration: 223.656056ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:16:16.044198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.31026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-19T13:16:16.044267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.934834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-19T13:16:16.044311Z","caller":"traceutil/trace.go:171","msg":"trace[569990894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2103; }","duration":"270.454353ms","start":"2026-05-19T13:16:15.773836Z","end":"2026-05-19T13:16:16.044291Z","steps":["trace[569990894] 'range keys from in-memory index tree' (duration: 269.598931ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:16:16.044375Z","caller":"traceutil/trace.go:171","msg":"trace[796353373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2103; }","duration":"273.128227ms","start":"2026-05-19T13:16:15.771215Z","end":"2026-05-19T13:16:16.044343Z","steps":["trace[796353373] 'range keys from in-memory index tree' (duration: 272.681481ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:16:16.178895Z","caller":"traceutil/trace.go:171","msg":"trace[732987912] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"130.16682ms","start":"2026-05-19T13:16:16.048699Z","end":"2026-05-19T13:16:16.178866Z","steps":["trace[732987912] 'process raft request' (duration: 129.992148ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:16:16.237197Z","caller":"traceutil/trace.go:171","msg":"trace[618118724] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"188.438403ms","start":"2026-05-19T13:16:16.04873Z","end":"2026-05-19T13:16:16.237169Z","steps":["trace[618118724] 'process raft request' (duration: 188.287011ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:16:16.23739Z","caller":"traceutil/trace.go:171","msg":"trace[401166673] linearizableReadLoop","detail":"{readStateIndex:2187; appliedIndex:2184; }","duration":"161.383738ms","start":"2026-05-19T13:16:16.075974Z","end":"2026-05-19T13:16:16.237358Z","steps":["trace[401166673] 'read index received' (duration: 102.70001ms)","trace[401166673] 'applied index is now lower than readState.Index' (duration: 58.681748ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:16:16.237474Z","caller":"traceutil/trace.go:171","msg":"trace[1392670217] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"188.460353ms","start":"2026-05-19T13:16:16.048964Z","end":"2026-05-19T13:16:16.237425Z","steps":["trace[1392670217] 'process raft request' (duration: 188.161329ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:16:16.237583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.57703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:16:16.237674Z","caller":"traceutil/trace.go:171","msg":"trace[482783410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2106; }","duration":"161.758043ms","start":"2026-05-19T13:16:16.075895Z","end":"2026-05-19T13:16:16.237654Z","steps":["trace[482783410] 'agreement among raft nodes before linearized reading' (duration: 161.57059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:21:51.727189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.413803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T13:21:51.727514Z","caller":"traceutil/trace.go:171","msg":"trace[1372419220] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"280.43019ms","start":"2026-05-19T13:21:51.447067Z","end":"2026-05-19T13:21:51.727498Z","steps":["trace[1372419220] 'process raft request' (duration: 159.271625ms)","trace[1372419220] 'compare' (duration: 120.223669ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:21:51.842409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.121911ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-19T13:21:51.843041Z","caller":"traceutil/trace.go:171","msg":"trace[1815438959] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"163.518396ms","start":"2026-05-19T13:21:51.679498Z","end":"2026-05-19T13:21:51.843017Z","steps":["trace[1815438959] 'process raft request' (duration: 163.078109ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:51.865247Z","caller":"traceutil/trace.go:171","msg":"trace[1297401511] linearizableReadLoop","detail":"{readStateIndex:4969; appliedIndex:4964; }","duration":"131.867007ms","start":"2026-05-19T13:21:51.733364Z","end":"2026-05-19T13:21:51.865231Z","steps":["trace[1297401511] 'read index received' (duration: 76.820428ms)","trace[1297401511] 'applied index is now lower than readState.Index' (duration: 55.045219ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:21:51.865227Z","caller":"traceutil/trace.go:171","msg":"trace[2077498688] transaction","detail":"{read_only:false; response_revision:4785; number_of_response:1; }","duration":"154.531033ms","start":"2026-05-19T13:21:51.710657Z","end":"2026-05-19T13:21:51.865188Z","steps":["trace[2077498688] 'process raft request' (duration: 132.346435ms)","trace[2077498688] 'compare' (duration: 21.981385ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:21:51.865328Z","caller":"traceutil/trace.go:171","msg":"trace[819959102] transaction","detail":"{read_only:false; response_revision:4786; number_of_response:1; }","duration":"132.163752ms","start":"2026-05-19T13:21:51.733151Z","end":"2026-05-19T13:21:51.865315Z","steps":["trace[819959102] 'process raft request' (duration: 131.951329ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:51.865695Z","caller":"traceutil/trace.go:171","msg":"trace[1551704901] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"132.521578ms","start":"2026-05-19T13:21:51.733157Z","end":"2026-05-19T13:21:51.865678Z","steps":["trace[1551704901] 'process raft request' (duration: 132.02414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:21:51.86586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.478197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:21:51.865905Z","caller":"traceutil/trace.go:171","msg":"trace[44135619] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:4787; }","duration":"132.536258ms","start":"2026-05-19T13:21:51.733356Z","end":"2026-05-19T13:21:51.865892Z","steps":["trace[44135619] 'agreement among raft nodes before linearized reading' (duration: 132.452567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:21:52.109952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.294918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-19T13:21:52.11012Z","caller":"traceutil/trace.go:171","msg":"trace[1853895132] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4787; }","duration":"100.501551ms","start":"2026-05-19T13:21:52.009595Z","end":"2026-05-19T13:21:52.110097Z","steps":["trace[1853895132] 'range keys from in-memory index tree' (duration: 100.120535ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:52.217335Z","caller":"traceutil/trace.go:171","msg":"trace[1378019167] transaction","detail":"{read_only:false; response_revision:4788; number_of_response:1; }","duration":"102.227681ms","start":"2026-05-19T13:21:52.115077Z","end":"2026-05-19T13:21:52.217305Z","steps":["trace[1378019167] 'process raft request' (duration: 102.019137ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:52.223988Z","caller":"traceutil/trace.go:171","msg":"trace[912422033] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"107.686114ms","start":"2026-05-19T13:21:52.116275Z","end":"2026-05-19T13:21:52.223961Z","steps":["trace[912422033] 'process raft request' (duration: 107.613013ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:52.224282Z","caller":"traceutil/trace.go:171","msg":"trace[1408348303] transaction","detail":"{read_only:false; response_revision:4789; number_of_response:1; }","duration":"109.006556ms","start":"2026-05-19T13:21:52.115226Z","end":"2026-05-19T13:21:52.224233Z","steps":["trace[1408348303] 'process raft request' (duration: 108.510877ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:57.640193Z","caller":"traceutil/trace.go:171","msg":"trace[772083929] transaction","detail":"{read_only:false; response_revision:4831; number_of_response:1; }","duration":"130.449609ms","start":"2026-05-19T13:21:57.509717Z","end":"2026-05-19T13:21:57.640167Z","steps":["trace[772083929] 'process raft request' (duration: 130.315437ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:57.640563Z","caller":"traceutil/trace.go:171","msg":"trace[868222586] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"130.518621ms","start":"2026-05-19T13:21:57.510031Z","end":"2026-05-19T13:21:57.64055Z","steps":["trace[868222586] 'process raft request' (duration: 130.060503ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:21:57.640944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.559233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-19T13:21:57.641016Z","caller":"traceutil/trace.go:171","msg":"trace[1596210722] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"131.698361ms","start":"2026-05-19T13:21:57.509263Z","end":"2026-05-19T13:21:57.640961Z","steps":["trace[1596210722] 'process raft request' (duration: 104.334508ms)","trace[1596210722] 'compare' (duration: 26.258364ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:21:57.641066Z","caller":"traceutil/trace.go:171","msg":"trace[1719878633] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4832; }","duration":"110.751616ms","start":"2026-05-19T13:21:57.530288Z","end":"2026-05-19T13:21:57.641039Z","steps":["trace[1719878633] 'agreement among raft nodes before linearized reading' (duration: 110.37516ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:21:57.641049Z","caller":"traceutil/trace.go:171","msg":"trace[203798100] linearizableReadLoop","detail":"{readStateIndex:5015; appliedIndex:5011; }","duration":"110.027214ms","start":"2026-05-19T13:21:57.53036Z","end":"2026-05-19T13:21:57.640387Z","steps":["trace[203798100] 'read index received' (duration: 47.045427ms)","trace[203798100] 'applied index is now lower than readState.Index' (duration: 62.980237ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:22:23.805627Z","caller":"traceutil/trace.go:171","msg":"trace[46969413] linearizableReadLoop","detail":"{readStateIndex:5330; appliedIndex:5328; }","duration":"143.9581ms","start":"2026-05-19T13:22:23.661647Z","end":"2026-05-19T13:22:23.805605Z","steps":["trace[46969413] 'read index received' (duration: 141.111633ms)","trace[46969413] 'applied index is now lower than readState.Index' (duration: 2.845237ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:22:23.805913Z","caller":"traceutil/trace.go:171","msg":"trace[294658716] transaction","detail":"{read_only:false; response_revision:5136; number_of_response:1; }","duration":"148.382693ms","start":"2026-05-19T13:22:23.657513Z","end":"2026-05-19T13:22:23.805896Z","steps":["trace[294658716] 'process raft request' (duration: 145.16184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:22:23.806686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.739944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:22:23.806778Z","caller":"traceutil/trace.go:171","msg":"trace[21091541] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:5137; }","duration":"138.859956ms","start":"2026-05-19T13:22:23.667894Z","end":"2026-05-19T13:22:23.806754Z","steps":["trace[21091541] 'agreement among raft nodes before linearized reading' (duration: 138.010182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:22:23.806839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.1558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:22:23.806969Z","caller":"traceutil/trace.go:171","msg":"trace[1747076102] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:0; response_revision:5137; }","duration":"145.338913ms","start":"2026-05-19T13:22:23.661608Z","end":"2026-05-19T13:22:23.806947Z","steps":["trace[1747076102] 'agreement among raft nodes before linearized reading' (duration: 144.380878ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:22:23.805929Z","caller":"traceutil/trace.go:171","msg":"trace[1502869884] transaction","detail":"{read_only:false; response_revision:5137; number_of_response:1; }","duration":"147.771423ms","start":"2026-05-19T13:22:23.658079Z","end":"2026-05-19T13:22:23.80585Z","steps":["trace[1502869884] 'process raft request' (duration: 147.466898ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:23:23.381224Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2899} {"level":"info","ts":"2026-05-19T13:23:23.462002Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2899,"took":"78.399214ms","hash":1267012607,"current-db-size-bytes":52948992,"current-db-size":"53 MB","current-db-size-in-use-bytes":28504064,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-19T13:23:23.462162Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1267012607,"revision":2899,"compact-revision":-1} {"level":"info","ts":"2026-05-19T13:24:11.351333Z","caller":"traceutil/trace.go:171","msg":"trace[130761448] linearizableReadLoop","detail":"{readStateIndex:6018; appliedIndex:6017; }","duration":"284.713878ms","start":"2026-05-19T13:24:11.066597Z","end":"2026-05-19T13:24:11.351311Z","steps":["trace[130761448] 'read index received' (duration: 284.554795ms)","trace[130761448] 'applied index is now lower than readState.Index' (duration: 157.773µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:24:11.351414Z","caller":"traceutil/trace.go:171","msg":"trace[954605102] transaction","detail":"{read_only:false; response_revision:5802; number_of_response:1; }","duration":"300.497433ms","start":"2026-05-19T13:24:11.050868Z","end":"2026-05-19T13:24:11.351366Z","steps":["trace[954605102] 'process raft request' (duration: 300.29857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:11.351592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.494943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T13:24:11.351622Z","caller":"traceutil/trace.go:171","msg":"trace[436410249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5802; }","duration":"271.569913ms","start":"2026-05-19T13:24:11.080046Z","end":"2026-05-19T13:24:11.351616Z","steps":["trace[436410249] 'agreement among raft nodes before linearized reading' (duration: 271.425951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:11.351541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.103963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T13:24:11.351632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.019742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T13:24:11.35167Z","caller":"traceutil/trace.go:171","msg":"trace[1476434275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5802; }","duration":"274.279906ms","start":"2026-05-19T13:24:11.077367Z","end":"2026-05-19T13:24:11.351647Z","steps":["trace[1476434275] 'agreement among raft nodes before linearized reading' (duration: 274.091253ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:24:11.351732Z","caller":"traceutil/trace.go:171","msg":"trace[1066707905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5802; }","duration":"285.206365ms","start":"2026-05-19T13:24:11.0665Z","end":"2026-05-19T13:24:11.351706Z","steps":["trace[1066707905] 'agreement among raft nodes before linearized reading' (duration: 284.89932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:11.351829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:11.050838Z","time spent":"300.707495ms","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T13:24:11.351872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.061882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-19T13:24:11.351979Z","caller":"traceutil/trace.go:171","msg":"trace[1733504975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5802; }","duration":"272.228724ms","start":"2026-05-19T13:24:11.079724Z","end":"2026-05-19T13:24:11.351952Z","steps":["trace[1733504975] 'agreement among raft nodes before linearized reading' (duration: 271.947659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:11.35193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.955637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-19T13:24:11.352118Z","caller":"traceutil/trace.go:171","msg":"trace[1913106640] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5802; }","duration":"132.166211ms","start":"2026-05-19T13:24:11.219915Z","end":"2026-05-19T13:24:11.352081Z","steps":["trace[1913106640] 'agreement among raft nodes before linearized reading' (duration: 131.956527ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:24:16.900273Z","caller":"traceutil/trace.go:171","msg":"trace[1708298432] linearizableReadLoop","detail":"{readStateIndex:6052; appliedIndex:6051; }","duration":"541.814891ms","start":"2026-05-19T13:24:16.358427Z","end":"2026-05-19T13:24:16.900242Z","steps":["trace[1708298432] 'read index received' (duration: 442.762917ms)","trace[1708298432] 'applied index is now lower than readState.Index' (duration: 99.050314ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:24:16.900379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:16.257973Z","time spent":"642.395739ms","remote":"127.0.0.1:45550","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-19T13:24:16.900419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.978323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T13:24:16.900465Z","caller":"traceutil/trace.go:171","msg":"trace[142597998] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:5834; }","duration":"542.073425ms","start":"2026-05-19T13:24:16.358378Z","end":"2026-05-19T13:24:16.900451Z","steps":["trace[142597998] 'agreement among raft nodes before linearized reading' (duration: 541.976184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:16.900509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:16.35836Z","time spent":"542.139316ms","remote":"127.0.0.1:45680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":4,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-05-19T13:24:16.905909Z","caller":"traceutil/trace.go:171","msg":"trace[1014711576] transaction","detail":"{read_only:false; response_revision:5835; number_of_response:1; }","duration":"448.091989ms","start":"2026-05-19T13:24:16.457783Z","end":"2026-05-19T13:24:16.905875Z","steps":["trace[1014711576] 'process raft request' (duration: 447.802115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:16.906128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:16.457763Z","time spent":"448.253401ms","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:24:17.81259Z","caller":"traceutil/trace.go:171","msg":"trace[1806708429] transaction","detail":"{read_only:false; response_revision:5842; number_of_response:1; }","duration":"189.857309ms","start":"2026-05-19T13:24:17.622692Z","end":"2026-05-19T13:24:17.812549Z","steps":["trace[1806708429] 'process raft request' (duration: 180.19827ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:24:19.619376Z","caller":"traceutil/trace.go:171","msg":"trace[1173998983] transaction","detail":"{read_only:false; response_revision:5850; number_of_response:1; }","duration":"115.169941ms","start":"2026-05-19T13:24:19.50418Z","end":"2026-05-19T13:24:19.61935Z","steps":["trace[1173998983] 'process raft request' (duration: 115.09467ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:24:19.619542Z","caller":"traceutil/trace.go:171","msg":"trace[1578815493] transaction","detail":"{read_only:false; response_revision:5848; number_of_response:1; }","duration":"115.423946ms","start":"2026-05-19T13:24:19.504078Z","end":"2026-05-19T13:24:19.619502Z","steps":["trace[1578815493] 'process raft request' (duration: 84.67391ms)","trace[1578815493] 'compare' (duration: 30.3449ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:24:19.619681Z","caller":"traceutil/trace.go:171","msg":"trace[705919550] transaction","detail":"{read_only:false; response_revision:5849; number_of_response:1; }","duration":"115.404075ms","start":"2026-05-19T13:24:19.504177Z","end":"2026-05-19T13:24:19.619581Z","steps":["trace[705919550] 'process raft request' (duration: 115.04853ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:24:51.862771Z","caller":"traceutil/trace.go:171","msg":"trace[35495021] transaction","detail":"{read_only:false; response_revision:6060; number_of_response:1; }","duration":"874.35502ms","start":"2026-05-19T13:24:50.988392Z","end":"2026-05-19T13:24:51.862747Z","steps":["trace[35495021] 'process raft request' (duration: 874.183827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:51.863102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:50.988371Z","time spent":"874.482251ms","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:24:51.863655Z","caller":"traceutil/trace.go:171","msg":"trace[500845021] transaction","detail":"{read_only:false; response_revision:6061; number_of_response:1; }","duration":"826.021619ms","start":"2026-05-19T13:24:51.037586Z","end":"2026-05-19T13:24:51.863608Z","steps":["trace[500845021] 'process raft request' (duration: 825.776935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:51.863947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:51.03756Z","time spent":"826.230322ms","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:24:51.867847Z","caller":"traceutil/trace.go:171","msg":"trace[2126332894] linearizableReadLoop","detail":"{readStateIndex:6287; appliedIndex:6283; }","duration":"189.827827ms","start":"2026-05-19T13:24:51.677991Z","end":"2026-05-19T13:24:51.867819Z","steps":["trace[2126332894] 'read index received' (duration: 184.656427ms)","trace[2126332894] 'applied index is now lower than readState.Index' (duration: 5.17041ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:24:51.867907Z","caller":"traceutil/trace.go:171","msg":"trace[1115565629] transaction","detail":"{read_only:false; response_revision:6062; number_of_response:1; }","duration":"219.383009ms","start":"2026-05-19T13:24:51.648501Z","end":"2026-05-19T13:24:51.867884Z","steps":["trace[1115565629] 'process raft request' (duration: 219.040803ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:51.86809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.09072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-19T13:24:51.86812Z","caller":"traceutil/trace.go:171","msg":"trace[1337547795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6062; }","duration":"190.195262ms","start":"2026-05-19T13:24:51.677918Z","end":"2026-05-19T13:24:51.868113Z","steps":["trace[1337547795] 'agreement among raft nodes before linearized reading' (duration: 190.0309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:52.576311Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:53.07762Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:53.57828Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:54.076461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000510275s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-19T13:24:54.076748Z","caller":"traceutil/trace.go:171","msg":"trace[2073457640] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000870711s","start":"2026-05-19T13:24:52.075851Z","end":"2026-05-19T13:24:54.076722Z","steps":["trace[2073457640] 'agreement among raft nodes before linearized reading' (duration: 2.000552206s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:54.076865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:52.075825Z","time spent":"2.001022843s","remote":"127.0.0.1:45512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/19 13:24:54 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:24:54.078911Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:54.579958Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:55.080778Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:55.581933Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:56.077231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000321878s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:24:56.077342Z","caller":"traceutil/trace.go:171","msg":"trace[572277519] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00049087s","start":"2026-05-19T13:24:54.076829Z","end":"2026-05-19T13:24:56.07732Z","steps":["trace[572277519] 'agreement among raft nodes before linearized reading' (duration: 2.000340358s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:56.077397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:54.076815Z","time spent":"2.000571202s","remote":"127.0.0.1:45524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/19 13:24:56 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:24:56.082597Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:56.582744Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:56.872079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:51.873406Z","time spent":"4.998660301s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-19T13:24:56.872449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:51.873429Z","time spent":"4.999003297s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/05/19 13:24:56 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:24:56.968939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:51.969878Z","time spent":"4.999053907s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-19T13:24:57.083474Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:57.421606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998730993s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:24:57.421696Z","caller":"traceutil/trace.go:171","msg":"trace[1956633212] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.998919136s","start":"2026-05-19T13:24:52.422756Z","end":"2026-05-19T13:24:57.421675Z","steps":["trace[1956633212] 'agreement among raft nodes before linearized reading' (duration: 4.998788224s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:57.421747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:52.422723Z","time spent":"4.999014027s","remote":"127.0.0.1:45762","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\" "} 2026/05/19 13:24:57 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:24:57.584205Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:58.085133Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:58.086178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000342039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-19T13:24:58.086286Z","caller":"traceutil/trace.go:171","msg":"trace[387299918] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000529091s","start":"2026-05-19T13:24:56.085736Z","end":"2026-05-19T13:24:58.086265Z","steps":["trace[387299918] 'agreement among raft nodes before linearized reading' (duration: 2.000361919s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:58.086355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:56.085723Z","time spent":"2.000617324s","remote":"127.0.0.1:45512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/19 13:24:58 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:24:58.585507Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266854,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:58.869112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:53.871701Z","time spent":"4.997400971s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/05/19 13:24:58 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:24:58.87469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:51.873617Z","time spent":"7.001059034s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-19T13:24:58.964176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:51.964014Z","time spent":"7.000145709s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-19T13:24:59.076272Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-05-19T13:24:59.577024Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:24:59.644929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999795425s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:24:59.645019Z","caller":"traceutil/trace.go:171","msg":"trace[1376021195] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999971238s","start":"2026-05-19T13:24:57.645017Z","end":"2026-05-19T13:24:59.644989Z","steps":["trace[1376021195] 'agreement among raft nodes before linearized reading' (duration: 1.999843066s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:24:59.645084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:57.64498Z","time spent":"2.000092669s","remote":"127.0.0.1:45512","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-05-19T13:25:00.07757Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:00.086372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000146417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-19T13:25:00.086463Z","caller":"traceutil/trace.go:171","msg":"trace[1648117692] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000288919s","start":"2026-05-19T13:24:58.086153Z","end":"2026-05-19T13:25:00.086442Z","steps":["trace[1648117692] 'agreement among raft nodes before linearized reading' (duration: 2.000163007s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:00.086517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:58.086142Z","time spent":"2.00036462s","remote":"127.0.0.1:45524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/19 13:25:00 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:00.578277Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:00.875818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:53.874714Z","time spent":"7.001090445s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-19T13:25:01.078608Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:01.579788Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:01.788616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.911911521s","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-05-19T13:25:01.788824Z","caller":"traceutil/trace.go:171","msg":"trace[1979311647] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.912266495s","start":"2026-05-19T13:24:58.876531Z","end":"2026-05-19T13:25:01.788797Z","steps":["trace[1979311647] 'agreement among raft nodes before linearized reading' (duration: 2.91195112s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:01.788705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.935217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"} {"level":"warn","ts":"2026-05-19T13:25:01.788927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:58.876507Z","time spent":"2.912404688s","remote":"127.0.0.1:45762","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/05/19 13:25:01 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-05-19T13:25:01.789781Z","caller":"traceutil/trace.go:171","msg":"trace[1177720683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"909.84405ms","start":"2026-05-19T13:25:00.879556Z","end":"2026-05-19T13:25:01.7894Z","steps":["trace[1177720683] 'agreement among raft nodes before linearized reading' (duration: 909.009938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:01.790271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:00.879521Z","time spent":"910.727784ms","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} 2026/05/19 13:25:01 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:01.791114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.915602086s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:01.791266Z","caller":"traceutil/trace.go:171","msg":"trace[369593153] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.915749999s","start":"2026-05-19T13:24:58.875438Z","end":"2026-05-19T13:25:01.791188Z","steps":["trace[369593153] 'agreement among raft nodes before linearized reading' (duration: 2.914958117s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:01.791573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:58.875409Z","time spent":"2.916018472s","remote":"127.0.0.1:45762","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/05/19 13:25:01 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:01.806844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999717805s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:01.8071Z","caller":"traceutil/trace.go:171","msg":"trace[400954965] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999900948s","start":"2026-05-19T13:24:59.807036Z","end":"2026-05-19T13:25:01.806937Z","steps":["trace[400954965] 'agreement among raft nodes before linearized reading' (duration: 1.999760606s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:01.807181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:59.807009Z","time spent":"2.000158812s","remote":"127.0.0.1:45512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/19 13:25:01 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:01.969433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998008018s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:01.969588Z","caller":"traceutil/trace.go:171","msg":"trace[1265512700] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; }","duration":"4.998201811s","start":"2026-05-19T13:24:56.971361Z","end":"2026-05-19T13:25:01.969562Z","steps":["trace[1265512700] 'agreement among raft nodes before linearized reading' (duration: 4.998025608s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:01.96968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:56.97135Z","time spent":"4.998316723s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":0,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} 2026/05/19 13:25:01 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:01.994763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.238478322s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:01.994895Z","caller":"traceutil/trace.go:171","msg":"trace[749102331] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; }","duration":"9.238682955s","start":"2026-05-19T13:24:52.75619Z","end":"2026-05-19T13:25:01.994873Z","steps":["trace[749102331] 'agreement among raft nodes before linearized reading' (duration: 9.238526303s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:01.994948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:52.756159Z","time spent":"9.238778806s","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":0,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} 2026/05/19 13:25:01 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:02.082093Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:02.094255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999921316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-19T13:25:02.09434Z","caller":"traceutil/trace.go:171","msg":"trace[167447254] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000080748s","start":"2026-05-19T13:25:00.094234Z","end":"2026-05-19T13:25:02.094315Z","steps":["trace[167447254] 'agreement among raft nodes before linearized reading' (duration: 1.999940776s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:02.094398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:00.094221Z","time spent":"2.00016691s","remote":"127.0.0.1:45524","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-05-19T13:25:02.283585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.004132719s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:02.283703Z","caller":"traceutil/trace.go:171","msg":"trace[498269126] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; }","duration":"10.004327662s","start":"2026-05-19T13:24:52.279339Z","end":"2026-05-19T13:25:02.283667Z","steps":["trace[498269126] 'agreement among raft nodes before linearized reading' (duration: 10.00417905s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:02.283756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:52.279311Z","time spent":"10.004435573s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":0,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} 2026/05/19 13:25:02 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:02.421471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.99813466s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:02.421575Z","caller":"traceutil/trace.go:171","msg":"trace[53164857] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.998305932s","start":"2026-05-19T13:24:59.423238Z","end":"2026-05-19T13:25:02.421544Z","steps":["trace[53164857] 'agreement among raft nodes before linearized reading' (duration: 2.99817388s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:02.421647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:59.423213Z","time spent":"2.998422884s","remote":"127.0.0.1:45762","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\" "} 2026/05/19 13:25:02 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:02.583081Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:03.081425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:56.080598Z","time spent":"7.000820331s","remote":"127.0.0.1:45594","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-19T13:25:03.083678Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:03.584036Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:03.869336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.997059554s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:03.869445Z","caller":"traceutil/trace.go:171","msg":"trace[455919551] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; }","duration":"4.997230897s","start":"2026-05-19T13:24:58.872187Z","end":"2026-05-19T13:25:03.869418Z","steps":["trace[455919551] 'agreement among raft nodes before linearized reading' (duration: 4.997089514s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:03.86951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:58.872166Z","time spent":"4.997334308s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":0,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} 2026/05/19 13:25:03 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:03.872184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.991968928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:03.872304Z","caller":"traceutil/trace.go:171","msg":"trace[2086601425] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; }","duration":"2.99213316s","start":"2026-05-19T13:25:00.880146Z","end":"2026-05-19T13:25:03.87228Z","steps":["trace[2086601425] 'agreement among raft nodes before linearized reading' (duration: 2.991983438s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:03.87236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:00.88013Z","time spent":"2.992217712s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":0,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} 2026/05/19 13:25:03 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:03.878508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.000219482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:03.878548Z","caller":"traceutil/trace.go:171","msg":"trace[351821402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"10.000325604s","start":"2026-05-19T13:24:53.878213Z","end":"2026-05-19T13:25:03.878539Z","steps":["trace[351821402] 'agreement among raft nodes before linearized reading' (duration: 10.000281253s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:03.878572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:53.878181Z","time spent":"10.000385965s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} 2026/05/19 13:25:03 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:04.08463Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:04.101812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000078102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:04.101913Z","caller":"traceutil/trace.go:171","msg":"trace[2088177071] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000247055s","start":"2026-05-19T13:25:02.101645Z","end":"2026-05-19T13:25:04.101892Z","steps":["trace[2088177071] 'agreement among raft nodes before linearized reading' (duration: 2.000116113s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:04.10199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:02.101624Z","time spent":"2.000356697s","remote":"127.0.0.1:45512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/19 13:25:04 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:04.584977Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:05.086217Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:05.312471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:58.311561Z","time spent":"7.000899514s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-19T13:25:05.586759Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266867,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:05.970814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:58.969823Z","time spent":"7.000982337s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-19T13:25:06.076641Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-05-19T13:25:06.076939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.829692868s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-05-19T13:25:06.077008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.308595584s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.07705Z","caller":"traceutil/trace.go:171","msg":"trace[982470242] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; }","duration":"7.308687075s","start":"2026-05-19T13:24:58.768348Z","end":"2026-05-19T13:25:06.077035Z","steps":["trace[982470242] 'agreement among raft nodes before linearized reading' (duration: 7.308648224s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.07709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.889862682s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-05-19T13:25:06.077111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:58.768319Z","time spent":"7.308779217s","remote":"127.0.0.1:45844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":0,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.077154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.884517166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.077384Z","caller":"traceutil/trace.go:171","msg":"trace[1154542092] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; }","duration":"8.884786491s","start":"2026-05-19T13:24:57.192588Z","end":"2026-05-19T13:25:06.077374Z","steps":["trace[1154542092] 'agreement among raft nodes before linearized reading' (duration: 8.884554097s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.07728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.904654036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-05-19T13:25:06.077457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:57.192566Z","time spent":"8.884878432s","remote":"127.0.0.1:45758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":0,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.076945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.044121322s","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":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.077476Z","caller":"traceutil/trace.go:171","msg":"trace[15723486] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; }","duration":"11.904964251s","start":"2026-05-19T13:24:54.172489Z","end":"2026-05-19T13:25:06.077453Z","steps":["trace[15723486] 'agreement among raft nodes before linearized reading' (duration: 11.904671817s)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:25:06.077511Z","caller":"traceutil/trace.go:171","msg":"trace[364853366] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; }","duration":"8.044763642s","start":"2026-05-19T13:24:58.032736Z","end":"2026-05-19T13:25:06.0775Z","steps":["trace[364853366] 'agreement among raft nodes before linearized reading' (duration: 8.044172383s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.077539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:54.172474Z","time spent":"11.905047632s","remote":"127.0.0.1:52296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":0,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.077556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:58.03267Z","time spent":"8.044873043s","remote":"127.0.0.1:56404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":0,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.077112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.05480308s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.077641Z","caller":"traceutil/trace.go:171","msg":"trace[270759709] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; }","duration":"9.055387718s","start":"2026-05-19T13:24:57.022217Z","end":"2026-05-19T13:25:06.077605Z","steps":["trace[270759709] 'agreement among raft nodes before linearized reading' (duration: 9.05486738s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.07736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.670022626s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.077038Z","caller":"traceutil/trace.go:171","msg":"trace[562891485] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; }","duration":"9.829899281s","start":"2026-05-19T13:24:56.247115Z","end":"2026-05-19T13:25:06.077014Z","steps":["trace[562891485] 'agreement among raft nodes before linearized reading' (duration: 9.829743999s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.077027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.483347765s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.077946Z","caller":"traceutil/trace.go:171","msg":"trace[2113847407] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; }","duration":"7.670551044s","start":"2026-05-19T13:24:58.407142Z","end":"2026-05-19T13:25:06.077693Z","steps":["trace[2113847407] 'agreement among raft nodes before linearized reading' (duration: 7.670006335s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.077905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:56.247068Z","time spent":"9.830762295s","remote":"127.0.0.1:56490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":0,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.077736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:57.022175Z","time spent":"9.055516021s","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":0,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.078041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:58.407112Z","time spent":"7.67090022s","remote":"127.0.0.1:45562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":0,"response size":0,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"info","ts":"2026-05-19T13:25:06.077956Z","caller":"traceutil/trace.go:171","msg":"trace[1635160375] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; }","duration":"10.484268339s","start":"2026-05-19T13:24:55.593663Z","end":"2026-05-19T13:25:06.077931Z","steps":["trace[1635160375] 'agreement among raft nodes before linearized reading' (duration: 10.483347045s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.07834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:55.593644Z","time spent":"10.484667965s","remote":"127.0.0.1:56484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":0,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-05-19T13:25:06.077167Z","caller":"traceutil/trace.go:171","msg":"trace[681313803] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; }","duration":"10.889958284s","start":"2026-05-19T13:24:55.187157Z","end":"2026-05-19T13:25:06.077115Z","steps":["trace[681313803] 'agreement among raft nodes before linearized reading' (duration: 10.889921783s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.078414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:55.187128Z","time spent":"10.891275754s","remote":"127.0.0.1:45880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.076965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.009375045s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.078542Z","caller":"traceutil/trace.go:171","msg":"trace[1988343250] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; }","duration":"10.011085332s","start":"2026-05-19T13:24:56.067444Z","end":"2026-05-19T13:25:06.078529Z","steps":["trace[1988343250] 'agreement among raft nodes before linearized reading' (duration: 10.009430466s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.078598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:56.067413Z","time spent":"10.011170093s","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":0,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.077222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.143674279s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.078651Z","caller":"traceutil/trace.go:171","msg":"trace[558755652] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; }","duration":"9.145162182s","start":"2026-05-19T13:24:56.933479Z","end":"2026-05-19T13:25:06.078641Z","steps":["trace[558755652] 'agreement among raft nodes before linearized reading' (duration: 9.14370627s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.078686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:56.933456Z","time spent":"9.145221243s","remote":"127.0.0.1:52326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":0,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.077228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.342607528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.078762Z","caller":"traceutil/trace.go:171","msg":"trace[425769980] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; }","duration":"13.344150112s","start":"2026-05-19T13:24:52.734595Z","end":"2026-05-19T13:25:06.078745Z","steps":["trace[425769980] 'agreement among raft nodes before linearized reading' (duration: 13.342603828s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.078807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:52.734565Z","time spent":"13.344230444s","remote":"127.0.0.1:45680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":0,"response size":0,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-05-19T13:25:06.07724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.473254699s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.078846Z","caller":"traceutil/trace.go:171","msg":"trace[45451144] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; }","duration":"13.474928634s","start":"2026-05-19T13:24:52.603907Z","end":"2026-05-19T13:25:06.078836Z","steps":["trace[45451144] 'agreement among raft nodes before linearized reading' (duration: 13.47331355s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.078888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:52.60388Z","time spent":"13.474998096s","remote":"127.0.0.1:45688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":0,"request content":"key:\"/registry/services/endpoints/openstack/keystone-api\" "} {"level":"warn","ts":"2026-05-19T13:25:06.077277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.683685464s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.078929Z","caller":"traceutil/trace.go:171","msg":"trace[1427681324] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; }","duration":"7.685383721s","start":"2026-05-19T13:24:58.393539Z","end":"2026-05-19T13:25:06.078922Z","steps":["trace[1427681324] 'agreement among raft nodes before linearized reading' (duration: 7.683727155s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.078962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:58.393506Z","time spent":"7.685448301s","remote":"127.0.0.1:45626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":0,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.077284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.030172506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.079002Z","caller":"traceutil/trace.go:171","msg":"trace[83539315] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; }","duration":"12.031934584s","start":"2026-05-19T13:24:54.047061Z","end":"2026-05-19T13:25:06.078995Z","steps":["trace[83539315] 'agreement among raft nodes before linearized reading' (duration: 12.030208407s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.079036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:54.047043Z","time spent":"12.031984164s","remote":"127.0.0.1:52228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":0,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.077309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.818397035s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.079088Z","caller":"traceutil/trace.go:171","msg":"trace[1641154396] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; }","duration":"9.820197313s","start":"2026-05-19T13:24:56.258882Z","end":"2026-05-19T13:25:06.07908Z","steps":["trace[1641154396] 'agreement among raft nodes before linearized reading' (duration: 9.818416616s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.079117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:56.258871Z","time spent":"9.820238613s","remote":"127.0.0.1:45550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":0,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"warn","ts":"2026-05-19T13:25:06.077325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.527134361s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.079217Z","caller":"traceutil/trace.go:171","msg":"trace[346312498] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; }","duration":"11.529079931s","start":"2026-05-19T13:24:54.550129Z","end":"2026-05-19T13:25:06.079209Z","steps":["trace[346312498] 'agreement among raft nodes before linearized reading' (duration: 11.527184912s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.079256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:54.550101Z","time spent":"11.529142461s","remote":"127.0.0.1:45940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":0,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.077326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.752190024s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-19T13:25:06.079303Z","caller":"traceutil/trace.go:171","msg":"trace[1845685378] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; }","duration":"11.754211284s","start":"2026-05-19T13:24:54.325085Z","end":"2026-05-19T13:25:06.079296Z","steps":["trace[1845685378] 'agreement among raft nodes before linearized reading' (duration: 11.752231264s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.079339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:54.325062Z","time spent":"11.754266446s","remote":"127.0.0.1:45784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":0,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.103001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000537532s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:06.103062Z","caller":"traceutil/trace.go:171","msg":"trace[565975195] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000668704s","start":"2026-05-19T13:25:04.102379Z","end":"2026-05-19T13:25:06.103048Z","steps":["trace[565975195] 'agreement among raft nodes before linearized reading' (duration: 2.000601083s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.103104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:04.102337Z","time spent":"2.000759256s","remote":"127.0.0.1:45524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/19 13:25:06 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:06.577472Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872841686266877,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T13:25:06.593971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99999074s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T13:25:06.594058Z","caller":"traceutil/trace.go:171","msg":"trace[1937047499] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000138531s","start":"2026-05-19T13:25:04.59389Z","end":"2026-05-19T13:25:06.594028Z","steps":["trace[1937047499] 'agreement among raft nodes before linearized reading' (duration: 2.00002379s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.594285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:04.593867Z","time spent":"2.000359495s","remote":"127.0.0.1:45512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/19 13:25:06 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T13:25:06.737162Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"14.862660046s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-19T13:25:06.743106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:56.39416Z","time spent":"10.348938208s","remote":"127.0.0.1:43434","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-19T13:25:06.744508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.744883112s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:25:06.744725Z","caller":"traceutil/trace.go:171","msg":"trace[1884205609] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:6063; }","duration":"10.745077625s","start":"2026-05-19T13:24:55.999576Z","end":"2026-05-19T13:25:06.744654Z","steps":["trace[1884205609] 'range keys from in-memory index tree' (duration: 10.744845771s)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:25:06.751223Z","caller":"traceutil/trace.go:171","msg":"trace[212382] transaction","detail":"{read_only:false; response_revision:6072; number_of_response:1; }","duration":"6.612126055s","start":"2026-05-19T13:25:00.139078Z","end":"2026-05-19T13:25:06.751204Z","steps":["trace[212382] 'process raft request' (duration: 6.610729694s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.751373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:00.139048Z","time spent":"6.612252027s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:25:06.753618Z","caller":"traceutil/trace.go:171","msg":"trace[214084203] transaction","detail":"{read_only:false; number_of_response:1; response_revision:6073; }","duration":"4.960635228s","start":"2026-05-19T13:25:01.792922Z","end":"2026-05-19T13:25:06.753558Z","steps":["trace[214084203] 'process raft request' (duration: 4.959247527s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.753802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:01.79289Z","time spent":"4.96080365s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":62,"response count":0,"response size":527,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:25:06.756366Z","caller":"traceutil/trace.go:171","msg":"trace[1223124558] transaction","detail":"{read_only:false; number_of_response:1; response_revision:6073; }","duration":"4.962682259s","start":"2026-05-19T13:25:01.79367Z","end":"2026-05-19T13:25:06.756352Z","steps":["trace[1223124558] 'process raft request' (duration: 4.959126224s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.756439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:01.793641Z","time spent":"4.962757s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":47,"response count":0,"response size":514,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:25:06.757499Z","caller":"traceutil/trace.go:171","msg":"trace[921308902] linearizableReadLoop","detail":"{readStateIndex:6306; appliedIndex:6288; }","duration":"680.689848ms","start":"2026-05-19T13:25:06.076787Z","end":"2026-05-19T13:25:06.757477Z","steps":["trace[921308902] 'read index received' (duration: 660.740253ms)","trace[921308902] 'applied index is now lower than readState.Index' (duration: 19.948305ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:25:06.757736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:03.087677Z","time spent":"3.670055099s","remote":"127.0.0.1:45594","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-19T13:25:06.757647Z","caller":"traceutil/trace.go:171","msg":"trace[439234471] transaction","detail":"{read_only:false; response_revision:6074; number_of_response:1; }","duration":"2.876173955s","start":"2026-05-19T13:25:03.881459Z","end":"2026-05-19T13:25:06.757633Z","steps":["trace[439234471] 'process raft request' (duration: 2.875884921s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.757857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.194742587s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T13:25:06.757896Z","caller":"traceutil/trace.go:171","msg":"trace[1707023910] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:6074; }","duration":"4.194834958s","start":"2026-05-19T13:25:02.563052Z","end":"2026-05-19T13:25:06.757887Z","steps":["trace[1707023910] 'agreement among raft nodes before linearized reading' (duration: 4.194736087s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.757928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:02.563029Z","time spent":"4.19489219s","remote":"127.0.0.1:45876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.75796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:03.881431Z","time spent":"2.876446079s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":415,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:25:06.757647Z","caller":"traceutil/trace.go:171","msg":"trace[73020372] transaction","detail":"{read_only:false; number_of_response:1; response_revision:6073; }","duration":"4.963881317s","start":"2026-05-19T13:25:01.793739Z","end":"2026-05-19T13:25:06.75762Z","steps":["trace[73020372] 'process raft request' (duration: 4.959136815s)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:25:06.758108Z","caller":"traceutil/trace.go:171","msg":"trace[1373466877] transaction","detail":"{read_only:false; number_of_response:1; response_revision:6074; }","duration":"781.18663ms","start":"2026-05-19T13:25:05.976912Z","end":"2026-05-19T13:25:06.758099Z","steps":["trace[1373466877] 'process raft request' (duration: 780.51685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.758163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.263851532s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-19T13:25:06.758187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:01.793681Z","time spent":"4.964396555s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":46,"response count":0,"response size":469,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:25:06.758225Z","caller":"traceutil/trace.go:171","msg":"trace[125378333] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:6074; }","duration":"4.263966004s","start":"2026-05-19T13:25:02.49424Z","end":"2026-05-19T13:25:06.758206Z","steps":["trace[125378333] 'agreement among raft nodes before linearized reading' (duration: 4.263873502s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.758264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:02.494211Z","time spent":"4.264044625s","remote":"127.0.0.1:51806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.758384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.440682419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" ","response":"range_response_count:1 size:489"} {"level":"info","ts":"2026-05-19T13:25:06.75841Z","caller":"traceutil/trace.go:171","msg":"trace[1153667119] range","detail":"{range_begin:/registry/leases/ingress-nginx/ingress-nginx-leader; range_end:; response_count:1; response_revision:6074; }","duration":"1.44075428s","start":"2026-05-19T13:25:05.317648Z","end":"2026-05-19T13:25:06.758402Z","steps":["trace[1153667119] 'agreement among raft nodes before linearized reading' (duration: 1.440590767s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.758644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:05.317621Z","time spent":"1.441018004s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":512,"request content":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" "} {"level":"warn","ts":"2026-05-19T13:25:06.758722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.426511734s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:25:06.758808Z","caller":"traceutil/trace.go:171","msg":"trace[769396116] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:6074; }","duration":"7.426628995s","start":"2026-05-19T13:24:59.332166Z","end":"2026-05-19T13:25:06.758795Z","steps":["trace[769396116] 'agreement among raft nodes before linearized reading' (duration: 7.426214479s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.758899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:24:59.332149Z","time spent":"7.426736017s","remote":"127.0.0.1:56278","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-05-19T13:25:06.759003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.599225236s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"warn","ts":"2026-05-19T13:25:06.758226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.249284459s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T13:25:06.759043Z","caller":"traceutil/trace.go:171","msg":"trace[1835932150] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:6074; }","duration":"1.599327158s","start":"2026-05-19T13:25:05.159704Z","end":"2026-05-19T13:25:06.759031Z","steps":["trace[1835932150] 'agreement among raft nodes before linearized reading' (duration: 1.599173745s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.75907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:05.159659Z","time spent":"1.599404559s","remote":"127.0.0.1:45704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2013,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-05-19T13:25:06.759175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.375660668s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:25:06.75925Z","caller":"traceutil/trace.go:171","msg":"trace[678206805] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:6074; }","duration":"4.375782931s","start":"2026-05-19T13:25:02.383456Z","end":"2026-05-19T13:25:06.759239Z","steps":["trace[678206805] 'agreement among raft nodes before linearized reading' (duration: 4.375673789s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.759287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.244989362s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:25:06.759316Z","caller":"traceutil/trace.go:171","msg":"trace[617531441] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:6074; }","duration":"3.245056324s","start":"2026-05-19T13:25:03.514252Z","end":"2026-05-19T13:25:06.759309Z","steps":["trace[617531441] 'agreement among raft nodes before linearized reading' (duration: 3.245014593s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.759337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:03.51423Z","time spent":"3.245101564s","remote":"127.0.0.1:45878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.759344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:02.383424Z","time spent":"4.375871712s","remote":"127.0.0.1:56498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.75956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.331669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:25:06.759587Z","caller":"traceutil/trace.go:171","msg":"trace[962115218] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6074; }","duration":"649.400881ms","start":"2026-05-19T13:25:06.110177Z","end":"2026-05-19T13:25:06.759578Z","steps":["trace[962115218] 'agreement among raft nodes before linearized reading' (duration: 649.32515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.759602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:06.110156Z","time spent":"649.442681ms","remote":"127.0.0.1:45512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T13:25:06.759747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.783864739s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:25:06.759778Z","caller":"traceutil/trace.go:171","msg":"trace[1958154147] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:6074; }","duration":"4.783959051s","start":"2026-05-19T13:25:01.975811Z","end":"2026-05-19T13:25:06.75977Z","steps":["trace[1958154147] 'agreement among raft nodes before linearized reading' (duration: 4.78390434s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.759758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.661523291s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7111"} {"level":"warn","ts":"2026-05-19T13:25:06.7598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:01.975774Z","time spent":"4.784019241s","remote":"127.0.0.1:47972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true "} {"level":"info","ts":"2026-05-19T13:25:06.759838Z","caller":"traceutil/trace.go:171","msg":"trace[858274100] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:6074; }","duration":"4.661650044s","start":"2026-05-19T13:25:02.098176Z","end":"2026-05-19T13:25:06.759826Z","steps":["trace[858274100] 'agreement among raft nodes before linearized reading' (duration: 4.66138702s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.758183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:05.976869Z","time spent":"781.264572ms","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":45,"response count":0,"response size":570,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T13:25:06.759924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:02.09815Z","time spent":"4.661752535s","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7134,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-05-19T13:25:06.759251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.920694209s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:25:06.760096Z","caller":"traceutil/trace.go:171","msg":"trace[1190970477] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:6074; }","duration":"1.921592703s","start":"2026-05-19T13:25:04.838495Z","end":"2026-05-19T13:25:06.760088Z","steps":["trace[1190970477] 'agreement among raft nodes before linearized reading' (duration: 1.920723629s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.760185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:04.838472Z","time spent":"1.921702854s","remote":"127.0.0.1:51826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.758853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.531132188s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-19T13:25:06.760401Z","caller":"traceutil/trace.go:171","msg":"trace[685272445] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:6074; }","duration":"1.532739452s","start":"2026-05-19T13:25:05.227652Z","end":"2026-05-19T13:25:06.760392Z","steps":["trace[685272445] 'agreement among raft nodes before linearized reading' (duration: 1.531040386s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.760433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:05.227626Z","time spent":"1.532799053s","remote":"127.0.0.1:45762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-05-19T13:25:06.760548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.318258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:25:06.76057Z","caller":"traceutil/trace.go:171","msg":"trace[1007315184] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:0; response_revision:6074; }","duration":"500.386599ms","start":"2026-05-19T13:25:06.260178Z","end":"2026-05-19T13:25:06.760565Z","steps":["trace[1007315184] 'agreement among raft nodes before linearized reading' (duration: 500.348248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.760588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:06.260142Z","time spent":"500.44197ms","remote":"127.0.0.1:45550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"warn","ts":"2026-05-19T13:25:06.760124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.612038233s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T13:25:06.76077Z","caller":"traceutil/trace.go:171","msg":"trace[246453822] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:6074; }","duration":"6.612703123s","start":"2026-05-19T13:25:00.148054Z","end":"2026-05-19T13:25:06.760757Z","steps":["trace[246453822] 'agreement among raft nodes before linearized reading' (duration: 6.612034673s)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:25:06.760766Z","caller":"traceutil/trace.go:171","msg":"trace[393847132] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:6074; }","duration":"1.250121672s","start":"2026-05-19T13:25:05.508932Z","end":"2026-05-19T13:25:06.759054Z","steps":["trace[393847132] 'agreement among raft nodes before linearized reading' (duration: 1.249266349s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:25:06.761973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:05.508868Z","time spent":"1.253087557s","remote":"127.0.0.1:45994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":4,"response size":30,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-05-19T13:25:06.76083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:25:00.148042Z","time spent":"6.612767464s","remote":"127.0.0.1:52202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "} {"level":"info","ts":"2026-05-19T13:28:23.388633Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5506} {"level":"info","ts":"2026-05-19T13:28:23.469956Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5506,"took":"79.259774ms","hash":267856873,"current-db-size-bytes":52948992,"current-db-size":"53 MB","current-db-size-in-use-bytes":18767872,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-05-19T13:28:23.470028Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":267856873,"revision":5506,"compact-revision":2899}