{"level":"warn","ts":"2026-06-27T05:36:31.324084Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-27T05:36:31.324196Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-06-27T05:36:31.324307Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-27T05:36:31.324322Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-06-27T05:36:31.324356Z","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-06-27T05:36:31.325117Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-06-27T05:36:31.325237Z","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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-06-27T05:36:31.330086Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.570957ms"} {"level":"info","ts":"2026-06-27T05:36:31.339687Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-06-27T05:36:31.339765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-06-27T05:36:31.339784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-06-27T05:36:31.339794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-27T05:36:31.339803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-06-27T05:36:31.339839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-06-27T05:36:31.346576Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-27T05:36:31.348176Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-27T05:36:31.349081Z","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-06-27T05:36:31.351918Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-27T05:36:31.352329Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-27T05:36:31.352508Z","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-06-27T05:36:31.352552Z","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-06-27T05:36:31.352566Z","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-06-27T05:36:31.355743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-06-27T05:36:31.35604Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-06-27T05:36:31.357221Z","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-06-27T05:36:31.357356Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-06-27T05:36:31.357392Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-06-27T05:36:31.357507Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-27T05:36:31.357544Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-27T05:36:31.540089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-06-27T05:36:31.540162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-27T05:36:31.540185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-06-27T05:36:31.540204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-06-27T05:36:31.540216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-06-27T05:36:31.540232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-06-27T05:36:31.540245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-06-27T05:36:31.548795Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-27T05:36:31.549756Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-27T05:36:31.549753Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-06-27T05:36:31.550024Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-27T05:36:31.550063Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-27T05:36:31.549865Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-27T05:36:31.552193Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-27T05:36:31.553718Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-06-27T05:36:31.562511Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-06-27T05:36:31.562578Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-27T05:36:31.562602Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-27T05:36:43.796544Z","caller":"traceutil/trace.go:171","msg":"trace[1895945009] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"120.501682ms","start":"2026-06-27T05:36:43.676023Z","end":"2026-06-27T05:36:43.796525Z","steps":["trace[1895945009] 'process raft request' (duration: 120.342261ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:36:43.987797Z","caller":"traceutil/trace.go:171","msg":"trace[662136206] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"187.442106ms","start":"2026-06-27T05:36:43.800331Z","end":"2026-06-27T05:36:43.987773Z","steps":["trace[662136206] 'process raft request' (duration: 182.755512ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:36:44.04314Z","caller":"traceutil/trace.go:171","msg":"trace[1577150898] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"238.470109ms","start":"2026-06-27T05:36:43.804646Z","end":"2026-06-27T05:36:44.043116Z","steps":["trace[1577150898] 'process raft request' (duration: 238.344608ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:37:10.155098Z","caller":"traceutil/trace.go:171","msg":"trace[1221559965] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"109.035261ms","start":"2026-06-27T05:37:10.046031Z","end":"2026-06-27T05:37:10.155066Z","steps":["trace[1221559965] 'process raft request' (duration: 108.767629ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:37:10.154947Z","caller":"traceutil/trace.go:171","msg":"trace[2129986804] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"109.389207ms","start":"2026-06-27T05:37:10.045537Z","end":"2026-06-27T05:37:10.154926Z","steps":["trace[2129986804] 'process raft request' (duration: 86.940191ms)","trace[2129986804] 'compare' (duration: 22.166423ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:37:10.156769Z","caller":"traceutil/trace.go:171","msg":"trace[43338747] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"108.908785ms","start":"2026-06-27T05:37:10.047728Z","end":"2026-06-27T05:37:10.156636Z","steps":["trace[43338747] 'process raft request' (duration: 107.182033ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:37:10.159569Z","caller":"traceutil/trace.go:171","msg":"trace[1712662544] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"111.088079ms","start":"2026-06-27T05:37:10.048465Z","end":"2026-06-27T05:37:10.159553Z","steps":["trace[1712662544] 'process raft request' (duration: 110.854788ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:37:10.159837Z","caller":"traceutil/trace.go:171","msg":"trace[1527543220] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"103.174933ms","start":"2026-06-27T05:37:10.05663Z","end":"2026-06-27T05:37:10.159805Z","steps":["trace[1527543220] 'process raft request' (duration: 102.920241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:37:11.071178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.67233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T05:37:11.071273Z","caller":"traceutil/trace.go:171","msg":"trace[114711452] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:554; }","duration":"111.808897ms","start":"2026-06-27T05:37:10.959443Z","end":"2026-06-27T05:37:11.071252Z","steps":["trace[114711452] 'agreement among raft nodes before linearized reading' (duration: 111.643799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:37:11.072227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.593164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T05:37:11.072286Z","caller":"traceutil/trace.go:171","msg":"trace[1771596245] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:554; }","duration":"112.69674ms","start":"2026-06-27T05:37:10.959574Z","end":"2026-06-27T05:37:11.072271Z","steps":["trace[1771596245] 'agreement among raft nodes before linearized reading' (duration: 112.619226ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:37:16.352227Z","caller":"traceutil/trace.go:171","msg":"trace[1187355865] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"142.196523ms","start":"2026-06-27T05:37:16.210002Z","end":"2026-06-27T05:37:16.352198Z","steps":["trace[1187355865] 'read index received' (duration: 141.368566ms)","trace[1187355865] 'applied index is now lower than readState.Index' (duration: 826.987µs)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:37:16.352329Z","caller":"traceutil/trace.go:171","msg":"trace[1329287414] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"201.143373ms","start":"2026-06-27T05:37:16.151152Z","end":"2026-06-27T05:37:16.352295Z","steps":["trace[1329287414] 'process raft request' (duration: 200.447232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:37:16.35248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.457324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-27T05:37:16.352514Z","caller":"traceutil/trace.go:171","msg":"trace[561871317] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"142.542858ms","start":"2026-06-27T05:37:16.209962Z","end":"2026-06-27T05:37:16.352505Z","steps":["trace[561871317] 'agreement among raft nodes before linearized reading' (duration: 142.386531ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:37:16.987155Z","caller":"traceutil/trace.go:171","msg":"trace[1975779369] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"128.718264ms","start":"2026-06-27T05:37:16.858409Z","end":"2026-06-27T05:37:16.987127Z","steps":["trace[1975779369] 'process raft request' (duration: 128.532896ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:37:17.423088Z","caller":"traceutil/trace.go:171","msg":"trace[772873616] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"516.469974ms","start":"2026-06-27T05:37:16.906593Z","end":"2026-06-27T05:37:17.423063Z","steps":["trace[772873616] 'process raft request' (duration: 515.796154ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:37:17.423497Z","caller":"traceutil/trace.go:171","msg":"trace[1637057561] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"209.960066ms","start":"2026-06-27T05:37:17.213507Z","end":"2026-06-27T05:37:17.423467Z","steps":["trace[1637057561] 'process raft request' (duration: 209.502926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:37:17.423633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-27T05:37:16.906549Z","time spent":"516.61606ms","remote":"127.0.0.1:51584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-27T05:37:32.561923Z","caller":"traceutil/trace.go:171","msg":"trace[460609242] linearizableReadLoop","detail":"{readStateIndex:785; appliedIndex:784; }","duration":"115.486524ms","start":"2026-06-27T05:37:32.446411Z","end":"2026-06-27T05:37:32.561897Z","steps":["trace[460609242] 'read index received' (duration: 115.322328ms)","trace[460609242] 'applied index is now lower than readState.Index' (duration: 163.376µs)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:37:32.562025Z","caller":"traceutil/trace.go:171","msg":"trace[315667518] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"128.599277ms","start":"2026-06-27T05:37:32.433401Z","end":"2026-06-27T05:37:32.562Z","steps":["trace[315667518] 'process raft request' (duration: 128.365688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:37:32.562114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.680841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-27T05:37:32.562157Z","caller":"traceutil/trace.go:171","msg":"trace[1471366075] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:760; }","duration":"115.761734ms","start":"2026-06-27T05:37:32.446384Z","end":"2026-06-27T05:37:32.562146Z","steps":["trace[1471366075] 'agreement among raft nodes before linearized reading' (duration: 115.612609ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:38:39.515588Z","caller":"traceutil/trace.go:171","msg":"trace[89551567] linearizableReadLoop","detail":"{readStateIndex:1765; appliedIndex:1764; }","duration":"137.006106ms","start":"2026-06-27T05:38:39.378555Z","end":"2026-06-27T05:38:39.515561Z","steps":["trace[89551567] 'read index received' (duration: 136.696449ms)","trace[89551567] 'applied index is now lower than readState.Index' (duration: 308.467µs)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:38:39.515728Z","caller":"traceutil/trace.go:171","msg":"trace[1166990142] transaction","detail":"{read_only:false; response_revision:1698; number_of_response:1; }","duration":"139.722316ms","start":"2026-06-27T05:38:39.375991Z","end":"2026-06-27T05:38:39.515713Z","steps":["trace[1166990142] 'process raft request' (duration: 139.327727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:38:39.515902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.324203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T05:38:39.515966Z","caller":"traceutil/trace.go:171","msg":"trace[143965644] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:1698; }","duration":"137.409584ms","start":"2026-06-27T05:38:39.378543Z","end":"2026-06-27T05:38:39.515952Z","steps":["trace[143965644] 'agreement among raft nodes before linearized reading' (duration: 137.251331ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:38:39.515936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.350764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-27T05:38:39.515956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.436636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-27T05:38:39.515979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.519044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T05:38:39.51602Z","caller":"traceutil/trace.go:171","msg":"trace[1519195491] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:1698; }","duration":"122.539797ms","start":"2026-06-27T05:38:39.393466Z","end":"2026-06-27T05:38:39.516006Z","steps":["trace[1519195491] 'agreement among raft nodes before linearized reading' (duration: 122.423885ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:38:39.516027Z","caller":"traceutil/trace.go:171","msg":"trace[136220] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:1698; }","duration":"122.500727ms","start":"2026-06-27T05:38:39.3935Z","end":"2026-06-27T05:38:39.516Z","steps":["trace[136220] 'agreement among raft nodes before linearized reading' (duration: 122.346924ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:38:39.516045Z","caller":"traceutil/trace.go:171","msg":"trace[1846315543] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:1698; }","duration":"121.612718ms","start":"2026-06-27T05:38:39.394415Z","end":"2026-06-27T05:38:39.516028Z","steps":["trace[1846315543] 'agreement among raft nodes before linearized reading' (duration: 121.507796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:38:39.515927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T05:38:39.516169Z","caller":"traceutil/trace.go:171","msg":"trace[1665468559] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:1698; }","duration":"137.474555ms","start":"2026-06-27T05:38:39.378677Z","end":"2026-06-27T05:38:39.516151Z","steps":["trace[1665468559] 'agreement among raft nodes before linearized reading' (duration: 137.132118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:38:39.516182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.158525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T05:38:39.51645Z","caller":"traceutil/trace.go:171","msg":"trace[530392820] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:1698; }","duration":"135.42918ms","start":"2026-06-27T05:38:39.380995Z","end":"2026-06-27T05:38:39.516424Z","steps":["trace[530392820] 'agreement among raft nodes before linearized reading' (duration: 135.161005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:38:48.842674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.399534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9be990bd-9ac6-47e9-b179-47bcfee3dad9\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-27T05:38:48.842776Z","caller":"traceutil/trace.go:171","msg":"trace[796329114] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9be990bd-9ac6-47e9-b179-47bcfee3dad9; range_end:; response_count:1; response_revision:1825; }","duration":"193.557558ms","start":"2026-06-27T05:38:48.649195Z","end":"2026-06-27T05:38:48.842752Z","steps":["trace[796329114] 'range keys from in-memory index tree' (duration: 192.574007ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:38:49.120606Z","caller":"traceutil/trace.go:171","msg":"trace[793008526] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"177.247074ms","start":"2026-06-27T05:38:48.943336Z","end":"2026-06-27T05:38:49.120583Z","steps":["trace[793008526] 'process raft request' (duration: 177.07544ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:39:03.788686Z","caller":"traceutil/trace.go:171","msg":"trace[580385998] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"102.581019ms","start":"2026-06-27T05:39:03.686075Z","end":"2026-06-27T05:39:03.788656Z","steps":["trace[580385998] 'process raft request' (duration: 102.407445ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:39:37.325454Z","caller":"traceutil/trace.go:171","msg":"trace[752699314] linearizableReadLoop","detail":"{readStateIndex:2217; appliedIndex:2216; }","duration":"190.598204ms","start":"2026-06-27T05:39:37.134833Z","end":"2026-06-27T05:39:37.325432Z","steps":["trace[752699314] 'read index received' (duration: 190.439882ms)","trace[752699314] 'applied index is now lower than readState.Index' (duration: 157.482µs)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:39:37.325546Z","caller":"traceutil/trace.go:171","msg":"trace[1803421279] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"233.902021ms","start":"2026-06-27T05:39:37.091621Z","end":"2026-06-27T05:39:37.325523Z","steps":["trace[1803421279] 'process raft request' (duration: 233.634016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:39:37.325713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.862319ms","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-06-27T05:39:37.325774Z","caller":"traceutil/trace.go:171","msg":"trace[805948272] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2136; }","duration":"190.991101ms","start":"2026-06-27T05:39:37.134767Z","end":"2026-06-27T05:39:37.325758Z","steps":["trace[805948272] 'agreement among raft nodes before linearized reading' (duration: 190.792068ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:39:37.438923Z","caller":"traceutil/trace.go:171","msg":"trace[385675753] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2217; }","duration":"113.363571ms","start":"2026-06-27T05:39:37.325529Z","end":"2026-06-27T05:39:37.438893Z","steps":["trace[385675753] 'read index received' (duration: 112.80902ms)","trace[385675753] 'applied index is now lower than readState.Index' (duration: 553.141µs)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:39:37.439132Z","caller":"traceutil/trace.go:171","msg":"trace[1282378878] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"178.771014ms","start":"2026-06-27T05:39:37.260333Z","end":"2026-06-27T05:39:37.439104Z","steps":["trace[1282378878] 'process raft request' (duration: 177.97972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:39:37.439329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.909178ms","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-06-27T05:39:37.439416Z","caller":"traceutil/trace.go:171","msg":"trace[2020610610] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2137; }","duration":"269.04376ms","start":"2026-06-27T05:39:37.170356Z","end":"2026-06-27T05:39:37.4394Z","steps":["trace[2020610610] 'agreement among raft nodes before linearized reading' (duration: 268.763115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:39:37.440638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.024037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-27T05:39:37.440683Z","caller":"traceutil/trace.go:171","msg":"trace[1802223650] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2138; }","duration":"112.119168ms","start":"2026-06-27T05:39:37.328553Z","end":"2026-06-27T05:39:37.440672Z","steps":["trace[1802223650] 'agreement among raft nodes before linearized reading' (duration: 111.952845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:39:37.440997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.050438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-27T05:39:37.441083Z","caller":"traceutil/trace.go:171","msg":"trace[2111612591] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2138; }","duration":"105.150759ms","start":"2026-06-27T05:39:37.335893Z","end":"2026-06-27T05:39:37.441044Z","steps":["trace[2111612591] 'agreement among raft nodes before linearized reading' (duration: 104.898355ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:39:37.441016Z","caller":"traceutil/trace.go:171","msg":"trace[1375841088] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"110.531201ms","start":"2026-06-27T05:39:37.330475Z","end":"2026-06-27T05:39:37.441006Z","steps":["trace[1375841088] 'process raft request' (duration: 109.959381ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:39:37.666462Z","caller":"traceutil/trace.go:171","msg":"trace[1548747714] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"220.438103ms","start":"2026-06-27T05:39:37.445996Z","end":"2026-06-27T05:39:37.666434Z","steps":["trace[1548747714] 'process raft request' (duration: 220.384782ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:39:37.666656Z","caller":"traceutil/trace.go:171","msg":"trace[1963453084] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"221.457339ms","start":"2026-06-27T05:39:37.445191Z","end":"2026-06-27T05:39:37.666649Z","steps":["trace[1963453084] 'process raft request' (duration: 220.537464ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:39:37.66668Z","caller":"traceutil/trace.go:171","msg":"trace[1857621434] linearizableReadLoop","detail":"{readStateIndex:2223; appliedIndex:2220; }","duration":"151.60641ms","start":"2026-06-27T05:39:37.515049Z","end":"2026-06-27T05:39:37.666655Z","steps":["trace[1857621434] 'read index received' (duration: 5.956011ms)","trace[1857621434] 'applied index is now lower than readState.Index' (duration: 145.648739ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:39:37.666714Z","caller":"traceutil/trace.go:171","msg":"trace[210016477] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"220.235439ms","start":"2026-06-27T05:39:37.446472Z","end":"2026-06-27T05:39:37.666708Z","steps":["trace[210016477] 'process raft request' (duration: 219.937634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:39:37.666943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.882306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-06-27T05:39:37.666974Z","caller":"traceutil/trace.go:171","msg":"trace[377076773] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2142; }","duration":"151.980707ms","start":"2026-06-27T05:39:37.514983Z","end":"2026-06-27T05:39:37.666963Z","steps":["trace[377076773] 'agreement among raft nodes before linearized reading' (duration: 151.750483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:40:28.63019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.85923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T05:40:28.630282Z","caller":"traceutil/trace.go:171","msg":"trace[2090022196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2516; }","duration":"155.025613ms","start":"2026-06-27T05:40:28.475239Z","end":"2026-06-27T05:40:28.630264Z","steps":["trace[2090022196] 'range keys from in-memory index tree' (duration: 154.763858ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:41:00.498873Z","caller":"traceutil/trace.go:171","msg":"trace[246529506] linearizableReadLoop","detail":"{readStateIndex:2791; appliedIndex:2790; }","duration":"106.217269ms","start":"2026-06-27T05:41:00.392631Z","end":"2026-06-27T05:41:00.498849Z","steps":["trace[246529506] 'read index received' (duration: 106.002005ms)","trace[246529506] 'applied index is now lower than readState.Index' (duration: 214.124µs)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:41:00.499223Z","caller":"traceutil/trace.go:171","msg":"trace[1781162103] transaction","detail":"{read_only:false; response_revision:2692; number_of_response:1; }","duration":"123.660894ms","start":"2026-06-27T05:41:00.375531Z","end":"2026-06-27T05:41:00.499192Z","steps":["trace[1781162103] 'process raft request' (duration: 123.134296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:41:00.499856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.214384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-27T05:41:00.500038Z","caller":"traceutil/trace.go:171","msg":"trace[1459105580] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2692; }","duration":"107.456777ms","start":"2026-06-27T05:41:00.392567Z","end":"2026-06-27T05:41:00.500024Z","steps":["trace[1459105580] 'agreement among raft nodes before linearized reading' (duration: 106.574204ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:41:00.766103Z","caller":"traceutil/trace.go:171","msg":"trace[198675874] linearizableReadLoop","detail":"{readStateIndex:2792; appliedIndex:2791; }","duration":"203.258534ms","start":"2026-06-27T05:41:00.562818Z","end":"2026-06-27T05:41:00.766077Z","steps":["trace[198675874] 'read index received' (duration: 174.189841ms)","trace[198675874] 'applied index is now lower than readState.Index' (duration: 29.067523ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:41:00.766157Z","caller":"traceutil/trace.go:171","msg":"trace[222908290] transaction","detail":"{read_only:false; response_revision:2693; number_of_response:1; }","duration":"229.903063ms","start":"2026-06-27T05:41:00.536213Z","end":"2026-06-27T05:41:00.766116Z","steps":["trace[222908290] 'process raft request' (duration: 197.299567ms)","trace[222908290] 'compare' (duration: 32.409753ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T05:41:00.766384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.421578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T05:41:00.766437Z","caller":"traceutil/trace.go:171","msg":"trace[2068474993] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2693; }","duration":"203.63823ms","start":"2026-06-27T05:41:00.562784Z","end":"2026-06-27T05:41:00.766422Z","steps":["trace[2068474993] 'agreement among raft nodes before linearized reading' (duration: 203.421927ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:41:06.050373Z","caller":"traceutil/trace.go:171","msg":"trace[1324810973] transaction","detail":"{read_only:false; response_revision:2717; number_of_response:1; }","duration":"119.388193ms","start":"2026-06-27T05:41:05.930965Z","end":"2026-06-27T05:41:06.050353Z","steps":["trace[1324810973] 'process raft request' (duration: 119.257321ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:41:06.200828Z","caller":"traceutil/trace.go:171","msg":"trace[561393208] linearizableReadLoop","detail":"{readStateIndex:2819; appliedIndex:2817; }","duration":"162.273574ms","start":"2026-06-27T05:41:06.038527Z","end":"2026-06-27T05:41:06.200801Z","steps":["trace[561393208] 'read index received' (duration: 11.68807ms)","trace[561393208] 'applied index is now lower than readState.Index' (duration: 150.584284ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:41:06.200925Z","caller":"traceutil/trace.go:171","msg":"trace[1114479873] transaction","detail":"{read_only:false; response_revision:2718; number_of_response:1; }","duration":"260.958136ms","start":"2026-06-27T05:41:05.939932Z","end":"2026-06-27T05:41:06.20089Z","steps":["trace[1114479873] 'process raft request' (duration: 234.606154ms)","trace[1114479873] 'compare' (duration: 26.128099ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T05:41:06.20137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.816712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"} {"level":"info","ts":"2026-06-27T05:41:06.201452Z","caller":"traceutil/trace.go:171","msg":"trace[857702564] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2718; }","duration":"162.980154ms","start":"2026-06-27T05:41:06.038454Z","end":"2026-06-27T05:41:06.201434Z","steps":["trace[857702564] 'agreement among raft nodes before linearized reading' (duration: 162.537388ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:44:50.829042Z","caller":"traceutil/trace.go:171","msg":"trace[556797492] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"121.591045ms","start":"2026-06-27T05:44:50.707434Z","end":"2026-06-27T05:44:50.829025Z","steps":["trace[556797492] 'process raft request' (duration: 121.489583ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:44:51.165769Z","caller":"traceutil/trace.go:171","msg":"trace[880325628] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"102.249135ms","start":"2026-06-27T05:44:51.063476Z","end":"2026-06-27T05:44:51.165725Z","steps":["trace[880325628] 'process raft request' (duration: 76.267889ms)","trace[880325628] 'compare' (duration: 25.75994ms)"],"step_count":2} {"level":"warn","ts":"2026-06-27T05:45:03.421266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.542313ms","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-06-27T05:45:03.42135Z","caller":"traceutil/trace.go:171","msg":"trace[1429874945] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4832; }","duration":"155.673026ms","start":"2026-06-27T05:45:03.265658Z","end":"2026-06-27T05:45:03.421331Z","steps":["trace[1429874945] 'range keys from in-memory index tree' (duration: 155.38654ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:45:03.421408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.23479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"info","ts":"2026-06-27T05:45:03.421555Z","caller":"traceutil/trace.go:171","msg":"trace[1967122131] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4832; }","duration":"234.409583ms","start":"2026-06-27T05:45:03.187127Z","end":"2026-06-27T05:45:03.421536Z","steps":["trace[1967122131] 'range keys from in-memory index tree' (duration: 234.052715ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:45:03.560737Z","caller":"traceutil/trace.go:171","msg":"trace[66620381] linearizableReadLoop","detail":"{readStateIndex:5019; appliedIndex:5018; }","duration":"195.531506ms","start":"2026-06-27T05:45:03.365184Z","end":"2026-06-27T05:45:03.560715Z","steps":["trace[66620381] 'read index received' (duration: 195.467424ms)","trace[66620381] 'applied index is now lower than readState.Index' (duration: 63.132µs)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:45:03.560841Z","caller":"traceutil/trace.go:171","msg":"trace[904940530] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"205.094137ms","start":"2026-06-27T05:45:03.355736Z","end":"2026-06-27T05:45:03.56083Z","steps":["trace[904940530] 'process raft request' (duration: 204.849642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:45:03.561116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.914545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-27T05:45:03.561224Z","caller":"traceutil/trace.go:171","msg":"trace[1882041559] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4833; }","duration":"196.067678ms","start":"2026-06-27T05:45:03.365129Z","end":"2026-06-27T05:45:03.561197Z","steps":["trace[1882041559] 'agreement among raft nodes before linearized reading' (duration: 195.838633ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:45:03.598876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.923422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T05:45:03.598955Z","caller":"traceutil/trace.go:171","msg":"trace[1495750033] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:4834; }","duration":"204.047644ms","start":"2026-06-27T05:45:03.394888Z","end":"2026-06-27T05:45:03.598935Z","steps":["trace[1495750033] 'agreement among raft nodes before linearized reading' (duration: 203.912071ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:45:03.599333Z","caller":"traceutil/trace.go:171","msg":"trace[612861631] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"167.961938ms","start":"2026-06-27T05:45:03.431333Z","end":"2026-06-27T05:45:03.599295Z","steps":["trace[612861631] 'process raft request' (duration: 167.336484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:45:03.599596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.246515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-27T05:45:03.599671Z","caller":"traceutil/trace.go:171","msg":"trace[1525946768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4834; }","duration":"125.395308ms","start":"2026-06-27T05:45:03.474257Z","end":"2026-06-27T05:45:03.599653Z","steps":["trace[1525946768] 'agreement among raft nodes before linearized reading' (duration: 125.225915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:45:03.600076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.344291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9b2e5b29-cc3c-4e94-8aba-861184a871a5\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-06-27T05:45:03.600229Z","caller":"traceutil/trace.go:171","msg":"trace[70957502] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9b2e5b29-cc3c-4e94-8aba-861184a871a5; range_end:; response_count:1; response_revision:4834; }","duration":"175.900363ms","start":"2026-06-27T05:45:03.424308Z","end":"2026-06-27T05:45:03.600209Z","steps":["trace[70957502] 'agreement among raft nodes before linearized reading' (duration: 174.968453ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:45:03.762763Z","caller":"traceutil/trace.go:171","msg":"trace[1605196178] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"155.893711ms","start":"2026-06-27T05:45:03.606841Z","end":"2026-06-27T05:45:03.762735Z","steps":["trace[1605196178] 'process raft request' (duration: 155.786339ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:45:03.762837Z","caller":"traceutil/trace.go:171","msg":"trace[1428114602] transaction","detail":"{read_only:false; response_revision:4836; number_of_response:1; }","duration":"158.899706ms","start":"2026-06-27T05:45:03.603911Z","end":"2026-06-27T05:45:03.762811Z","steps":["trace[1428114602] 'process raft request' (duration: 85.035457ms)","trace[1428114602] 'compare' (duration: 73.318668ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:45:03.763163Z","caller":"traceutil/trace.go:171","msg":"trace[1674196545] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"156.269739ms","start":"2026-06-27T05:45:03.606871Z","end":"2026-06-27T05:45:03.76314Z","steps":["trace[1674196545] 'process raft request' (duration: 155.815749ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:45:03.76321Z","caller":"traceutil/trace.go:171","msg":"trace[732480934] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"156.280729ms","start":"2026-06-27T05:45:03.606909Z","end":"2026-06-27T05:45:03.76319Z","steps":["trace[732480934] 'process raft request' (duration: 156.136346ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:45:03.763378Z","caller":"traceutil/trace.go:171","msg":"trace[402090939] linearizableReadLoop","detail":"{readStateIndex:5027; appliedIndex:5021; }","duration":"153.090378ms","start":"2026-06-27T05:45:03.610266Z","end":"2026-06-27T05:45:03.763357Z","steps":["trace[402090939] 'read index received' (duration: 78.692307ms)","trace[402090939] 'applied index is now lower than readState.Index' (duration: 74.396751ms)"],"step_count":2} {"level":"info","ts":"2026-06-27T05:45:03.763405Z","caller":"traceutil/trace.go:171","msg":"trace[1606833684] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"155.915241ms","start":"2026-06-27T05:45:03.607469Z","end":"2026-06-27T05:45:03.763384Z","steps":["trace[1606833684] 'process raft request' (duration: 155.799968ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:45:03.763574Z","caller":"traceutil/trace.go:171","msg":"trace[376469952] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"156.610367ms","start":"2026-06-27T05:45:03.606945Z","end":"2026-06-27T05:45:03.763555Z","steps":["trace[376469952] 'process raft request' (duration: 156.187546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:45:03.763631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.703653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-27T05:45:03.763686Z","caller":"traceutil/trace.go:171","msg":"trace[592232209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4841; }","duration":"153.778364ms","start":"2026-06-27T05:45:03.60989Z","end":"2026-06-27T05:45:03.763668Z","steps":["trace[592232209] 'agreement among raft nodes before linearized reading' (duration: 153.654181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-27T05:45:03.763706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.467809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"warn","ts":"2026-06-27T05:45:03.763592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.280186ms","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-06-27T05:45:03.763759Z","caller":"traceutil/trace.go:171","msg":"trace[1882118022] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4841; }","duration":"158.54613ms","start":"2026-06-27T05:45:03.605196Z","end":"2026-06-27T05:45:03.763742Z","steps":["trace[1882118022] 'agreement among raft nodes before linearized reading' (duration: 158.424917ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:45:03.763779Z","caller":"traceutil/trace.go:171","msg":"trace[246623441] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4841; }","duration":"159.516861ms","start":"2026-06-27T05:45:03.604251Z","end":"2026-06-27T05:45:03.763767Z","steps":["trace[246623441] 'agreement among raft nodes before linearized reading' (duration: 159.184263ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:45:38.227113Z","caller":"traceutil/trace.go:171","msg":"trace[850962388] transaction","detail":"{read_only:false; response_revision:5167; number_of_response:1; }","duration":"103.558599ms","start":"2026-06-27T05:45:38.123515Z","end":"2026-06-27T05:45:38.227073Z","steps":["trace[850962388] 'process raft request' (duration: 103.374375ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:46:32.103662Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2854} {"level":"info","ts":"2026-06-27T05:46:32.176397Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2854,"took":"70.847887ms","hash":1228564355,"current-db-size-bytes":54423552,"current-db-size":"54 MB","current-db-size-in-use-bytes":29687808,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-27T05:46:32.176458Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1228564355,"revision":2854,"compact-revision":-1} {"level":"info","ts":"2026-06-27T05:48:53.454133Z","caller":"traceutil/trace.go:171","msg":"trace[463411846] transaction","detail":"{read_only:false; response_revision:6549; number_of_response:1; }","duration":"117.493643ms","start":"2026-06-27T05:48:53.336621Z","end":"2026-06-27T05:48:53.454115Z","steps":["trace[463411846] 'process raft request' (duration: 117.393201ms)"],"step_count":1} {"level":"info","ts":"2026-06-27T05:51:32.109042Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5574} {"level":"info","ts":"2026-06-27T05:51:32.175823Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5574,"took":"65.232067ms","hash":2617427496,"current-db-size-bytes":54423552,"current-db-size":"54 MB","current-db-size-in-use-bytes":18235392,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-27T05:51:32.175905Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2617427496,"revision":5574,"compact-revision":2854}