{"level":"warn","ts":"2026-04-09T17:35:19.247105Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-09T17:35:19.247207Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-09T17:35:19.247282Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-09T17:35:19.247299Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-04-09T17:35:19.247318Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-09T17:35:19.247951Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-04-09T17:35:19.24803Z","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":16,"max-cpu-available":16,"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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-09T17:35:19.251967Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.726938ms"} {"level":"info","ts":"2026-04-09T17:35:19.25737Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-04-09T17:35:19.257575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-04-09T17:35:19.2576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-04-09T17:35:19.257617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-09T17:35:19.257627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-04-09T17:35:19.257689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-04-09T17:35:19.264629Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-09T17:35:19.266675Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-09T17:35:19.268019Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-09T17:35:19.271182Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-09T17:35:19.271487Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-09T17:35:19.271673Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-09T17:35:19.271786Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-09T17:35:19.271802Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-09T17:35:19.273146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-04-09T17:35:19.274811Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-04-09T17:35:19.276725Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-09T17:35:19.276904Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-04-09T17:35:19.276977Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-04-09T17:35:19.277157Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-09T17:35:19.277209Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-09T17:35:20.258023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-04-09T17:35:20.258147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-09T17:35:20.258213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-04-09T17:35:20.258243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-04-09T17:35:20.258256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-04-09T17:35:20.258274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-04-09T17:35:20.258299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-04-09T17:35:20.25929Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T17:35:20.259969Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T17:35:20.259997Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T17:35:20.259975Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-04-09T17:35:20.260378Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-09T17:35:20.260403Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-09T17:35:20.260677Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T17:35:20.260911Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T17:35:20.260981Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T17:35:20.263912Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-09T17:35:20.263927Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"warn","ts":"2026-04-09T17:35:36.043449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.471209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-09T17:35:36.043639Z","caller":"traceutil/trace.go:171","msg":"trace[638426842] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:409; }","duration":"167.685374ms","start":"2026-04-09T17:35:35.875923Z","end":"2026-04-09T17:35:36.043608Z","steps":["trace[638426842] 'range keys from in-memory index tree' (duration: 167.297956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:35:36.043769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.979337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-09T17:35:36.043512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.188642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-09T17:35:36.043894Z","caller":"traceutil/trace.go:171","msg":"trace[125997468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:409; }","duration":"175.105139ms","start":"2026-04-09T17:35:35.868747Z","end":"2026-04-09T17:35:36.043852Z","steps":["trace[125997468] 'range keys from in-memory index tree' (duration: 174.877195ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:35:36.043935Z","caller":"traceutil/trace.go:171","msg":"trace[1948668896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:409; }","duration":"252.601629ms","start":"2026-04-09T17:35:35.791261Z","end":"2026-04-09T17:35:36.043863Z","steps":["trace[1948668896] 'range keys from in-memory index tree' (duration: 251.985878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:35:36.043703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.731032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T17:35:36.044494Z","caller":"traceutil/trace.go:171","msg":"trace[413386256] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"187.184041ms","start":"2026-04-09T17:35:35.856876Z","end":"2026-04-09T17:35:36.04406Z","steps":["trace[413386256] 'range keys from in-memory index tree' (duration: 186.620491ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:35:54.550932Z","caller":"traceutil/trace.go:171","msg":"trace[803255453] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"271.786443ms","start":"2026-04-09T17:35:54.279105Z","end":"2026-04-09T17:35:54.550891Z","steps":["trace[803255453] 'process raft request' (duration: 211.309053ms)","trace[803255453] 'compare' (duration: 60.136045ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T17:35:54.551318Z","caller":"traceutil/trace.go:171","msg":"trace[2004442014] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"272.006137ms","start":"2026-04-09T17:35:54.279293Z","end":"2026-04-09T17:35:54.551299Z","steps":["trace[2004442014] 'process raft request' (duration: 271.515229ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:35:54.551378Z","caller":"traceutil/trace.go:171","msg":"trace[1057134107] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"259.912051ms","start":"2026-04-09T17:35:54.29143Z","end":"2026-04-09T17:35:54.551342Z","steps":["trace[1057134107] 'process raft request' (duration: 259.721457ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:36:00.510733Z","caller":"traceutil/trace.go:171","msg":"trace[1570664582] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"108.983508ms","start":"2026-04-09T17:36:00.401707Z","end":"2026-04-09T17:36:00.510691Z","steps":["trace[1570664582] 'process raft request' (duration: 108.5694ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:36:00.696037Z","caller":"traceutil/trace.go:171","msg":"trace[1986208295] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"155.803265ms","start":"2026-04-09T17:36:00.540206Z","end":"2026-04-09T17:36:00.696009Z","steps":["trace[1986208295] 'process raft request' (duration: 153.585777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:36:01.1741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.914783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-09T17:36:01.174255Z","caller":"traceutil/trace.go:171","msg":"trace[44496409] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"362.623392ms","start":"2026-04-09T17:36:00.811608Z","end":"2026-04-09T17:36:01.174232Z","steps":["trace[44496409] 'read index received' (duration: 193.627691ms)","trace[44496409] 'applied index is now lower than readState.Index' (duration: 168.99372ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T17:36:01.174342Z","caller":"traceutil/trace.go:171","msg":"trace[1059247809] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"417.512348ms","start":"2026-04-09T17:36:00.756781Z","end":"2026-04-09T17:36:01.174293Z","steps":["trace[1059247809] 'process raft request' (duration: 248.425155ms)","trace[1059247809] 'compare' (duration: 167.398073ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T17:36:01.174453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.831206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T17:36:01.174744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.277172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T17:36:01.174755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T17:36:00.756748Z","time spent":"417.939465ms","remote":"127.0.0.1:34244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-09T17:36:01.174819Z","caller":"traceutil/trace.go:171","msg":"trace[1483103276] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:627; }","duration":"363.242033ms","start":"2026-04-09T17:36:00.811548Z","end":"2026-04-09T17:36:01.17479Z","steps":["trace[1483103276] 'agreement among raft nodes before linearized reading' (duration: 362.774945ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:36:01.17486Z","caller":"traceutil/trace.go:171","msg":"trace[1662571864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"316.435175ms","start":"2026-04-09T17:36:00.858399Z","end":"2026-04-09T17:36:01.174835Z","steps":["trace[1662571864] 'agreement among raft nodes before linearized reading' (duration: 316.243462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:36:01.17489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T17:36:00.811519Z","time spent":"363.352054ms","remote":"127.0.0.1:56246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-09T17:36:01.174917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T17:36:00.85839Z","time spent":"316.517556ms","remote":"127.0.0.1:33746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-09T17:36:01.174876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.874502ms","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:5"} {"level":"warn","ts":"2026-04-09T17:36:01.174536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.136081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T17:36:01.175059Z","caller":"traceutil/trace.go:171","msg":"trace[1894980203] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:627; }","duration":"341.145666ms","start":"2026-04-09T17:36:00.833861Z","end":"2026-04-09T17:36:01.175007Z","steps":["trace[1894980203] 'agreement among raft nodes before linearized reading' (duration: 340.744409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:36:01.17512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.116611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T17:36:01.175203Z","caller":"traceutil/trace.go:171","msg":"trace[769495719] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:627; }","duration":"295.224192ms","start":"2026-04-09T17:36:00.879961Z","end":"2026-04-09T17:36:01.175185Z","steps":["trace[769495719] 'agreement among raft nodes before linearized reading' (duration: 294.545791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:36:01.17518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T17:36:00.833834Z","time spent":"341.321579ms","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"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-04-09T17:36:01.17489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.089537ms","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:5"} {"level":"info","ts":"2026-04-09T17:36:01.175135Z","caller":"traceutil/trace.go:171","msg":"trace[980512619] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:627; }","duration":"295.778961ms","start":"2026-04-09T17:36:00.879342Z","end":"2026-04-09T17:36:01.175121Z","steps":["trace[980512619] 'agreement among raft nodes before linearized reading' (duration: 295.158911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:36:01.174558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.249593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T17:36:01.174587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.994748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T17:36:01.175397Z","caller":"traceutil/trace.go:171","msg":"trace[2095882441] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:627; }","duration":"296.109927ms","start":"2026-04-09T17:36:00.879274Z","end":"2026-04-09T17:36:01.175384Z","steps":["trace[2095882441] 'agreement among raft nodes before linearized reading' (duration: 295.244563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:36:01.174617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.880894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T17:36:01.174612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.680548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T17:36:01.17542Z","caller":"traceutil/trace.go:171","msg":"trace[1372659469] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:627; }","duration":"320.700907ms","start":"2026-04-09T17:36:00.854626Z","end":"2026-04-09T17:36:01.175326Z","steps":["trace[1372659469] 'agreement among raft nodes before linearized reading' (duration: 319.926044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:36:01.175589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T17:36:00.85461Z","time spent":"320.957751ms","remote":"127.0.0.1:56262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-09T17:36:01.175491Z","caller":"traceutil/trace.go:171","msg":"trace[1289560617] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:627; }","duration":"341.569902ms","start":"2026-04-09T17:36:00.833912Z","end":"2026-04-09T17:36:01.175482Z","steps":["trace[1289560617] 'agreement among raft nodes before linearized reading' (duration: 340.663177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:36:01.17621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T17:36:00.833908Z","time spent":"342.277576ms","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-09T17:36:01.175576Z","caller":"traceutil/trace.go:171","msg":"trace[663763751] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:627; }","duration":"320.764058ms","start":"2026-04-09T17:36:00.854727Z","end":"2026-04-09T17:36:01.175492Z","steps":["trace[663763751] 'agreement among raft nodes before linearized reading' (duration: 319.860924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:36:01.17645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T17:36:00.854719Z","time spent":"321.717295ms","remote":"127.0.0.1:56262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-09T17:36:01.175447Z","caller":"traceutil/trace.go:171","msg":"trace[1921033225] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:627; }","duration":"319.924413ms","start":"2026-04-09T17:36:00.855506Z","end":"2026-04-09T17:36:01.17543Z","steps":["trace[1921033225] 'agreement among raft nodes before linearized reading' (duration: 318.972838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:36:01.174602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.915787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T17:36:01.176794Z","caller":"traceutil/trace.go:171","msg":"trace[743878436] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:627; }","duration":"365.196535ms","start":"2026-04-09T17:36:00.811578Z","end":"2026-04-09T17:36:01.176775Z","steps":["trace[743878436] 'agreement among raft nodes before linearized reading' (duration: 362.886527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:36:01.176903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T17:36:00.811553Z","time spent":"365.316928ms","remote":"127.0.0.1:56246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-09T17:36:01.176972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T17:36:00.85548Z","time spent":"321.144994ms","remote":"127.0.0.1:56254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-04-09T17:36:43.801507Z","caller":"traceutil/trace.go:171","msg":"trace[1415751082] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"169.996058ms","start":"2026-04-09T17:36:43.631477Z","end":"2026-04-09T17:36:43.801474Z","steps":["trace[1415751082] 'process raft request' (duration: 169.785745ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:37:31.412681Z","caller":"traceutil/trace.go:171","msg":"trace[316510649] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"178.411689ms","start":"2026-04-09T17:37:31.234234Z","end":"2026-04-09T17:37:31.412646Z","steps":["trace[316510649] 'process raft request' (duration: 178.226036ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:38:15.906015Z","caller":"traceutil/trace.go:171","msg":"trace[1735528432] linearizableReadLoop","detail":"{readStateIndex:2226; appliedIndex:2225; }","duration":"126.592313ms","start":"2026-04-09T17:38:15.77939Z","end":"2026-04-09T17:38:15.905982Z","steps":["trace[1735528432] 'read index received' (duration: 99.735878ms)","trace[1735528432] 'applied index is now lower than readState.Index' (duration: 26.855285ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T17:38:15.906056Z","caller":"traceutil/trace.go:171","msg":"trace[1686513340] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"163.257014ms","start":"2026-04-09T17:38:15.742757Z","end":"2026-04-09T17:38:15.906014Z","steps":["trace[1686513340] 'process raft request' (duration: 136.419088ms)","trace[1686513340] 'compare' (duration: 26.681393ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T17:38:15.906276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.851749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-09T17:38:15.906423Z","caller":"traceutil/trace.go:171","msg":"trace[362252773] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2146; }","duration":"127.055143ms","start":"2026-04-09T17:38:15.779339Z","end":"2026-04-09T17:38:15.906394Z","steps":["trace[362252773] 'agreement among raft nodes before linearized reading' (duration: 126.750296ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:39:45.680256Z","caller":"traceutil/trace.go:171","msg":"trace[2102225824] transaction","detail":"{read_only:false; response_revision:2821; number_of_response:1; }","duration":"177.616093ms","start":"2026-04-09T17:39:45.502606Z","end":"2026-04-09T17:39:45.680223Z","steps":["trace[2102225824] 'process raft request' (duration: 103.425959ms)","trace[2102225824] 'compare' (duration: 74.004501ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T17:39:45.68203Z","caller":"traceutil/trace.go:171","msg":"trace[1505702225] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"178.924727ms","start":"2026-04-09T17:39:45.503086Z","end":"2026-04-09T17:39:45.682011Z","steps":["trace[1505702225] 'process raft request' (duration: 178.849566ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:39:45.682213Z","caller":"traceutil/trace.go:171","msg":"trace[453807108] transaction","detail":"{read_only:false; response_revision:2824; number_of_response:1; }","duration":"130.245959ms","start":"2026-04-09T17:39:45.551958Z","end":"2026-04-09T17:39:45.682204Z","steps":["trace[453807108] 'process raft request' (duration: 130.017085ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:39:45.682255Z","caller":"traceutil/trace.go:171","msg":"trace[939168116] transaction","detail":"{read_only:false; response_revision:2822; number_of_response:1; }","duration":"179.540088ms","start":"2026-04-09T17:39:45.502704Z","end":"2026-04-09T17:39:45.682244Z","steps":["trace[939168116] 'process raft request' (duration: 179.134401ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:44:02.388912Z","caller":"traceutil/trace.go:171","msg":"trace[542852868] transaction","detail":"{read_only:false; response_revision:5101; number_of_response:1; }","duration":"266.040786ms","start":"2026-04-09T17:44:02.122849Z","end":"2026-04-09T17:44:02.388889Z","steps":["trace[542852868] 'process raft request' (duration: 217.99941ms)","trace[542852868] 'compare' (duration: 47.925164ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T17:44:02.44626Z","caller":"traceutil/trace.go:171","msg":"trace[1921324583] transaction","detail":"{read_only:false; response_revision:5102; number_of_response:1; }","duration":"146.029951ms","start":"2026-04-09T17:44:02.300188Z","end":"2026-04-09T17:44:02.446218Z","steps":["trace[1921324583] 'process raft request' (duration: 145.865747ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:44:24.521662Z","caller":"traceutil/trace.go:171","msg":"trace[1166176154] transaction","detail":"{read_only:false; response_revision:5527; number_of_response:1; }","duration":"136.602661ms","start":"2026-04-09T17:44:24.385025Z","end":"2026-04-09T17:44:24.521627Z","steps":["trace[1166176154] 'process raft request' (duration: 136.389427ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:44:35.547733Z","caller":"traceutil/trace.go:171","msg":"trace[2016298200] transaction","detail":"{read_only:false; response_revision:5686; number_of_response:1; }","duration":"142.056302ms","start":"2026-04-09T17:44:35.405649Z","end":"2026-04-09T17:44:35.547705Z","steps":["trace[2016298200] 'process raft request' (duration: 141.849679ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:44:35.548034Z","caller":"traceutil/trace.go:171","msg":"trace[261842335] transaction","detail":"{read_only:false; response_revision:5687; number_of_response:1; }","duration":"141.690276ms","start":"2026-04-09T17:44:35.406306Z","end":"2026-04-09T17:44:35.547996Z","steps":["trace[261842335] 'process raft request' (duration: 141.35986ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:44:35.548276Z","caller":"traceutil/trace.go:171","msg":"trace[1884552555] linearizableReadLoop","detail":"{readStateIndex:5895; appliedIndex:5892; }","duration":"106.698846ms","start":"2026-04-09T17:44:35.441542Z","end":"2026-04-09T17:44:35.548241Z","steps":["trace[1884552555] 'read index received' (duration: 105.973822ms)","trace[1884552555] 'applied index is now lower than readState.Index' (duration: 723.874µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T17:44:35.548424Z","caller":"traceutil/trace.go:171","msg":"trace[2072198549] transaction","detail":"{read_only:false; response_revision:5688; number_of_response:1; }","duration":"140.687157ms","start":"2026-04-09T17:44:35.407727Z","end":"2026-04-09T17:44:35.548414Z","steps":["trace[2072198549] 'process raft request' (duration: 140.219658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:44:35.548529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.942111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T17:44:35.548588Z","caller":"traceutil/trace.go:171","msg":"trace[1843357337] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:5688; }","duration":"107.084783ms","start":"2026-04-09T17:44:35.441485Z","end":"2026-04-09T17:44:35.54857Z","steps":["trace[1843357337] 'agreement among raft nodes before linearized reading' (duration: 106.954791ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:44:35.745974Z","caller":"traceutil/trace.go:171","msg":"trace[1078826522] transaction","detail":"{read_only:false; response_revision:5691; number_of_response:1; }","duration":"142.437981ms","start":"2026-04-09T17:44:35.603496Z","end":"2026-04-09T17:44:35.745934Z","steps":["trace[1078826522] 'process raft request' (duration: 83.165394ms)","trace[1078826522] 'compare' (duration: 58.977991ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T17:44:35.746461Z","caller":"traceutil/trace.go:171","msg":"trace[262988565] transaction","detail":"{read_only:false; response_revision:5692; number_of_response:1; }","duration":"142.91493ms","start":"2026-04-09T17:44:35.603499Z","end":"2026-04-09T17:44:35.746414Z","steps":["trace[262988565] 'process raft request' (duration: 142.363199ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:44:35.746649Z","caller":"traceutil/trace.go:171","msg":"trace[968920194] transaction","detail":"{read_only:false; response_revision:5693; number_of_response:1; }","duration":"142.343768ms","start":"2026-04-09T17:44:35.604266Z","end":"2026-04-09T17:44:35.74661Z","steps":["trace[968920194] 'process raft request' (duration: 141.87374ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:45:20.29565Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3013} {"level":"info","ts":"2026-04-09T17:45:20.380749Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3013,"took":"82.855168ms","hash":678737068,"current-db-size-bytes":58208256,"current-db-size":"58 MB","current-db-size-in-use-bytes":31203328,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-09T17:45:20.380826Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":678737068,"revision":3013,"compact-revision":-1} {"level":"info","ts":"2026-04-09T17:50:20.303687Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6074} {"level":"info","ts":"2026-04-09T17:50:20.398712Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6074,"took":"92.906958ms","hash":2965711515,"current-db-size-bytes":58208256,"current-db-size":"58 MB","current-db-size-in-use-bytes":23871488,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-09T17:50:20.398799Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2965711515,"revision":6074,"compact-revision":3013} {"level":"info","ts":"2026-04-09T17:51:00.302213Z","caller":"traceutil/trace.go:171","msg":"trace[329837611] transaction","detail":"{read_only:false; response_revision:8574; number_of_response:1; }","duration":"130.198857ms","start":"2026-04-09T17:51:00.171976Z","end":"2026-04-09T17:51:00.302175Z","steps":["trace[329837611] 'process raft request' (duration: 129.849291ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:51:01.874896Z","caller":"traceutil/trace.go:171","msg":"trace[1620196609] linearizableReadLoop","detail":"{readStateIndex:8883; appliedIndex:8882; }","duration":"157.362488ms","start":"2026-04-09T17:51:01.717504Z","end":"2026-04-09T17:51:01.874866Z","steps":["trace[1620196609] 'read index received' (duration: 127.284772ms)","trace[1620196609] 'applied index is now lower than readState.Index' (duration: 30.076946ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T17:51:01.875004Z","caller":"traceutil/trace.go:171","msg":"trace[320888770] transaction","detail":"{read_only:false; response_revision:8581; number_of_response:1; }","duration":"161.787132ms","start":"2026-04-09T17:51:01.713162Z","end":"2026-04-09T17:51:01.874949Z","steps":["trace[320888770] 'process raft request' (duration: 131.807668ms)","trace[320888770] 'compare' (duration: 29.710589ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T17:51:01.875243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.732566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-09T17:51:01.875319Z","caller":"traceutil/trace.go:171","msg":"trace[1684833478] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8581; }","duration":"157.819557ms","start":"2026-04-09T17:51:01.717484Z","end":"2026-04-09T17:51:01.875303Z","steps":["trace[1684833478] 'agreement among raft nodes before linearized reading' (duration: 157.544702ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:51:13.140427Z","caller":"traceutil/trace.go:171","msg":"trace[2005027658] transaction","detail":"{read_only:false; response_revision:8684; number_of_response:1; }","duration":"257.773595ms","start":"2026-04-09T17:51:12.88262Z","end":"2026-04-09T17:51:13.140394Z","steps":["trace[2005027658] 'process raft request' (duration: 257.50057ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:51:13.140718Z","caller":"traceutil/trace.go:171","msg":"trace[1401230278] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8685; }","duration":"257.196424ms","start":"2026-04-09T17:51:12.883505Z","end":"2026-04-09T17:51:13.140702Z","steps":["trace[1401230278] 'process raft request' (duration: 256.818348ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:51:13.140847Z","caller":"traceutil/trace.go:171","msg":"trace[699081902] linearizableReadLoop","detail":"{readStateIndex:8992; appliedIndex:8989; }","duration":"198.288488ms","start":"2026-04-09T17:51:12.942527Z","end":"2026-04-09T17:51:13.140815Z","steps":["trace[699081902] 'read index received' (duration: 197.668386ms)","trace[699081902] 'applied index is now lower than readState.Index' (duration: 618.892µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T17:51:13.140853Z","caller":"traceutil/trace.go:171","msg":"trace[1291907789] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8685; }","duration":"257.116374ms","start":"2026-04-09T17:51:12.883715Z","end":"2026-04-09T17:51:13.140831Z","steps":["trace[1291907789] 'process raft request' (duration: 256.935061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:51:13.141156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.618234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-09T17:51:13.14125Z","caller":"traceutil/trace.go:171","msg":"trace[1792258159] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8685; }","duration":"198.774427ms","start":"2026-04-09T17:51:12.942453Z","end":"2026-04-09T17:51:13.141227Z","steps":["trace[1792258159] 'agreement among raft nodes before linearized reading' (duration: 198.459921ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:51:13.149917Z","caller":"traceutil/trace.go:171","msg":"trace[111431523] transaction","detail":"{read_only:false; response_revision:8686; number_of_response:1; }","duration":"130.009564ms","start":"2026-04-09T17:51:13.019871Z","end":"2026-04-09T17:51:13.14988Z","steps":["trace[111431523] 'process raft request' (duration: 129.743779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T17:51:13.150018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.379424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-04-09T17:51:13.150026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.362028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T17:51:13.150077Z","caller":"traceutil/trace.go:171","msg":"trace[221616027] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8686; }","duration":"194.486336ms","start":"2026-04-09T17:51:12.955574Z","end":"2026-04-09T17:51:13.15006Z","steps":["trace[221616027] 'agreement among raft nodes before linearized reading' (duration: 194.248501ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:51:13.150099Z","caller":"traceutil/trace.go:171","msg":"trace[1668308510] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:8686; }","duration":"123.506642ms","start":"2026-04-09T17:51:13.026576Z","end":"2026-04-09T17:51:13.150083Z","steps":["trace[1668308510] 'agreement among raft nodes before linearized reading' (duration: 123.316599ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:51:13.786294Z","caller":"traceutil/trace.go:171","msg":"trace[1499064534] transaction","detail":"{read_only:false; response_revision:8691; number_of_response:1; }","duration":"175.726053ms","start":"2026-04-09T17:51:13.610525Z","end":"2026-04-09T17:51:13.786251Z","steps":["trace[1499064534] 'process raft request' (duration: 79.705018ms)","trace[1499064534] 'compare' (duration: 95.74363ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T17:51:14.569261Z","caller":"traceutil/trace.go:171","msg":"trace[1005217218] transaction","detail":"{read_only:false; response_revision:8699; number_of_response:1; }","duration":"130.625406ms","start":"2026-04-09T17:51:14.438597Z","end":"2026-04-09T17:51:14.569222Z","steps":["trace[1005217218] 'process raft request' (duration: 130.387551ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T17:51:14.780159Z","caller":"traceutil/trace.go:171","msg":"trace[1272313896] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"234.674721ms","start":"2026-04-09T17:51:14.545445Z","end":"2026-04-09T17:51:14.78012Z","steps":["trace[1272313896] 'process raft request' (duration: 204.140477ms)","trace[1272313896] 'compare' (duration: 30.230559ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T17:51:29.744204Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023f5.wal"} {"level":"warn","ts":"2026-04-09T17:52:26.726156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.878088ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T17:52:26.726766Z","caller":"traceutil/trace.go:171","msg":"trace[1144682354] transaction","detail":"{read_only:false; response_revision:9421; number_of_response:1; }","duration":"373.808369ms","start":"2026-04-09T17:52:26.352912Z","end":"2026-04-09T17:52:26.72672Z","steps":["trace[1144682354] 'process raft request' (duration: 191.014136ms)","trace[1144682354] 'compare' (duration: 181.43996ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T17:52:26.727019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T17:52:26.352894Z","time spent":"373.994894ms","remote":"127.0.0.1:34022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T17:53:00.05456Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1cac722af8b2b8a6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-09T17:53:00.060268Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-09T17:53:00.060393Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-09T17:55:20.310672Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8307} {"level":"info","ts":"2026-04-09T17:55:20.390426Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8307,"took":"77.393866ms","hash":2418610709,"current-db-size-bytes":58208256,"current-db-size":"58 MB","current-db-size-in-use-bytes":25858048,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-09T17:55:20.39052Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2418610709,"revision":8307,"compact-revision":6074} {"level":"info","ts":"2026-04-09T18:00:20.316736Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10702} {"level":"info","ts":"2026-04-09T18:00:20.389945Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10702,"took":"71.606572ms","hash":233574744,"current-db-size-bytes":58208256,"current-db-size":"58 MB","current-db-size-in-use-bytes":21028864,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-09T18:00:20.390015Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":233574744,"revision":10702,"compact-revision":8307}