{"level":"warn","ts":"2026-05-08T10:16:33.881754Z","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-08T10:16:33.881863Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-08T10:16:33.881935Z","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-08T10:16:33.881949Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-05-08T10:16:33.881969Z","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-08T10:16:33.882662Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-05-08T10:16:33.88274Z","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.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-08T10:16:33.888742Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.745675ms"} {"level":"info","ts":"2026-05-08T10:16:33.918335Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-05-08T10:16:33.91847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-05-08T10:16:33.918506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-05-08T10:16:33.918525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-08T10:16:33.918542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-05-08T10:16:33.918595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-05-08T10:16:33.944962Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-08T10:16:33.947274Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-08T10:16:33.950412Z","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-08T10:16:33.953154Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-08T10:16:33.960437Z","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-08T10:16:33.960534Z","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-08T10:16:33.960469Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-08T10:16:33.960587Z","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-08T10:16:33.963595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-05-08T10:16:33.963811Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-05-08T10:16:33.966533Z","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-08T10:16:33.966602Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-05-08T10:16:33.966717Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-05-08T10:16:33.967656Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-08T10:16:33.967635Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-08T10:16:34.818943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-05-08T10:16:34.818997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-08T10:16:34.819022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-05-08T10:16:34.819045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-05-08T10:16:34.819051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-05-08T10:16:34.819061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-05-08T10:16:34.819074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-05-08T10:16:34.82994Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-05-08T10:16:34.830004Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T10:16:34.829695Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:16:34.830611Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T10:16:34.831552Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-08T10:16:34.83164Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-08T10:16:34.833393Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:16:34.83362Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:16:34.833692Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:16:34.835402Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-08T10:16:34.840212Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-05-08T10:16:49.449008Z","caller":"traceutil/trace.go:171","msg":"trace[1618222541] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"229.274639ms","start":"2026-05-08T10:16:49.219677Z","end":"2026-05-08T10:16:49.448952Z","steps":["trace[1618222541] 'process raft request' (duration: 229.021898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:16:49.948872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.872637ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:16:49.948958Z","caller":"traceutil/trace.go:171","msg":"trace[406323571] linearizableReadLoop","detail":"{readStateIndex:376; appliedIndex:375; }","duration":"119.728421ms","start":"2026-05-08T10:16:49.829216Z","end":"2026-05-08T10:16:49.948945Z","steps":["trace[406323571] 'read index received' (duration: 60.483µs)","trace[406323571] 'applied index is now lower than readState.Index' (duration: 119.667078ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:16:49.949202Z","caller":"traceutil/trace.go:171","msg":"trace[477139291] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"494.285149ms","start":"2026-05-08T10:16:49.454908Z","end":"2026-05-08T10:16:49.949193Z","steps":["trace[477139291] 'process raft request' (duration: 80.676562ms)","trace[477139291] 'compare' (duration: 412.733721ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:16:49.949246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:16:49.454875Z","time spent":"494.350572ms","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:16:49.949374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.171009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4795"} {"level":"info","ts":"2026-05-08T10:16:49.949389Z","caller":"traceutil/trace.go:171","msg":"trace[1289186163] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:365; }","duration":"120.228191ms","start":"2026-05-08T10:16:49.829156Z","end":"2026-05-08T10:16:49.949384Z","steps":["trace[1289186163] 'agreement among raft nodes before linearized reading' (duration: 120.19273ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:17:20.857913Z","caller":"traceutil/trace.go:171","msg":"trace[176772917] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"370.676767ms","start":"2026-05-08T10:17:20.487194Z","end":"2026-05-08T10:17:20.857871Z","steps":["trace[176772917] 'process raft request' (duration: 323.208816ms)","trace[176772917] 'compare' (duration: 47.103409ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:17:20.858293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:17:20.487146Z","time spent":"370.983007ms","remote":"127.0.0.1:34270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:17:21.34424Z","caller":"traceutil/trace.go:171","msg":"trace[339386636] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"385.030324ms","start":"2026-05-08T10:17:20.959182Z","end":"2026-05-08T10:17:21.344212Z","steps":["trace[339386636] 'read index received' (duration: 384.794736ms)","trace[339386636] 'applied index is now lower than readState.Index' (duration: 234.607µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:17:21.344357Z","caller":"traceutil/trace.go:171","msg":"trace[78656671] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"389.893638ms","start":"2026-05-08T10:17:20.954456Z","end":"2026-05-08T10:17:21.34435Z","steps":["trace[78656671] 'process raft request' (duration: 389.609639ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:17:21.344514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:17:20.954431Z","time spent":"389.948779ms","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:17:21.34458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.367114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T10:17:21.344631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.065921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:17:21.34469Z","caller":"traceutil/trace.go:171","msg":"trace[573544507] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:603; }","duration":"385.53815ms","start":"2026-05-08T10:17:20.959126Z","end":"2026-05-08T10:17:21.344665Z","steps":["trace[573544507] 'agreement among raft nodes before linearized reading' (duration: 385.293422ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:17:21.344846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:17:20.959098Z","time spent":"385.736915ms","remote":"127.0.0.1:34392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":26,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-05-08T10:17:21.34485Z","caller":"traceutil/trace.go:171","msg":"trace[1050431116] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"214.298169ms","start":"2026-05-08T10:17:21.130436Z","end":"2026-05-08T10:17:21.344734Z","steps":["trace[1050431116] 'agreement among raft nodes before linearized reading' (duration: 214.040591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:17:21.345097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.570668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-56k78\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-08T10:17:21.345131Z","caller":"traceutil/trace.go:171","msg":"trace[1362158114] range","detail":"{range_begin:/registry/pods/kube-system/cilium-56k78; range_end:; response_count:1; response_revision:603; }","duration":"351.753223ms","start":"2026-05-08T10:17:20.99337Z","end":"2026-05-08T10:17:21.345123Z","steps":["trace[1362158114] 'agreement among raft nodes before linearized reading' (duration: 351.02777ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:17:21.345153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:17:20.993347Z","time spent":"351.799615ms","remote":"127.0.0.1:34354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16986,"request content":"key:\"/registry/pods/kube-system/cilium-56k78\" "} {"level":"info","ts":"2026-05-08T10:17:21.535707Z","caller":"traceutil/trace.go:171","msg":"trace[1936756577] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"172.678824ms","start":"2026-05-08T10:17:21.362983Z","end":"2026-05-08T10:17:21.535662Z","steps":["trace[1936756577] 'process raft request' (duration: 169.918237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:17:36.685784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.493923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-08T10:17:36.685898Z","caller":"traceutil/trace.go:171","msg":"trace[568024789] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:760; }","duration":"198.678338ms","start":"2026-05-08T10:17:36.487199Z","end":"2026-05-08T10:17:36.685877Z","steps":["trace[568024789] 'range keys from in-memory index tree' (duration: 198.235045ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.502691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.128427ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:18:55.50277Z","caller":"traceutil/trace.go:171","msg":"trace[1098791756] linearizableReadLoop","detail":"{readStateIndex:1910; appliedIndex:1909; }","duration":"161.000166ms","start":"2026-05-08T10:18:55.341759Z","end":"2026-05-08T10:18:55.502759Z","steps":["trace[1098791756] 'read index received' (duration: 35.96µs)","trace[1098791756] 'applied index is now lower than readState.Index' (duration: 160.963406ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:18:55.502941Z","caller":"traceutil/trace.go:171","msg":"trace[1090815426] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"384.751098ms","start":"2026-05-08T10:18:55.118177Z","end":"2026-05-08T10:18:55.502928Z","steps":["trace[1090815426] 'process raft request' (duration: 152.326364ms)","trace[1090815426] 'compare' (duration: 231.874143ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:18:55.503006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:18:55.118158Z","time spent":"384.81789ms","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:18:55.503182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.419686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:18:55.503222Z","caller":"traceutil/trace.go:171","msg":"trace[1504197572] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1834; }","duration":"161.483347ms","start":"2026-05-08T10:18:55.341726Z","end":"2026-05-08T10:18:55.503209Z","steps":["trace[1504197572] 'agreement among raft nodes before linearized reading' (duration: 161.428256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.503348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.923646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-08T10:18:55.503362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.164551ms","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-08T10:18:55.503386Z","caller":"traceutil/trace.go:171","msg":"trace[1816616073] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1834; }","duration":"137.984868ms","start":"2026-05-08T10:18:55.365391Z","end":"2026-05-08T10:18:55.503376Z","steps":["trace[1816616073] 'agreement among raft nodes before linearized reading' (duration: 137.853796ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:18:55.503426Z","caller":"traceutil/trace.go:171","msg":"trace[872966794] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1834; }","duration":"127.251013ms","start":"2026-05-08T10:18:55.376157Z","end":"2026-05-08T10:18:55.503408Z","steps":["trace[872966794] 'agreement among raft nodes before linearized reading' (duration: 127.09147ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:18:55.878438Z","caller":"traceutil/trace.go:171","msg":"trace[1416600058] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"370.863591ms","start":"2026-05-08T10:18:55.507539Z","end":"2026-05-08T10:18:55.878402Z","steps":["trace[1416600058] 'process raft request' (duration: 290.852482ms)","trace[1416600058] 'compare' (duration: 79.752993ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:18:55.878625Z","caller":"traceutil/trace.go:171","msg":"trace[343907025] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"368.468163ms","start":"2026-05-08T10:18:55.510143Z","end":"2026-05-08T10:18:55.878611Z","steps":["trace[343907025] 'process raft request' (duration: 368.164456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.878734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:18:55.510132Z","time spent":"368.525494ms","remote":"127.0.0.1:34354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:18:55.878839Z","caller":"traceutil/trace.go:171","msg":"trace[948498581] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1910; }","duration":"307.582376ms","start":"2026-05-08T10:18:55.571227Z","end":"2026-05-08T10:18:55.878809Z","steps":["trace[948498581] 'read index received' (duration: 1.647772ms)","trace[948498581] 'applied index is now lower than readState.Index' (duration: 305.932914ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:18:55.879055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.819691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-08T10:18:55.879123Z","caller":"traceutil/trace.go:171","msg":"trace[459567887] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1838; }","duration":"307.924383ms","start":"2026-05-08T10:18:55.571183Z","end":"2026-05-08T10:18:55.879107Z","steps":["trace[459567887] 'agreement among raft nodes before linearized reading' (duration: 307.755989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.879165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:18:55.571164Z","time spent":"307.988754ms","remote":"127.0.0.1:54260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5465,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-08T10:18:55.87917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.931255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-186227f6-15c4-470e-b9b1-920e32433a51\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-05-08T10:18:55.879212Z","caller":"traceutil/trace.go:171","msg":"trace[1234401865] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-186227f6-15c4-470e-b9b1-920e32433a51; range_end:; response_count:1; response_revision:1838; }","duration":"185.009476ms","start":"2026-05-08T10:18:55.694189Z","end":"2026-05-08T10:18:55.879199Z","steps":["trace[1234401865] 'agreement among raft nodes before linearized reading' (duration: 184.929345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.87939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.325084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-05-08T10:18:55.87942Z","caller":"traceutil/trace.go:171","msg":"trace[437400145] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1838; }","duration":"138.385855ms","start":"2026-05-08T10:18:55.741023Z","end":"2026-05-08T10:18:55.879409Z","steps":["trace[437400145] 'agreement among raft nodes before linearized reading' (duration: 138.307754ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.879507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:18:55.507529Z","time spent":"371.938142ms","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:18:56.160803Z","caller":"traceutil/trace.go:171","msg":"trace[1831965908] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"276.287191ms","start":"2026-05-08T10:18:55.884459Z","end":"2026-05-08T10:18:56.160746Z","steps":["trace[1831965908] 'process raft request' (duration: 276.156349ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:18:56.160809Z","caller":"traceutil/trace.go:171","msg":"trace[1169851654] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"276.571767ms","start":"2026-05-08T10:18:55.884208Z","end":"2026-05-08T10:18:56.160779Z","steps":["trace[1169851654] 'process raft request' (duration: 228.52228ms)","trace[1169851654] 'compare' (duration: 47.383534ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:19:29.08198Z","caller":"traceutil/trace.go:171","msg":"trace[1169087563] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"118.660204ms","start":"2026-05-08T10:19:28.963278Z","end":"2026-05-08T10:19:29.081939Z","steps":["trace[1169087563] 'process raft request' (duration: 64.00605ms)","trace[1169087563] 'compare' (duration: 53.90989ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:19:29.087892Z","caller":"traceutil/trace.go:171","msg":"trace[2056605450] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"121.331503ms","start":"2026-05-08T10:19:28.966438Z","end":"2026-05-08T10:19:29.087769Z","steps":["trace[2056605450] 'process raft request' (duration: 121.208081ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:19:29.900077Z","caller":"traceutil/trace.go:171","msg":"trace[1620034513] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"159.002782ms","start":"2026-05-08T10:19:29.741041Z","end":"2026-05-08T10:19:29.900044Z","steps":["trace[1620034513] 'process raft request' (duration: 158.871759ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:19:30.178041Z","caller":"traceutil/trace.go:171","msg":"trace[1890664422] transaction","detail":"{read_only:false; response_revision:2081; number_of_response:1; }","duration":"229.7844ms","start":"2026-05-08T10:19:29.948207Z","end":"2026-05-08T10:19:30.177991Z","steps":["trace[1890664422] 'process raft request' (duration: 229.481484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:19:30.17825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.926045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-08T10:19:30.178306Z","caller":"traceutil/trace.go:171","msg":"trace[165173886] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2081; }","duration":"215.019416ms","start":"2026-05-08T10:19:29.96327Z","end":"2026-05-08T10:19:30.17829Z","steps":["trace[165173886] 'agreement among raft nodes before linearized reading' (duration: 214.816221ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:19:30.179973Z","caller":"traceutil/trace.go:171","msg":"trace[1512927457] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"165.732281ms","start":"2026-05-08T10:19:30.014225Z","end":"2026-05-08T10:19:30.179957Z","steps":["trace[1512927457] 'process raft request' (duration: 165.68688ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:19:30.180191Z","caller":"traceutil/trace.go:171","msg":"trace[1936550801] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"174.816589ms","start":"2026-05-08T10:19:30.00536Z","end":"2026-05-08T10:19:30.180177Z","steps":["trace[1936550801] 'process raft request' (duration: 174.475653ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:19:30.184061Z","caller":"traceutil/trace.go:171","msg":"trace[1408187307] linearizableReadLoop","detail":"{readStateIndex:2164; appliedIndex:2163; }","duration":"220.726532ms","start":"2026-05-08T10:19:29.963317Z","end":"2026-05-08T10:19:30.184043Z","steps":["trace[1408187307] 'read index received' (duration: 214.451405ms)","trace[1408187307] 'applied index is now lower than readState.Index' (duration: 136.492µs)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:19:30.185613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.753621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-08T10:19:30.185653Z","caller":"traceutil/trace.go:171","msg":"trace[1511136584] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2084; }","duration":"152.831982ms","start":"2026-05-08T10:19:30.032811Z","end":"2026-05-08T10:19:30.185643Z","steps":["trace[1511136584] 'agreement among raft nodes before linearized reading' (duration: 152.710959ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:20:26.479994Z","caller":"traceutil/trace.go:171","msg":"trace[1238210046] transaction","detail":"{read_only:false; response_revision:2432; number_of_response:1; }","duration":"119.279443ms","start":"2026-05-08T10:20:26.360688Z","end":"2026-05-08T10:20:26.479968Z","steps":["trace[1238210046] 'process raft request' (duration: 118.935716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:08.176157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.738542ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:38"} {"level":"info","ts":"2026-05-08T10:21:08.195905Z","caller":"traceutil/trace.go:171","msg":"trace[196910898] transaction","detail":"{read_only:false; response_revision:2711; number_of_response:1; }","duration":"139.934949ms","start":"2026-05-08T10:21:08.055941Z","end":"2026-05-08T10:21:08.195876Z","steps":["trace[196910898] 'process raft request' (duration: 139.768743ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:32.722141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.399108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-08T10:21:32.722397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.354342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:32.722499Z","caller":"traceutil/trace.go:171","msg":"trace[100706095] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2836; }","duration":"821.482856ms","start":"2026-05-08T10:21:31.900974Z","end":"2026-05-08T10:21:32.722457Z","steps":["trace[100706095] 'count revisions from in-memory index tree' (duration: 821.288289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:32.722539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:31.900959Z","time spent":"821.570259ms","remote":"127.0.0.1:42910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":26,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-05-08T10:21:32.722564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.579062ms","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-08T10:21:32.722608Z","caller":"traceutil/trace.go:171","msg":"trace[306303088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2836; }","duration":"756.645724ms","start":"2026-05-08T10:21:31.965948Z","end":"2026-05-08T10:21:32.722594Z","steps":["trace[306303088] 'range keys from in-memory index tree' (duration: 756.463967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:32.722641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:31.965933Z","time spent":"756.700285ms","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-08T10:21:32.722862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.109852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:32.723107Z","caller":"traceutil/trace.go:171","msg":"trace[1175556117] linearizableReadLoop","detail":"{readStateIndex:2947; appliedIndex:2946; }","duration":"156.494234ms","start":"2026-05-08T10:21:32.566603Z","end":"2026-05-08T10:21:32.723097Z","steps":["trace[1175556117] 'read index received' (duration: 156.408301ms)","trace[1175556117] 'applied index is now lower than readState.Index' (duration: 85.273µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:21:32.723039Z","caller":"traceutil/trace.go:171","msg":"trace[1524892286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2836; }","duration":"594.236656ms","start":"2026-05-08T10:21:32.128694Z","end":"2026-05-08T10:21:32.722931Z","steps":["trace[1524892286] 'range keys from in-memory index tree' (duration: 594.029049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:32.723219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.623898ms","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-08T10:21:32.723243Z","caller":"traceutil/trace.go:171","msg":"trace[968880137] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2837; }","duration":"156.6831ms","start":"2026-05-08T10:21:32.566551Z","end":"2026-05-08T10:21:32.723234Z","steps":["trace[968880137] 'agreement among raft nodes before linearized reading' (duration: 156.583157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:32.723242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.128677Z","time spent":"594.552626ms","remote":"127.0.0.1:34176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T10:21:32.723344Z","caller":"traceutil/trace.go:171","msg":"trace[494305339] transaction","detail":"{read_only:false; response_revision:2837; number_of_response:1; }","duration":"406.100675ms","start":"2026-05-08T10:21:32.317235Z","end":"2026-05-08T10:21:32.723336Z","steps":["trace[494305339] 'process raft request' (duration: 405.708862ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:32.723481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.317215Z","time spent":"406.218599ms","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:21:32.722215Z","caller":"traceutil/trace.go:171","msg":"trace[840707525] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2836; }","duration":"620.523372ms","start":"2026-05-08T10:21:32.101675Z","end":"2026-05-08T10:21:32.722199Z","steps":["trace[840707525] 'count revisions from in-memory index tree' (duration: 620.315945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:32.723884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.101657Z","time spent":"622.216528ms","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":28,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-05-08T10:21:33.23025Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880793739302598,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:21:33.730391Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880793739302598,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:21:34.231344Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880793739302598,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:21:34.730104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000507579s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-08T10:21:34.730186Z","caller":"traceutil/trace.go:171","msg":"trace[2089685271] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000621602s","start":"2026-05-08T10:21:32.729547Z","end":"2026-05-08T10:21:34.730168Z","steps":["trace[2089685271] 'agreement among raft nodes before linearized reading' (duration: 2.000528369s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:34.730218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.729532Z","time spent":"2.000680125s","remote":"127.0.0.1:34174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/08 10:21:34 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-08T10:21:34.73228Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880793739302598,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:21:35.233126Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880793739302598,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:21:35.327725Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.605782125s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T10:21:35.331743Z","caller":"traceutil/trace.go:171","msg":"trace[1091494249] transaction","detail":"{read_only:false; response_revision:2838; number_of_response:1; }","duration":"2.652908892s","start":"2026-05-08T10:21:32.678818Z","end":"2026-05-08T10:21:35.331727Z","steps":["trace[1091494249] 'process raft request' (duration: 2.649121286s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.331844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.678797Z","time spent":"2.652993964s","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:21:35.332296Z","caller":"traceutil/trace.go:171","msg":"trace[883208877] transaction","detail":"{read_only:false; response_revision:2840; number_of_response:1; }","duration":"2.605449472s","start":"2026-05-08T10:21:32.726825Z","end":"2026-05-08T10:21:35.332274Z","steps":["trace[883208877] 'process raft request' (duration: 2.605306127s)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:21:35.332353Z","caller":"traceutil/trace.go:171","msg":"trace[1038452712] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"2.626861383s","start":"2026-05-08T10:21:32.705484Z","end":"2026-05-08T10:21:35.332345Z","steps":["trace[1038452712] 'process raft request' (duration: 2.626192441s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.332419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.705462Z","time spent":"2.626917434s","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:21:35.332413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.726801Z","time spent":"2.605557146s","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:21:35.332297Z","caller":"traceutil/trace.go:171","msg":"trace[1813470512] transaction","detail":"{read_only:false; response_revision:2841; number_of_response:1; }","duration":"2.604941154s","start":"2026-05-08T10:21:32.727338Z","end":"2026-05-08T10:21:35.332279Z","steps":["trace[1813470512] 'process raft request' (duration: 2.60483066s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.332784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.727327Z","time spent":"2.605421802s","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:21:35.352067Z","caller":"traceutil/trace.go:171","msg":"trace[1602604096] transaction","detail":"{read_only:false; response_revision:2843; number_of_response:1; }","duration":"502.187741ms","start":"2026-05-08T10:21:34.84986Z","end":"2026-05-08T10:21:35.352048Z","steps":["trace[1602604096] 'process raft request' (duration: 502.137819ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:21:35.352098Z","caller":"traceutil/trace.go:171","msg":"trace[2069427746] transaction","detail":"{read_only:false; response_revision:2842; number_of_response:1; }","duration":"618.081019ms","start":"2026-05-08T10:21:34.733992Z","end":"2026-05-08T10:21:35.352073Z","steps":["trace[2069427746] 'process raft request' (duration: 617.891663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.352184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:34.849835Z","time spent":"502.298564ms","remote":"127.0.0.1:34178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:21:35.352219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:34.733969Z","time spent":"618.187514ms","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:21:35.352299Z","caller":"traceutil/trace.go:171","msg":"trace[989771871] transaction","detail":"{read_only:false; response_revision:2844; number_of_response:1; }","duration":"151.781194ms","start":"2026-05-08T10:21:35.200498Z","end":"2026-05-08T10:21:35.352279Z","steps":["trace[989771871] 'process raft request' (duration: 151.522605ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:21:35.352579Z","caller":"traceutil/trace.go:171","msg":"trace[296521766] linearizableReadLoop","detail":"{readStateIndex:2955; appliedIndex:2947; }","duration":"2.622523171s","start":"2026-05-08T10:21:32.729575Z","end":"2026-05-08T10:21:35.352098Z","steps":["trace[296521766] 'read index received' (duration: 2.598320764s)","trace[296521766] 'applied index is now lower than readState.Index' (duration: 24.201717ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:21:35.352754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.709864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T10:21:35.352789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.048998095s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T10:21:35.352784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.166861ms","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":"info","ts":"2026-05-08T10:21:35.352811Z","caller":"traceutil/trace.go:171","msg":"trace[876112452] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2844; }","duration":"1.049052026s","start":"2026-05-08T10:21:34.30375Z","end":"2026-05-08T10:21:35.352802Z","steps":["trace[876112452] 'agreement among raft nodes before linearized reading' (duration: 1.049025955s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.352836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:34.30373Z","time spent":"1.049102298s","remote":"127.0.0.1:42756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-05-08T10:21:35.352843Z","caller":"traceutil/trace.go:171","msg":"trace[1170018475] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2844; }","duration":"341.229584ms","start":"2026-05-08T10:21:35.011582Z","end":"2026-05-08T10:21:35.352812Z","steps":["trace[1170018475] 'agreement among raft nodes before linearized reading' (duration: 341.098739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.352858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.161304239s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"} {"level":"warn","ts":"2026-05-08T10:21:35.352873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:35.011568Z","time spent":"341.297365ms","remote":"127.0.0.1:34366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2011,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"info","ts":"2026-05-08T10:21:35.352884Z","caller":"traceutil/trace.go:171","msg":"trace[326284282] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2844; }","duration":"2.161342311s","start":"2026-05-08T10:21:33.191529Z","end":"2026-05-08T10:21:35.352871Z","steps":["trace[326284282] 'agreement among raft nodes before linearized reading' (duration: 2.161296939s)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:21:35.352794Z","caller":"traceutil/trace.go:171","msg":"trace[1517181593] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2844; }","duration":"590.761366ms","start":"2026-05-08T10:21:34.762023Z","end":"2026-05-08T10:21:35.352784Z","steps":["trace[1517181593] 'agreement among raft nodes before linearized reading' (duration: 590.691523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.352918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:33.191518Z","time spent":"2.161391052s","remote":"127.0.0.1:34366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1387,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-05-08T10:21:35.352941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:34.762015Z","time spent":"590.919791ms","remote":"127.0.0.1:49874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-08T10:21:35.352977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.187037773s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:35.352993Z","caller":"traceutil/trace.go:171","msg":"trace[480069234] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:2844; }","duration":"2.187091584s","start":"2026-05-08T10:21:33.165895Z","end":"2026-05-08T10:21:35.352986Z","steps":["trace[480069234] 'agreement among raft nodes before linearized reading' (duration: 2.187067244s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.352995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.447259064s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"warn","ts":"2026-05-08T10:21:35.353011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:33.165875Z","time spent":"2.187132036s","remote":"127.0.0.1:54276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":26,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"warn","ts":"2026-05-08T10:21:35.352756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.206038292s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T10:21:35.353041Z","caller":"traceutil/trace.go:171","msg":"trace[791903547] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2844; }","duration":"1.206375202s","start":"2026-05-08T10:21:34.146659Z","end":"2026-05-08T10:21:35.353035Z","steps":["trace[791903547] 'agreement among raft nodes before linearized reading' (duration: 1.206064192s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.353065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:34.146637Z","time spent":"1.206419814s","remote":"127.0.0.1:49836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":28,"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-08T10:21:35.353128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.338782129s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T10:21:35.353145Z","caller":"traceutil/trace.go:171","msg":"trace[826193502] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2844; }","duration":"2.338842682s","start":"2026-05-08T10:21:33.014298Z","end":"2026-05-08T10:21:35.353141Z","steps":["trace[826193502] 'agreement among raft nodes before linearized reading' (duration: 2.33881146s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.353159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:33.01428Z","time spent":"2.338875742s","remote":"127.0.0.1:34640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":3,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-05-08T10:21:35.352811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.419798309s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-05-08T10:21:35.3532Z","caller":"traceutil/trace.go:171","msg":"trace[432423980] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2844; }","duration":"2.420213193s","start":"2026-05-08T10:21:32.932981Z","end":"2026-05-08T10:21:35.353194Z","steps":["trace[432423980] 'agreement among raft nodes before linearized reading' (duration: 2.419755028s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.353219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.932968Z","time spent":"2.420246054s","remote":"127.0.0.1:34354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12234,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-08T10:21:35.352915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.450451992s","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-08T10:21:35.353336Z","caller":"traceutil/trace.go:171","msg":"trace[1033073691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2844; }","duration":"2.450911377s","start":"2026-05-08T10:21:32.90242Z","end":"2026-05-08T10:21:35.353331Z","steps":["trace[1033073691] 'agreement among raft nodes before linearized reading' (duration: 2.45040444s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.353348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.65639724s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-08T10:21:35.353353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.9024Z","time spent":"2.450949008s","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-08T10:21:35.353363Z","caller":"traceutil/trace.go:171","msg":"trace[1050106913] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2844; }","duration":"1.656428602s","start":"2026-05-08T10:21:33.69693Z","end":"2026-05-08T10:21:35.353359Z","steps":["trace[1050106913] 'agreement among raft nodes before linearized reading' (duration: 1.65638275s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.353381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:33.696924Z","time spent":"1.656452992s","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-08T10:21:35.353057Z","caller":"traceutil/trace.go:171","msg":"trace[351178225] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2844; }","duration":"2.447306706s","start":"2026-05-08T10:21:32.905706Z","end":"2026-05-08T10:21:35.353013Z","steps":["trace[351178225] 'agreement among raft nodes before linearized reading' (duration: 2.447225064s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.353537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.506320994s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T10:21:35.353556Z","caller":"traceutil/trace.go:171","msg":"trace[2032054816] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2844; }","duration":"2.506363196s","start":"2026-05-08T10:21:32.847189Z","end":"2026-05-08T10:21:35.353552Z","steps":["trace[2032054816] 'agreement among raft nodes before linearized reading' (duration: 2.506329495s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.353567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.528411679s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-08T10:21:35.35357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.847177Z","time spent":"2.506389207s","remote":"127.0.0.1:34542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":28,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-05-08T10:21:35.353587Z","caller":"traceutil/trace.go:171","msg":"trace[78533276] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2844; }","duration":"2.528460991s","start":"2026-05-08T10:21:32.825122Z","end":"2026-05-08T10:21:35.353583Z","steps":["trace[78533276] 'agreement among raft nodes before linearized reading' (duration: 2.52841692s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.353605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.825106Z","time spent":"2.528495032s","remote":"127.0.0.1:34512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":23,"response size":28,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-05-08T10:21:35.353724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.656807973s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-08T10:21:35.353786Z","caller":"traceutil/trace.go:171","msg":"trace[876211354] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2844; }","duration":"1.656909667s","start":"2026-05-08T10:21:33.696866Z","end":"2026-05-08T10:21:35.353776Z","steps":["trace[876211354] 'agreement among raft nodes before linearized reading' (duration: 1.656757492s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.353486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.905692Z","time spent":"2.447775651s","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":592,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-05-08T10:21:35.353838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.870542953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ad8fe69aa1388f\" ","response":"range_response_count:1 size:781"} {"level":"warn","ts":"2026-05-08T10:21:35.353839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:33.696844Z","time spent":"1.656965649s","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-08T10:21:35.353861Z","caller":"traceutil/trace.go:171","msg":"trace[1177521935] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ad8fe69aa1388f; range_end:; response_count:1; response_revision:2844; }","duration":"1.870604605s","start":"2026-05-08T10:21:33.483251Z","end":"2026-05-08T10:21:35.353856Z","steps":["trace[1177521935] 'agreement among raft nodes before linearized reading' (duration: 1.869421576s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.353877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:33.48323Z","time spent":"1.870643537s","remote":"127.0.0.1:34252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":802,"request content":"key:\"/registry/events/auth-system/keycloak-0.18ad8fe69aa1388f\" "} {"level":"warn","ts":"2026-05-08T10:21:35.354102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.672869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:35.354282Z","caller":"traceutil/trace.go:171","msg":"trace[883058609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2844; }","duration":"615.849585ms","start":"2026-05-08T10:21:34.738395Z","end":"2026-05-08T10:21:35.354245Z","steps":["trace[883058609] 'agreement among raft nodes before linearized reading' (duration: 615.667879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.354324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:34.738386Z","time spent":"615.928018ms","remote":"127.0.0.1:34176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T10:21:35.354677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.568205528s","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-08T10:21:35.354705Z","caller":"traceutil/trace.go:171","msg":"trace[1872360865] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2844; }","duration":"2.568290751s","start":"2026-05-08T10:21:32.786408Z","end":"2026-05-08T10:21:35.354699Z","steps":["trace[1872360865] 'agreement among raft nodes before linearized reading' (duration: 2.566253044s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:35.354737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:32.786388Z","time spent":"2.568343393s","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}