{"level":"warn","ts":"2026-08-13T00:50:55.983874Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T00:50:55.983976Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113: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.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-08-13T00:50:55.984049Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T00:50:55.984061Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-08-13T00:50:55.984081Z","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-08-13T00:50:55.984801Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-08-13T00:50:55.98487Z","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.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-08-13T00:50:55.994549Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.397021ms"} {"level":"info","ts":"2026-08-13T00:50:56.001369Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-08-13T00:50:56.001453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T00:50:56.00148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-08-13T00:50:56.001491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T00:50:56.001503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-08-13T00:50:56.001541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-08-13T00:50:56.006477Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T00:50:56.007842Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T00:50:56.009085Z","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-08-13T00:50:56.011068Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T00:50:56.011199Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T00:50:56.011331Z","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-08-13T00:50:56.011406Z","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-08-13T00:50:56.011422Z","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-08-13T00:50:56.012746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-08-13T00:50:56.013963Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-08-13T00:50:56.015421Z","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-08-13T00:50:56.015586Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T00:50:56.015584Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-08-13T00:50:56.015623Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T00:50:56.015644Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-08-13T00:50:56.102243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T00:50:56.102299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T00:50:56.102331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-08-13T00:50:56.102347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-08-13T00:50:56.102354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-08-13T00:50:56.102365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-08-13T00:50:56.102374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-08-13T00:50:56.103193Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T00:50:56.105983Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T00:50:56.106056Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:50:56.105964Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T00:50:56.106834Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:50:56.106909Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:50:56.106933Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T00:50:56.108331Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"info","ts":"2026-08-13T00:50:56.108752Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T00:50:56.10881Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T00:50:56.108834Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T00:51:00.590195Z","caller":"traceutil/trace.go:171","msg":"trace[460843495] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"428.414372ms","start":"2026-08-13T00:51:00.161755Z","end":"2026-08-13T00:51:00.59017Z","steps":["trace[460843495] 'process raft request' (duration: 428.252648ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:51:00.591056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:51:00.161739Z","time spent":"428.556157ms","remote":"127.0.0.1:50090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T00:51:00.872764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.447249ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-13T00:51:00.872931Z","caller":"traceutil/trace.go:171","msg":"trace[493010524] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"273.49421ms","start":"2026-08-13T00:51:00.599413Z","end":"2026-08-13T00:51:00.872907Z","steps":["trace[493010524] 'process raft request' (duration: 98.560125ms)","trace[493010524] 'compare' (duration: 174.232078ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:51:33.763532Z","caller":"traceutil/trace.go:171","msg":"trace[153716057] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"292.818558ms","start":"2026-08-13T00:51:33.470683Z","end":"2026-08-13T00:51:33.763501Z","steps":["trace[153716057] 'process raft request' (duration: 221.717127ms)","trace[153716057] 'compare' (duration: 70.888201ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:51:33.764358Z","caller":"traceutil/trace.go:171","msg":"trace[1305476116] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"192.745533ms","start":"2026-08-13T00:51:33.571552Z","end":"2026-08-13T00:51:33.764298Z","steps":["trace[1305476116] 'process raft request' (duration: 192.162611ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:51:38.384477Z","caller":"traceutil/trace.go:171","msg":"trace[287156245] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"109.254291ms","start":"2026-08-13T00:51:38.275188Z","end":"2026-08-13T00:51:38.384442Z","steps":["trace[287156245] 'process raft request' (duration: 104.717051ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:51:39.273004Z","caller":"traceutil/trace.go:171","msg":"trace[1372537678] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"305.545344ms","start":"2026-08-13T00:51:38.967436Z","end":"2026-08-13T00:51:39.272981Z","steps":["trace[1372537678] 'read index received' (duration: 304.741867ms)","trace[1372537678] 'applied index is now lower than readState.Index' (duration: 802.257µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:51:39.27306Z","caller":"traceutil/trace.go:171","msg":"trace[1020640322] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"397.742541ms","start":"2026-08-13T00:51:38.875283Z","end":"2026-08-13T00:51:39.273026Z","steps":["trace[1020640322] 'process raft request' (duration: 397.086195ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:51:39.273201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.735246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fmbml\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-08-13T00:51:39.273243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:51:38.875255Z","time spent":"397.891012ms","remote":"127.0.0.1:50004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T00:51:39.273274Z","caller":"traceutil/trace.go:171","msg":"trace[250254586] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fmbml; range_end:; response_count:1; response_revision:630; }","duration":"305.828647ms","start":"2026-08-13T00:51:38.967404Z","end":"2026-08-13T00:51:39.273233Z","steps":["trace[250254586] 'agreement among raft nodes before linearized reading' (duration: 305.667465ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:51:39.273318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:51:38.967375Z","time spent":"305.933498ms","remote":"127.0.0.1:50092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-fmbml\" "} {"level":"info","ts":"2026-08-13T00:52:22.431109Z","caller":"traceutil/trace.go:171","msg":"trace[1905490429] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"209.937536ms","start":"2026-08-13T00:52:22.221152Z","end":"2026-08-13T00:52:22.431089Z","steps":["trace[1905490429] 'process raft request' (duration: 209.760989ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:53:08.216179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.866218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T00:53:08.216259Z","caller":"traceutil/trace.go:171","msg":"trace[2131785791] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1845; }","duration":"134.006107ms","start":"2026-08-13T00:53:08.082237Z","end":"2026-08-13T00:53:08.216243Z","steps":["trace[2131785791] 'count revisions from in-memory index tree' (duration: 133.757162ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:53:08.216246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.209695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T00:53:08.216344Z","caller":"traceutil/trace.go:171","msg":"trace[10717692] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1845; }","duration":"359.367135ms","start":"2026-08-13T00:53:07.856959Z","end":"2026-08-13T00:53:08.216326Z","steps":["trace[10717692] 'count revisions from in-memory index tree' (duration: 359.130229ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:53:08.216417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:53:07.856934Z","time spent":"359.4723ms","remote":"127.0.0.1:50144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-08-13T00:53:08.412184Z","caller":"traceutil/trace.go:171","msg":"trace[1315233498] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"102.289148ms","start":"2026-08-13T00:53:08.309855Z","end":"2026-08-13T00:53:08.412144Z","steps":["trace[1315233498] 'process raft request' (duration: 102.125017ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:53:08.75771Z","caller":"traceutil/trace.go:171","msg":"trace[1419803022] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1924; }","duration":"137.940313ms","start":"2026-08-13T00:53:08.619744Z","end":"2026-08-13T00:53:08.757684Z","steps":["trace[1419803022] 'read index received' (duration: 137.70906ms)","trace[1419803022] 'applied index is now lower than readState.Index' (duration: 230.213µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:53:08.757847Z","caller":"traceutil/trace.go:171","msg":"trace[1294916941] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"139.219521ms","start":"2026-08-13T00:53:08.618617Z","end":"2026-08-13T00:53:08.757836Z","steps":["trace[1294916941] 'process raft request' (duration: 138.908982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:53:08.75813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.36282ms","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-08-13T00:53:08.758207Z","caller":"traceutil/trace.go:171","msg":"trace[2000939835] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1849; }","duration":"138.453375ms","start":"2026-08-13T00:53:08.619735Z","end":"2026-08-13T00:53:08.758189Z","steps":["trace[2000939835] 'agreement among raft nodes before linearized reading' (duration: 138.261373ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:53:08.758224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.874266ms","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-08-13T00:53:08.758324Z","caller":"traceutil/trace.go:171","msg":"trace[2003583467] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1849; }","duration":"119.006134ms","start":"2026-08-13T00:53:08.639293Z","end":"2026-08-13T00:53:08.7583Z","steps":["trace[2003583467] 'agreement among raft nodes before linearized reading' (duration: 118.77203ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:53:21.93486Z","caller":"traceutil/trace.go:171","msg":"trace[1380545211] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"187.818535ms","start":"2026-08-13T00:53:21.747019Z","end":"2026-08-13T00:53:21.934838Z","steps":["trace[1380545211] 'process raft request' (duration: 187.25886ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:53:43.049221Z","caller":"traceutil/trace.go:171","msg":"trace[438431342] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"162.405664ms","start":"2026-08-13T00:53:42.886781Z","end":"2026-08-13T00:53:43.049187Z","steps":["trace[438431342] 'process raft request' (duration: 162.013349ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:53:43.725649Z","caller":"traceutil/trace.go:171","msg":"trace[2137508057] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"127.784098ms","start":"2026-08-13T00:53:43.597826Z","end":"2026-08-13T00:53:43.72561Z","steps":["trace[2137508057] 'process raft request' (duration: 127.577134ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:53:43.931478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.736722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T00:53:43.931576Z","caller":"traceutil/trace.go:171","msg":"trace[1508101860] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"201.555219ms","start":"2026-08-13T00:53:43.730003Z","end":"2026-08-13T00:53:43.931559Z","steps":["trace[1508101860] 'process raft request' (duration: 72.671167ms)","trace[1508101860] 'compare' (duration: 128.606673ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:53:44.112372Z","caller":"traceutil/trace.go:171","msg":"trace[1873762349] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"159.496762ms","start":"2026-08-13T00:53:43.95285Z","end":"2026-08-13T00:53:44.112347Z","steps":["trace[1873762349] 'process raft request' (duration: 159.375754ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:53:44.114917Z","caller":"traceutil/trace.go:171","msg":"trace[1574290567] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"110.111637ms","start":"2026-08-13T00:53:44.004774Z","end":"2026-08-13T00:53:44.114885Z","steps":["trace[1574290567] 'process raft request' (duration: 109.797146ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:54:47.686759Z","caller":"traceutil/trace.go:171","msg":"trace[1058809047] transaction","detail":"{read_only:false; response_revision:2546; number_of_response:1; }","duration":"221.651415ms","start":"2026-08-13T00:54:47.465083Z","end":"2026-08-13T00:54:47.686735Z","steps":["trace[1058809047] 'process raft request' (duration: 221.509874ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:54:47.687618Z","caller":"traceutil/trace.go:171","msg":"trace[1414511642] transaction","detail":"{read_only:false; response_revision:2547; number_of_response:1; }","duration":"222.354076ms","start":"2026-08-13T00:54:47.465233Z","end":"2026-08-13T00:54:47.687587Z","steps":["trace[1414511642] 'process raft request' (duration: 222.185373ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:55:20.553233Z","caller":"traceutil/trace.go:171","msg":"trace[309001976] linearizableReadLoop","detail":"{readStateIndex:2834; appliedIndex:2833; }","duration":"107.40689ms","start":"2026-08-13T00:55:20.445799Z","end":"2026-08-13T00:55:20.553206Z","steps":["trace[309001976] 'read index received' (duration: 107.243674ms)","trace[309001976] 'applied index is now lower than readState.Index' (duration: 162.386µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:55:20.553358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.538268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T00:55:20.553389Z","caller":"traceutil/trace.go:171","msg":"trace[1756865902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2727; }","duration":"107.634037ms","start":"2026-08-13T00:55:20.445744Z","end":"2026-08-13T00:55:20.553378Z","steps":["trace[1756865902] 'agreement among raft nodes before linearized reading' (duration: 107.560268ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:55:20.553455Z","caller":"traceutil/trace.go:171","msg":"trace[830339981] transaction","detail":"{read_only:false; response_revision:2727; number_of_response:1; }","duration":"157.801416ms","start":"2026-08-13T00:55:20.395628Z","end":"2026-08-13T00:55:20.553429Z","steps":["trace[830339981] 'process raft request' (duration: 157.409164ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:55:20.787378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.028535ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T00:55:20.787489Z","caller":"traceutil/trace.go:171","msg":"trace[1449817597] linearizableReadLoop","detail":"{readStateIndex:2835; appliedIndex:2834; }","duration":"233.011462ms","start":"2026-08-13T00:55:20.554463Z","end":"2026-08-13T00:55:20.787475Z","steps":["trace[1449817597] 'read index received' (duration: 110.756121ms)","trace[1449817597] 'applied index is now lower than readState.Index' (duration: 122.25393ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:55:20.787731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.256157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T00:55:20.787794Z","caller":"traceutil/trace.go:171","msg":"trace[267081701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2728; }","duration":"233.347615ms","start":"2026-08-13T00:55:20.554432Z","end":"2026-08-13T00:55:20.78778Z","steps":["trace[267081701] 'agreement among raft nodes before linearized reading' (duration: 233.199629ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:55:20.78807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.857852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18cb3751902ee1cb\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-08-13T00:55:20.78804Z","caller":"traceutil/trace.go:171","msg":"trace[1773566869] transaction","detail":"{read_only:false; response_revision:2728; number_of_response:1; }","duration":"325.918967ms","start":"2026-08-13T00:55:20.461819Z","end":"2026-08-13T00:55:20.787738Z","steps":["trace[1773566869] 'process raft request' (duration: 203.447002ms)","trace[1773566869] 'compare' (duration: 121.716411ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:55:20.788284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:55:20.461797Z","time spent":"326.435496ms","remote":"127.0.0.1:50168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T00:55:20.78814Z","caller":"traceutil/trace.go:171","msg":"trace[43144049] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18cb3751902ee1cb; range_end:; response_count:1; response_revision:2728; }","duration":"151.990239ms","start":"2026-08-13T00:55:20.636136Z","end":"2026-08-13T00:55:20.788126Z","steps":["trace[43144049] 'agreement among raft nodes before linearized reading' (duration: 151.739573ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:03.5722Z","caller":"traceutil/trace.go:171","msg":"trace[1655363050] transaction","detail":"{read_only:false; response_revision:4436; number_of_response:1; }","duration":"542.155573ms","start":"2026-08-13T00:59:03.029987Z","end":"2026-08-13T00:59:03.572143Z","steps":["trace[1655363050] 'process raft request' (duration: 505.82797ms)","trace[1655363050] 'compare' (duration: 35.799307ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:59:03.572763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:59:03.029975Z","time spent":"542.70008ms","remote":"127.0.0.1:50168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T00:59:06.078097Z","caller":"traceutil/trace.go:171","msg":"trace[1770385633] linearizableReadLoop","detail":"{readStateIndex:4711; appliedIndex:4710; }","duration":"138.361031ms","start":"2026-08-13T00:59:05.939723Z","end":"2026-08-13T00:59:06.078084Z","steps":["trace[1770385633] 'read index received' (duration: 138.164401ms)","trace[1770385633] 'applied index is now lower than readState.Index' (duration: 195.99µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:06.078442Z","caller":"traceutil/trace.go:171","msg":"trace[680358762] transaction","detail":"{read_only:false; response_revision:4532; number_of_response:1; }","duration":"185.764519ms","start":"2026-08-13T00:59:05.892661Z","end":"2026-08-13T00:59:06.078425Z","steps":["trace[680358762] 'process raft request' (duration: 185.311865ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:06.078648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.916878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0.18cb378a8f54c361\" ","response":"range_response_count:1 size:1179"} {"level":"info","ts":"2026-08-13T00:59:06.078693Z","caller":"traceutil/trace.go:171","msg":"trace[830319451] range","detail":"{range_begin:/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0.18cb378a8f54c361; range_end:; response_count:1; response_revision:4532; }","duration":"139.007033ms","start":"2026-08-13T00:59:05.939675Z","end":"2026-08-13T00:59:06.078682Z","steps":["trace[830319451] 'agreement among raft nodes before linearized reading' (duration: 138.876767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:06.078948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.617011ms","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":"info","ts":"2026-08-13T00:59:06.079033Z","caller":"traceutil/trace.go:171","msg":"trace[898506312] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4532; }","duration":"127.778179ms","start":"2026-08-13T00:59:05.951235Z","end":"2026-08-13T00:59:06.079014Z","steps":["trace[898506312] 'agreement among raft nodes before linearized reading' (duration: 127.617041ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:09.260857Z","caller":"traceutil/trace.go:171","msg":"trace[441161982] transaction","detail":"{read_only:false; response_revision:4569; number_of_response:1; }","duration":"151.998575ms","start":"2026-08-13T00:59:09.108552Z","end":"2026-08-13T00:59:09.26055Z","steps":["trace[441161982] 'process raft request' (duration: 151.861147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:10.714488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.292854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T00:59:10.714649Z","caller":"traceutil/trace.go:171","msg":"trace[311377787] transaction","detail":"{read_only:false; response_revision:4630; number_of_response:1; }","duration":"241.27893ms","start":"2026-08-13T00:59:10.473355Z","end":"2026-08-13T00:59:10.714633Z","steps":["trace[311377787] 'process raft request' (duration: 241.227258ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:10.714816Z","caller":"traceutil/trace.go:171","msg":"trace[1137326093] linearizableReadLoop","detail":"{readStateIndex:4812; appliedIndex:4811; }","duration":"245.159738ms","start":"2026-08-13T00:59:10.469627Z","end":"2026-08-13T00:59:10.714787Z","steps":["trace[1137326093] 'read index received' (duration: 54.505305ms)","trace[1137326093] 'applied index is now lower than readState.Index' (duration: 190.652413ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:10.714928Z","caller":"traceutil/trace.go:171","msg":"trace[2135666607] transaction","detail":"{read_only:false; response_revision:4629; number_of_response:1; }","duration":"281.348425ms","start":"2026-08-13T00:59:10.433565Z","end":"2026-08-13T00:59:10.714913Z","steps":["trace[2135666607] 'process raft request' (duration: 90.556855ms)","trace[2135666607] 'compare' (duration: 190.192619ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:59:10.715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.800017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T00:59:10.715035Z","caller":"traceutil/trace.go:171","msg":"trace[122371909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4630; }","duration":"268.85833ms","start":"2026-08-13T00:59:10.446167Z","end":"2026-08-13T00:59:10.715025Z","steps":["trace[122371909] 'agreement among raft nodes before linearized reading' (duration: 268.778386ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:10.715202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.953825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-13T00:59:10.715238Z","caller":"traceutil/trace.go:171","msg":"trace[1640283080] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4630; }","duration":"282.038009ms","start":"2026-08-13T00:59:10.43319Z","end":"2026-08-13T00:59:10.715228Z","steps":["trace[1640283080] 'agreement among raft nodes before linearized reading' (duration: 281.899381ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:10.720966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.359444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:14497"} {"level":"warn","ts":"2026-08-13T00:59:10.720966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.945459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"warn","ts":"2026-08-13T00:59:10.720952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.666019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-08-13T00:59:10.721015Z","caller":"traceutil/trace.go:171","msg":"trace[1484587144] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4631; }","duration":"240.439858ms","start":"2026-08-13T00:59:10.480564Z","end":"2026-08-13T00:59:10.721004Z","steps":["trace[1484587144] 'agreement among raft nodes before linearized reading' (duration: 240.27882ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:10.721019Z","caller":"traceutil/trace.go:171","msg":"trace[1909169534] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4631; }","duration":"220.025962ms","start":"2026-08-13T00:59:10.500982Z","end":"2026-08-13T00:59:10.721008Z","steps":["trace[1909169534] 'agreement among raft nodes before linearized reading' (duration: 219.879695ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:10.721045Z","caller":"traceutil/trace.go:171","msg":"trace[418999257] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4631; }","duration":"171.798386ms","start":"2026-08-13T00:59:10.549222Z","end":"2026-08-13T00:59:10.721021Z","steps":["trace[418999257] 'agreement among raft nodes before linearized reading' (duration: 171.582655ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:16.008698Z","caller":"traceutil/trace.go:171","msg":"trace[1814630401] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"196.306397ms","start":"2026-08-13T00:59:15.812361Z","end":"2026-08-13T00:59:16.008667Z","steps":["trace[1814630401] 'process raft request' (duration: 175.735401ms)","trace[1814630401] 'compare' (duration: 20.279331ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:16.008502Z","caller":"traceutil/trace.go:171","msg":"trace[640796692] linearizableReadLoop","detail":"{readStateIndex:4920; appliedIndex:4919; }","duration":"110.869836ms","start":"2026-08-13T00:59:15.897608Z","end":"2026-08-13T00:59:16.008478Z","steps":["trace[640796692] 'read index received' (duration: 89.756432ms)","trace[640796692] 'applied index is now lower than readState.Index' (duration: 21.112434ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:59:16.008857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.242505ms","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-08-13T00:59:16.008969Z","caller":"traceutil/trace.go:171","msg":"trace[228749820] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4735; }","duration":"111.398513ms","start":"2026-08-13T00:59:15.897555Z","end":"2026-08-13T00:59:16.008954Z","steps":["trace[228749820] 'agreement among raft nodes before linearized reading' (duration: 111.184822ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:16.220824Z","caller":"traceutil/trace.go:171","msg":"trace[646632587] transaction","detail":"{read_only:false; response_revision:4736; number_of_response:1; }","duration":"208.318833ms","start":"2026-08-13T00:59:16.012481Z","end":"2026-08-13T00:59:16.2208Z","steps":["trace[646632587] 'process raft request' (duration: 183.695898ms)","trace[646632587] 'compare' (duration: 24.423896ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:16.220844Z","caller":"traceutil/trace.go:171","msg":"trace[258493154] transaction","detail":"{read_only:false; response_revision:4737; number_of_response:1; }","duration":"109.090006ms","start":"2026-08-13T00:59:16.111729Z","end":"2026-08-13T00:59:16.220819Z","steps":["trace[258493154] 'process raft request' (duration: 109.035223ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:16.221091Z","caller":"traceutil/trace.go:171","msg":"trace[705202946] linearizableReadLoop","detail":"{readStateIndex:4921; appliedIndex:4920; }","duration":"115.60858ms","start":"2026-08-13T00:59:16.105473Z","end":"2026-08-13T00:59:16.221081Z","steps":["trace[705202946] 'read index received' (duration: 90.832517ms)","trace[705202946] 'applied index is now lower than readState.Index' (duration: 24.775243ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:59:16.221256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.770628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b161767f-26a8-4236-9d20-cbf9e4cc0dac\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-13T00:59:16.221299Z","caller":"traceutil/trace.go:171","msg":"trace[1038662983] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b161767f-26a8-4236-9d20-cbf9e4cc0dac; range_end:; response_count:1; response_revision:4737; }","duration":"115.868244ms","start":"2026-08-13T00:59:16.10542Z","end":"2026-08-13T00:59:16.221288Z","steps":["trace[1038662983] 'agreement among raft nodes before linearized reading' (duration: 115.699455ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:16.381261Z","caller":"traceutil/trace.go:171","msg":"trace[916838254] linearizableReadLoop","detail":"{readStateIndex:4923; appliedIndex:4922; }","duration":"112.672069ms","start":"2026-08-13T00:59:16.268565Z","end":"2026-08-13T00:59:16.381237Z","steps":["trace[916838254] 'read index received' (duration: 112.396755ms)","trace[916838254] 'applied index is now lower than readState.Index' (duration: 274.224µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:16.381319Z","caller":"traceutil/trace.go:171","msg":"trace[799346008] transaction","detail":"{read_only:false; response_revision:4738; number_of_response:1; }","duration":"154.197133ms","start":"2026-08-13T00:59:16.227091Z","end":"2026-08-13T00:59:16.381288Z","steps":["trace[799346008] 'process raft request' (duration: 153.975522ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:16.38156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.969685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-08-13T00:59:16.381639Z","caller":"traceutil/trace.go:171","msg":"trace[613415087] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4738; }","duration":"113.102361ms","start":"2026-08-13T00:59:16.268515Z","end":"2026-08-13T00:59:16.381618Z","steps":["trace[613415087] 'agreement among raft nodes before linearized reading' (duration: 112.823576ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:17.129746Z","caller":"traceutil/trace.go:171","msg":"trace[1209869667] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"167.122531ms","start":"2026-08-13T00:59:16.9626Z","end":"2026-08-13T00:59:17.129723Z","steps":["trace[1209869667] 'process raft request' (duration: 166.969714ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:17.129878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.450657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T00:59:17.129739Z","caller":"traceutil/trace.go:171","msg":"trace[721133992] linearizableReadLoop","detail":"{readStateIndex:4935; appliedIndex:4934; }","duration":"152.316859ms","start":"2026-08-13T00:59:16.977399Z","end":"2026-08-13T00:59:17.129716Z","steps":["trace[721133992] 'read index received' (duration: 152.183513ms)","trace[721133992] 'applied index is now lower than readState.Index' (duration: 132.226µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:17.129958Z","caller":"traceutil/trace.go:171","msg":"trace[932348612] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:4750; }","duration":"152.581864ms","start":"2026-08-13T00:59:16.977363Z","end":"2026-08-13T00:59:17.129945Z","steps":["trace[932348612] 'agreement among raft nodes before linearized reading' (duration: 152.426776ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:17.308084Z","caller":"traceutil/trace.go:171","msg":"trace[1554431935] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"164.550962ms","start":"2026-08-13T00:59:17.143504Z","end":"2026-08-13T00:59:17.308055Z","steps":["trace[1554431935] 'process raft request' (duration: 137.69625ms)","trace[1554431935] 'compare' (duration: 26.681563ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:17.30809Z","caller":"traceutil/trace.go:171","msg":"trace[1779336678] linearizableReadLoop","detail":"{readStateIndex:4938; appliedIndex:4937; }","duration":"106.923636ms","start":"2026-08-13T00:59:17.201052Z","end":"2026-08-13T00:59:17.307976Z","steps":["trace[1779336678] 'read index received' (duration: 80.075674ms)","trace[1779336678] 'applied index is now lower than readState.Index' (duration: 26.846982ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:59:17.308311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.20516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-08-13T00:59:17.308392Z","caller":"traceutil/trace.go:171","msg":"trace[1367494600] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4753; }","duration":"107.340257ms","start":"2026-08-13T00:59:17.201036Z","end":"2026-08-13T00:59:17.308376Z","steps":["trace[1367494600] 'agreement among raft nodes before linearized reading' (duration: 107.094664ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:20.312294Z","caller":"traceutil/trace.go:171","msg":"trace[256156587] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"149.498073ms","start":"2026-08-13T00:59:20.162765Z","end":"2026-08-13T00:59:20.312263Z","steps":["trace[256156587] 'process raft request' (duration: 149.282742ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:20.315686Z","caller":"traceutil/trace.go:171","msg":"trace[1413871021] transaction","detail":"{read_only:false; response_revision:4795; number_of_response:1; }","duration":"149.201918ms","start":"2026-08-13T00:59:20.166414Z","end":"2026-08-13T00:59:20.315616Z","steps":["trace[1413871021] 'process raft request' (duration: 149.014658ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:28.379156Z","caller":"traceutil/trace.go:171","msg":"trace[1402150159] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"100.39469ms","start":"2026-08-13T00:59:28.278738Z","end":"2026-08-13T00:59:28.379133Z","steps":["trace[1402150159] 'process raft request' (duration: 97.584602ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:32.29128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.371343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T00:59:32.291394Z","caller":"traceutil/trace.go:171","msg":"trace[1603439272] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"228.894585ms","start":"2026-08-13T00:59:32.062479Z","end":"2026-08-13T00:59:32.291374Z","steps":["trace[1603439272] 'process raft request' (duration: 69.211736ms)","trace[1603439272] 'compare' (duration: 159.056745ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:59:32.607304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.578808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T00:59:32.607694Z","caller":"traceutil/trace.go:171","msg":"trace[1212569468] linearizableReadLoop","detail":"{readStateIndex:5128; appliedIndex:5127; }","duration":"404.302397ms","start":"2026-08-13T00:59:32.203373Z","end":"2026-08-13T00:59:32.607675Z","steps":["trace[1212569468] 'read index received' (duration: 293.195141ms)","trace[1212569468] 'applied index is now lower than readState.Index' (duration: 111.105195ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:32.607781Z","caller":"traceutil/trace.go:171","msg":"trace[533616819] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"518.207921ms","start":"2026-08-13T00:59:32.089561Z","end":"2026-08-13T00:59:32.607769Z","steps":["trace[533616819] 'process raft request' (duration: 407.070923ms)","trace[533616819] 'compare' (duration: 110.350926ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:59:32.607848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:59:32.089545Z","time spent":"518.261913ms","remote":"127.0.0.1:50168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T00:59:32.607904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.531589ms","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-08-13T00:59:32.608508Z","caller":"traceutil/trace.go:171","msg":"trace[1349481375] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:4936; }","duration":"405.172703ms","start":"2026-08-13T00:59:32.203321Z","end":"2026-08-13T00:59:32.608494Z","steps":["trace[1349481375] 'agreement among raft nodes before linearized reading' (duration: 404.54056ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:32.608561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:59:32.203303Z","time spent":"405.242337ms","remote":"127.0.0.1:42674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-13T00:59:32.689944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.289176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T00:59:32.690064Z","caller":"traceutil/trace.go:171","msg":"trace[497367700] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:4937; }","duration":"421.449955ms","start":"2026-08-13T00:59:32.268593Z","end":"2026-08-13T00:59:32.690043Z","steps":["trace[497367700] 'agreement among raft nodes before linearized reading' (duration: 421.237203ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:32.690108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:59:32.268505Z","time spent":"421.592681ms","remote":"127.0.0.1:50344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-08-13T00:59:32.69009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.010102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-13T00:59:32.690163Z","caller":"traceutil/trace.go:171","msg":"trace[841336111] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4937; }","duration":"347.121797ms","start":"2026-08-13T00:59:32.343024Z","end":"2026-08-13T00:59:32.690146Z","steps":["trace[841336111] 'agreement among raft nodes before linearized reading' (duration: 346.875953ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:32.690317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:59:32.343009Z","time spent":"347.227374ms","remote":"127.0.0.1:50074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-08-13T00:59:32.690326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.778253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-08-13T00:59:32.690365Z","caller":"traceutil/trace.go:171","msg":"trace[595197170] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4937; }","duration":"408.852958ms","start":"2026-08-13T00:59:32.281501Z","end":"2026-08-13T00:59:32.690354Z","steps":["trace[595197170] 'agreement among raft nodes before linearized reading' (duration: 408.71214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:32.690392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T00:59:32.281473Z","time spent":"408.911531ms","remote":"127.0.0.1:50092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10415,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-08-13T00:59:32.69047Z","caller":"traceutil/trace.go:171","msg":"trace[1684671094] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"138.441253ms","start":"2026-08-13T00:59:32.551986Z","end":"2026-08-13T00:59:32.690427Z","steps":["trace[1684671094] 'process raft request' (duration: 137.698763ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:32.690622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.00443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T00:59:32.690719Z","caller":"traceutil/trace.go:171","msg":"trace[1824760389] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:4937; }","duration":"259.18707ms","start":"2026-08-13T00:59:32.431517Z","end":"2026-08-13T00:59:32.690704Z","steps":["trace[1824760389] 'agreement among raft nodes before linearized reading' (duration: 258.928926ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:32.690784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.709119ms","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-08-13T00:59:32.690897Z","caller":"traceutil/trace.go:171","msg":"trace[679278755] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4937; }","duration":"290.918671ms","start":"2026-08-13T00:59:32.399958Z","end":"2026-08-13T00:59:32.690876Z","steps":["trace[679278755] 'agreement among raft nodes before linearized reading' (duration: 290.391153ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:32.752727Z","caller":"traceutil/trace.go:171","msg":"trace[2006753625] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"107.057111ms","start":"2026-08-13T00:59:32.645604Z","end":"2026-08-13T00:59:32.752661Z","steps":["trace[2006753625] 'process raft request' (duration: 99.610127ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:32.967762Z","caller":"traceutil/trace.go:171","msg":"trace[95558097] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"185.481865ms","start":"2026-08-13T00:59:32.782246Z","end":"2026-08-13T00:59:32.967728Z","steps":["trace[95558097] 'process raft request' (duration: 102.302579ms)","trace[95558097] 'compare' (duration: 82.766024ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:32.967785Z","caller":"traceutil/trace.go:171","msg":"trace[212650692] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"184.993889ms","start":"2026-08-13T00:59:32.782766Z","end":"2026-08-13T00:59:32.96776Z","steps":["trace[212650692] 'process raft request' (duration: 184.858452ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:32.9683Z","caller":"traceutil/trace.go:171","msg":"trace[266851945] linearizableReadLoop","detail":"{readStateIndex:5136; appliedIndex:5133; }","duration":"137.83852ms","start":"2026-08-13T00:59:32.83045Z","end":"2026-08-13T00:59:32.968288Z","steps":["trace[266851945] 'read index received' (duration: 54.01174ms)","trace[266851945] 'applied index is now lower than readState.Index' (duration: 83.82546ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T00:59:32.968408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.942897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T00:59:32.968418Z","caller":"traceutil/trace.go:171","msg":"trace[2070940680] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"184.45288ms","start":"2026-08-13T00:59:32.783951Z","end":"2026-08-13T00:59:32.968403Z","steps":["trace[2070940680] 'process raft request' (duration: 183.741923ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:32.968447Z","caller":"traceutil/trace.go:171","msg":"trace[1240551000] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:4945; }","duration":"138.037653ms","start":"2026-08-13T00:59:32.830397Z","end":"2026-08-13T00:59:32.968434Z","steps":["trace[1240551000] 'agreement among raft nodes before linearized reading' (duration: 137.941238ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:33.204889Z","caller":"traceutil/trace.go:171","msg":"trace[31480445] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"194.204445ms","start":"2026-08-13T00:59:33.010657Z","end":"2026-08-13T00:59:33.204862Z","steps":["trace[31480445] 'process raft request' (duration: 146.386388ms)","trace[31480445] 'compare' (duration: 47.593646ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:33.205028Z","caller":"traceutil/trace.go:171","msg":"trace[775480646] linearizableReadLoop","detail":"{readStateIndex:5140; appliedIndex:5138; }","duration":"183.682306ms","start":"2026-08-13T00:59:33.021326Z","end":"2026-08-13T00:59:33.205009Z","steps":["trace[775480646] 'read index received' (duration: 135.789295ms)","trace[775480646] 'applied index is now lower than readState.Index' (duration: 47.891641ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T00:59:33.205086Z","caller":"traceutil/trace.go:171","msg":"trace[1512919488] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"192.95771ms","start":"2026-08-13T00:59:33.012112Z","end":"2026-08-13T00:59:33.20507Z","steps":["trace[1512919488] 'process raft request' (duration: 192.692395ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T00:59:33.20517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.823225ms","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":"info","ts":"2026-08-13T00:59:33.205217Z","caller":"traceutil/trace.go:171","msg":"trace[1386934864] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4948; }","duration":"183.903568ms","start":"2026-08-13T00:59:33.021299Z","end":"2026-08-13T00:59:33.205202Z","steps":["trace[1386934864] 'agreement among raft nodes before linearized reading' (duration: 183.807483ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T00:59:33.513296Z","caller":"traceutil/trace.go:171","msg":"trace[1407480285] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"112.29752ms","start":"2026-08-13T00:59:33.400955Z","end":"2026-08-13T00:59:33.513253Z","steps":["trace[1407480285] 'process raft request' (duration: 60.735053ms)","trace[1407480285] 'compare' (duration: 51.238649ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T01:00:56.635845Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2915} {"level":"info","ts":"2026-08-13T01:00:56.764346Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2915,"took":"125.53337ms","hash":909452410,"current-db-size-bytes":52666368,"current-db-size":"53 MB","current-db-size-in-use-bytes":29163520,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-13T01:00:56.764609Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":909452410,"revision":2915,"compact-revision":-1} {"level":"info","ts":"2026-08-13T01:05:56.642676Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5591} {"level":"info","ts":"2026-08-13T01:05:56.713733Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5591,"took":"69.908657ms","hash":852503320,"current-db-size-bytes":52666368,"current-db-size":"53 MB","current-db-size-in-use-bytes":18235392,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-13T01:05:56.71379Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":852503320,"revision":5591,"compact-revision":2915}