{"level":"warn","ts":"2026-04-16T22:48:42.579803Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T22:48:42.579896Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.246: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.246:2380","--initial-cluster=instance=https://199.204.45.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.246:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-16T22:48:42.579966Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T22:48:42.579973Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-04-16T22:48:42.57999Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-16T22:48:42.580891Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"]} {"level":"info","ts":"2026-04-16T22:48:42.58099Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.246:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-16T22:48:42.58498Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.785729ms"} {"level":"info","ts":"2026-04-16T22:48:42.596827Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab97322ebdd79664","cluster-id":"87bc89380c3dc2c"} {"level":"info","ts":"2026-04-16T22:48:42.596947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T22:48:42.596977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 0"} {"level":"info","ts":"2026-04-16T22:48:42.596992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab97322ebdd79664 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T22:48:42.597002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 1"} {"level":"info","ts":"2026-04-16T22:48:42.597058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"warn","ts":"2026-04-16T22:48:42.605077Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T22:48:42.606645Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T22:48:42.607919Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-16T22:48:42.610145Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab97322ebdd79664","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T22:48:42.6106Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T22:48:42.61069Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab97322ebdd79664","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T22:48:42.610907Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T22:48:42.611031Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T22:48:42.613152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"info","ts":"2026-04-16T22:48:42.613424Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","added-peer-id":"ab97322ebdd79664","added-peer-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-04-16T22:48:42.618362Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-16T22:48:42.618726Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab97322ebdd79664","initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T22:48:42.618919Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-04-16T22:48:42.619021Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-04-16T22:48:42.618927Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T22:48:42.997792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T22:48:42.997881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T22:48:42.997911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgPreVoteResp from ab97322ebdd79664 at term 1"} {"level":"info","ts":"2026-04-16T22:48:42.997922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became candidate at term 2"} {"level":"info","ts":"2026-04-16T22:48:42.997928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgVoteResp from ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-04-16T22:48:42.997937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became leader at term 2"} {"level":"info","ts":"2026-04-16T22:48:42.997944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab97322ebdd79664 elected leader ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-04-16T22:48:43.008711Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:48:43.010016Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab97322ebdd79664","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.246:2379]}","request-path":"/0/members/ab97322ebdd79664/attributes","cluster-id":"87bc89380c3dc2c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T22:48:43.01004Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T22:48:43.010107Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T22:48:43.010503Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T22:48:43.010555Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T22:48:43.012115Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:48:43.012319Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:48:43.012405Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T22:48:43.013029Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.246:2379"} {"level":"info","ts":"2026-04-16T22:48:43.014436Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T22:49:11.097577Z","caller":"traceutil/trace.go:171","msg":"trace[1724262041] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"128.450919ms","start":"2026-04-16T22:49:10.969092Z","end":"2026-04-16T22:49:11.097543Z","steps":["trace[1724262041] 'process raft request' (duration: 128.158781ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:12.528359Z","caller":"traceutil/trace.go:171","msg":"trace[1889584432] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"105.121336ms","start":"2026-04-16T22:49:12.423184Z","end":"2026-04-16T22:49:12.528305Z","steps":["trace[1889584432] 'process raft request' (duration: 104.851918ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:18.730482Z","caller":"traceutil/trace.go:171","msg":"trace[701201632] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"153.229565ms","start":"2026-04-16T22:49:18.577216Z","end":"2026-04-16T22:49:18.730446Z","steps":["trace[701201632] 'process raft request' (duration: 153.018729ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:18.80544Z","caller":"traceutil/trace.go:171","msg":"trace[129191799] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"227.273379ms","start":"2026-04-16T22:49:18.578066Z","end":"2026-04-16T22:49:18.805339Z","steps":["trace[129191799] 'process raft request' (duration: 221.743505ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:18.948083Z","caller":"traceutil/trace.go:171","msg":"trace[33914242] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"137.526788ms","start":"2026-04-16T22:49:18.810493Z","end":"2026-04-16T22:49:18.94802Z","steps":["trace[33914242] 'process raft request' (duration: 137.367284ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:49:19.527199Z","caller":"traceutil/trace.go:171","msg":"trace[291230209] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"181.842102ms","start":"2026-04-16T22:49:19.345325Z","end":"2026-04-16T22:49:19.527167Z","steps":["trace[291230209] 'process raft request' (duration: 179.870417ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:50:28.503673Z","caller":"traceutil/trace.go:171","msg":"trace[1400117029] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"128.235179ms","start":"2026-04-16T22:50:28.375411Z","end":"2026-04-16T22:50:28.503647Z","steps":["trace[1400117029] 'process raft request' (duration: 128.041583ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:50:51.631965Z","caller":"traceutil/trace.go:171","msg":"trace[569390114] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"100.193546ms","start":"2026-04-16T22:50:51.531747Z","end":"2026-04-16T22:50:51.631941Z","steps":["trace[569390114] 'process raft request' (duration: 47.826995ms)","trace[569390114] 'compare' (duration: 52.267958ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:50:51.891911Z","caller":"traceutil/trace.go:171","msg":"trace[1150804651] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"358.687198ms","start":"2026-04-16T22:50:51.533205Z","end":"2026-04-16T22:50:51.891893Z","steps":["trace[1150804651] 'process raft request' (duration: 358.580035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:50:51.892327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T22:50:51.533198Z","time spent":"358.765051ms","remote":"127.0.0.1:33440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T22:50:52.017079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.098244ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T22:51:30.573289Z","caller":"traceutil/trace.go:171","msg":"trace[1479086355] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"107.005564ms","start":"2026-04-16T22:51:30.46626Z","end":"2026-04-16T22:51:30.573266Z","steps":["trace[1479086355] 'process raft request' (duration: 106.86561ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:51:36.027417Z","caller":"traceutil/trace.go:171","msg":"trace[1523337403] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"121.543944ms","start":"2026-04-16T22:51:35.905847Z","end":"2026-04-16T22:51:36.027391Z","steps":["trace[1523337403] 'process raft request' (duration: 84.721871ms)","trace[1523337403] 'compare' (duration: 36.72835ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:51:36.368344Z","caller":"traceutil/trace.go:171","msg":"trace[1046401546] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"106.913811ms","start":"2026-04-16T22:51:36.26138Z","end":"2026-04-16T22:51:36.368294Z","steps":["trace[1046401546] 'process raft request' (duration: 106.626723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:53:05.680777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.148412ms","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-04-16T22:53:05.680883Z","caller":"traceutil/trace.go:171","msg":"trace[595140256] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2773; }","duration":"106.313546ms","start":"2026-04-16T22:53:05.574546Z","end":"2026-04-16T22:53:05.680859Z","steps":["trace[595140256] 'range keys from in-memory index tree' (duration: 105.938866ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:53:05.937467Z","caller":"traceutil/trace.go:171","msg":"trace[770670495] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"251.82939ms","start":"2026-04-16T22:53:05.68561Z","end":"2026-04-16T22:53:05.937439Z","steps":["trace[770670495] 'process raft request' (duration: 251.657095ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:56:57.880143Z","caller":"traceutil/trace.go:171","msg":"trace[1185868254] transaction","detail":"{read_only:false; response_revision:4804; number_of_response:1; }","duration":"105.843705ms","start":"2026-04-16T22:56:57.774269Z","end":"2026-04-16T22:56:57.880113Z","steps":["trace[1185868254] 'process raft request' (duration: 105.619658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:57:02.006092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.699951ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T22:57:02.006211Z","caller":"traceutil/trace.go:171","msg":"trace[1724421835] linearizableReadLoop","detail":"{readStateIndex:5137; appliedIndex:5136; }","duration":"166.505345ms","start":"2026-04-16T22:57:01.839688Z","end":"2026-04-16T22:57:02.006193Z","steps":["trace[1724421835] 'read index received' (duration: 32.657579ms)","trace[1724421835] 'applied index is now lower than readState.Index' (duration: 133.846376ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:57:02.006282Z","caller":"traceutil/trace.go:171","msg":"trace[1286708984] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"248.345819ms","start":"2026-04-16T22:57:01.757883Z","end":"2026-04-16T22:57:02.006229Z","steps":["trace[1286708984] 'process raft request' (duration: 114.423261ms)","trace[1286708984] 'compare' (duration: 132.853308ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:57:02.006416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.729181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c5343949-584a-495e-9b69-b0c28401afc3\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-16T22:57:02.006461Z","caller":"traceutil/trace.go:171","msg":"trace[554365231] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c5343949-584a-495e-9b69-b0c28401afc3; range_end:; response_count:1; response_revision:4946; }","duration":"166.831924ms","start":"2026-04-16T22:57:01.839616Z","end":"2026-04-16T22:57:02.006448Z","steps":["trace[554365231] 'agreement among raft nodes before linearized reading' (duration: 166.627658ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:57:02.053182Z","caller":"traceutil/trace.go:171","msg":"trace[466452227] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"148.319414ms","start":"2026-04-16T22:57:01.904817Z","end":"2026-04-16T22:57:02.053137Z","steps":["trace[466452227] 'process raft request' (duration: 148.066227ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:57:02.413876Z","caller":"traceutil/trace.go:171","msg":"trace[1061556374] linearizableReadLoop","detail":"{readStateIndex:5148; appliedIndex:5147; }","duration":"188.562422ms","start":"2026-04-16T22:57:02.22528Z","end":"2026-04-16T22:57:02.413843Z","steps":["trace[1061556374] 'read index received' (duration: 104.993531ms)","trace[1061556374] 'applied index is now lower than readState.Index' (duration: 83.567901ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:57:02.414181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.857521ms","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-04-16T22:57:02.413996Z","caller":"traceutil/trace.go:171","msg":"trace[1124422044] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"250.020435ms","start":"2026-04-16T22:57:02.163911Z","end":"2026-04-16T22:57:02.413932Z","steps":["trace[1124422044] 'process raft request' (duration: 166.452433ms)","trace[1124422044] 'compare' (duration: 83.301404ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:57:02.414293Z","caller":"traceutil/trace.go:171","msg":"trace[1556468548] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:4957; }","duration":"189.043376ms","start":"2026-04-16T22:57:02.225223Z","end":"2026-04-16T22:57:02.414266Z","steps":["trace[1556468548] 'agreement among raft nodes before linearized reading' (duration: 188.795449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:57:02.414651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.544615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777473"} {"level":"info","ts":"2026-04-16T22:57:02.414707Z","caller":"traceutil/trace.go:171","msg":"trace[1338448323] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4957; }","duration":"146.673028ms","start":"2026-04-16T22:57:02.26802Z","end":"2026-04-16T22:57:02.414693Z","steps":["trace[1338448323] 'agreement among raft nodes before linearized reading' (duration: 146.01488ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:57:02.549654Z","caller":"traceutil/trace.go:171","msg":"trace[781445362] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"122.585306ms","start":"2026-04-16T22:57:02.427022Z","end":"2026-04-16T22:57:02.549607Z","steps":["trace[781445362] 'process raft request' (duration: 92.783215ms)","trace[781445362] 'compare' (duration: 29.575224ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:57:02.549782Z","caller":"traceutil/trace.go:171","msg":"trace[1334668669] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"116.865698ms","start":"2026-04-16T22:57:02.432869Z","end":"2026-04-16T22:57:02.549734Z","steps":["trace[1334668669] 'process raft request' (duration: 116.668243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T22:57:13.837242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.51053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-fr896\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-04-16T22:57:13.837291Z","caller":"traceutil/trace.go:171","msg":"trace[1199465584] linearizableReadLoop","detail":"{readStateIndex:5380; appliedIndex:5379; }","duration":"150.520335ms","start":"2026-04-16T22:57:13.686732Z","end":"2026-04-16T22:57:13.837252Z","steps":["trace[1199465584] 'read index received' (duration: 80.162288ms)","trace[1199465584] 'applied index is now lower than readState.Index' (duration: 70.356447ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T22:57:13.837352Z","caller":"traceutil/trace.go:171","msg":"trace[468396341] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-fr896; range_end:; response_count:1; response_revision:5181; }","duration":"229.692665ms","start":"2026-04-16T22:57:13.607637Z","end":"2026-04-16T22:57:13.837329Z","steps":["trace[468396341] 'range keys from in-memory index tree' (duration: 229.263313ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:57:13.837376Z","caller":"traceutil/trace.go:171","msg":"trace[362181849] transaction","detail":"{read_only:false; response_revision:5182; number_of_response:1; }","duration":"218.315912ms","start":"2026-04-16T22:57:13.619005Z","end":"2026-04-16T22:57:13.837321Z","steps":["trace[362181849] 'process raft request' (duration: 147.938774ms)","trace[362181849] 'compare' (duration: 70.022088ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T22:57:13.837503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.735541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T22:57:13.837561Z","caller":"traceutil/trace.go:171","msg":"trace[1176262787] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:5182; }","duration":"150.877834ms","start":"2026-04-16T22:57:13.686666Z","end":"2026-04-16T22:57:13.837544Z","steps":["trace[1176262787] 'agreement among raft nodes before linearized reading' (duration: 150.752031ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T22:58:43.195973Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2981} {"level":"info","ts":"2026-04-16T22:58:43.273599Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2981,"took":"75.510412ms","hash":4228266809,"current-db-size-bytes":58445824,"current-db-size":"58 MB","current-db-size-in-use-bytes":33783808,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-16T22:58:43.273769Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4228266809,"revision":2981,"compact-revision":-1} {"level":"info","ts":"2026-04-16T23:03:15.631781Z","caller":"traceutil/trace.go:171","msg":"trace[90018009] transaction","detail":"{read_only:false; response_revision:8115; number_of_response:1; }","duration":"116.956074ms","start":"2026-04-16T23:03:15.51479Z","end":"2026-04-16T23:03:15.631746Z","steps":["trace[90018009] 'process raft request' (duration: 116.577453ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:26.502167Z","caller":"traceutil/trace.go:171","msg":"trace[584700496] transaction","detail":"{read_only:false; response_revision:8173; number_of_response:1; }","duration":"124.611285ms","start":"2026-04-16T23:03:26.377522Z","end":"2026-04-16T23:03:26.502133Z","steps":["trace[584700496] 'process raft request' (duration: 124.388949ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:26.529125Z","caller":"traceutil/trace.go:171","msg":"trace[112466939] transaction","detail":"{read_only:false; response_revision:8174; number_of_response:1; }","duration":"131.407903ms","start":"2026-04-16T23:03:26.397682Z","end":"2026-04-16T23:03:26.52909Z","steps":["trace[112466939] 'process raft request' (duration: 131.034182ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:27.125214Z","caller":"traceutil/trace.go:171","msg":"trace[1857349329] linearizableReadLoop","detail":"{readStateIndex:8467; appliedIndex:8466; }","duration":"220.16838ms","start":"2026-04-16T23:03:26.905018Z","end":"2026-04-16T23:03:27.125187Z","steps":["trace[1857349329] 'read index received' (duration: 219.925524ms)","trace[1857349329] 'applied index is now lower than readState.Index' (duration: 241.306µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:03:27.12539Z","caller":"traceutil/trace.go:171","msg":"trace[1164053128] transaction","detail":"{read_only:false; response_revision:8176; number_of_response:1; }","duration":"318.267254ms","start":"2026-04-16T23:03:26.80705Z","end":"2026-04-16T23:03:27.125318Z","steps":["trace[1164053128] 'process raft request' (duration: 317.905914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:27.125419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.374436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T23:03:27.125631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:03:26.80699Z","time spent":"318.499671ms","remote":"127.0.0.1:33440","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-04-16T23:03:27.1257Z","caller":"traceutil/trace.go:171","msg":"trace[1134884099] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8176; }","duration":"220.712175ms","start":"2026-04-16T23:03:26.904973Z","end":"2026-04-16T23:03:27.125685Z","steps":["trace[1134884099] 'agreement among raft nodes before linearized reading' (duration: 220.351715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:27.135617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.343689ms","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-04-16T23:03:27.135674Z","caller":"traceutil/trace.go:171","msg":"trace[922381171] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8177; }","duration":"140.464503ms","start":"2026-04-16T23:03:26.995196Z","end":"2026-04-16T23:03:27.13566Z","steps":["trace[922381171] 'agreement among raft nodes before linearized reading' (duration: 140.305288ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:27.135986Z","caller":"traceutil/trace.go:171","msg":"trace[1564872630] transaction","detail":"{read_only:false; response_revision:8177; number_of_response:1; }","duration":"209.694391ms","start":"2026-04-16T23:03:26.926275Z","end":"2026-04-16T23:03:27.13597Z","steps":["trace[1564872630] 'process raft request' (duration: 208.745245ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:27.896206Z","caller":"traceutil/trace.go:171","msg":"trace[1007207752] transaction","detail":"{read_only:false; response_revision:8179; number_of_response:1; }","duration":"198.835691ms","start":"2026-04-16T23:03:27.697341Z","end":"2026-04-16T23:03:27.896177Z","steps":["trace[1007207752] 'process raft request' (duration: 198.674657ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:27.947384Z","caller":"traceutil/trace.go:171","msg":"trace[1356343473] linearizableReadLoop","detail":"{readStateIndex:8471; appliedIndex:8469; }","duration":"243.612415ms","start":"2026-04-16T23:03:27.703733Z","end":"2026-04-16T23:03:27.947345Z","steps":["trace[1356343473] 'read index received' (duration: 192.321542ms)","trace[1356343473] 'applied index is now lower than readState.Index' (duration: 51.289543ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:03:27.947393Z","caller":"traceutil/trace.go:171","msg":"trace[488742626] transaction","detail":"{read_only:false; response_revision:8180; number_of_response:1; }","duration":"246.569397ms","start":"2026-04-16T23:03:27.700807Z","end":"2026-04-16T23:03:27.947376Z","steps":["trace[488742626] 'process raft request' (duration: 214.630897ms)","trace[488742626] 'compare' (duration: 31.750265ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T23:03:27.947606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.680528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-16T23:03:27.947606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.521637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-4pzdt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-16T23:03:27.947662Z","caller":"traceutil/trace.go:171","msg":"trace[900336013] range","detail":"{range_begin:/registry/pods/openstack/keepalived-4pzdt; range_end:; response_count:1; response_revision:8180; }","duration":"229.6171ms","start":"2026-04-16T23:03:27.718039Z","end":"2026-04-16T23:03:27.947656Z","steps":["trace[900336013] 'agreement among raft nodes before linearized reading' (duration: 229.475306ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:27.947663Z","caller":"traceutil/trace.go:171","msg":"trace[1838960594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8180; }","duration":"243.77181ms","start":"2026-04-16T23:03:27.703881Z","end":"2026-04-16T23:03:27.947652Z","steps":["trace[1838960594] 'agreement among raft nodes before linearized reading' (duration: 243.611396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:27.947674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.886344ms","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-04-16T23:03:27.947774Z","caller":"traceutil/trace.go:171","msg":"trace[782416833] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8180; }","duration":"244.045648ms","start":"2026-04-16T23:03:27.703705Z","end":"2026-04-16T23:03:27.94775Z","steps":["trace[782416833] 'agreement among raft nodes before linearized reading' (duration: 243.734699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:27.947978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.943707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T23:03:27.948093Z","caller":"traceutil/trace.go:171","msg":"trace[2005621700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8180; }","duration":"243.093261ms","start":"2026-04-16T23:03:27.704969Z","end":"2026-04-16T23:03:27.948062Z","steps":["trace[2005621700] 'agreement among raft nodes before linearized reading' (duration: 242.68154ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:43.205204Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6091} {"level":"info","ts":"2026-04-16T23:03:43.336619Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6091,"took":"128.653907ms","hash":3033930901,"current-db-size-bytes":58445824,"current-db-size":"58 MB","current-db-size-in-use-bytes":23355392,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-16T23:03:43.33674Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3033930901,"revision":6091,"compact-revision":2981} {"level":"info","ts":"2026-04-16T23:03:55.384761Z","caller":"traceutil/trace.go:171","msg":"trace[1934778653] transaction","detail":"{read_only:false; response_revision:8380; number_of_response:1; }","duration":"143.716313ms","start":"2026-04-16T23:03:55.241021Z","end":"2026-04-16T23:03:55.384738Z","steps":["trace[1934778653] 'process raft request' (duration: 143.548028ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:03:55.557103Z","caller":"traceutil/trace.go:171","msg":"trace[1034217938] linearizableReadLoop","detail":"{readStateIndex:8681; appliedIndex:8679; }","duration":"236.068278ms","start":"2026-04-16T23:03:55.320969Z","end":"2026-04-16T23:03:55.557038Z","steps":["trace[1034217938] 'read index received' (duration: 63.743797ms)","trace[1034217938] 'applied index is now lower than readState.Index' (duration: 172.322341ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:03:55.557155Z","caller":"traceutil/trace.go:171","msg":"trace[265541889] transaction","detail":"{read_only:false; response_revision:8381; number_of_response:1; }","duration":"314.639584ms","start":"2026-04-16T23:03:55.242478Z","end":"2026-04-16T23:03:55.557118Z","steps":["trace[265541889] 'process raft request' (duration: 300.432802ms)","trace[265541889] 'compare' (duration: 13.801601ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T23:03:55.557383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T23:03:55.242452Z","time spent":"314.783268ms","remote":"127.0.0.1:33440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T23:03:55.557426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.79329ms","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-04-16T23:03:55.557552Z","caller":"traceutil/trace.go:171","msg":"trace[1319915081] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8381; }","duration":"186.973675ms","start":"2026-04-16T23:03:55.370545Z","end":"2026-04-16T23:03:55.557519Z","steps":["trace[1319915081] 'agreement among raft nodes before linearized reading' (duration: 186.749129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:03:55.557581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.50796ms","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-04-16T23:03:55.557752Z","caller":"traceutil/trace.go:171","msg":"trace[561171357] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8381; }","duration":"236.798208ms","start":"2026-04-16T23:03:55.320932Z","end":"2026-04-16T23:03:55.55773Z","steps":["trace[561171357] 'agreement among raft nodes before linearized reading' (duration: 236.319215ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:08.41562Z","caller":"traceutil/trace.go:171","msg":"trace[1013590613] linearizableReadLoop","detail":"{readStateIndex:8798; appliedIndex:8795; }","duration":"259.034781ms","start":"2026-04-16T23:04:08.156556Z","end":"2026-04-16T23:04:08.415591Z","steps":["trace[1013590613] 'read index received' (duration: 348.87µs)","trace[1013590613] 'applied index is now lower than readState.Index' (duration: 258.684961ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:04:08.415881Z","caller":"traceutil/trace.go:171","msg":"trace[738545869] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8492; }","duration":"281.84618ms","start":"2026-04-16T23:04:08.134002Z","end":"2026-04-16T23:04:08.415848Z","steps":["trace[738545869] 'process raft request' (duration: 281.46526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:08.416076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.491894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T23:04:08.416134Z","caller":"traceutil/trace.go:171","msg":"trace[998693335] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8492; }","duration":"259.569236ms","start":"2026-04-16T23:04:08.156549Z","end":"2026-04-16T23:04:08.416118Z","steps":["trace[998693335] 'agreement among raft nodes before linearized reading' (duration: 259.385121ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:08.416187Z","caller":"traceutil/trace.go:171","msg":"trace[1033176789] transaction","detail":"{read_only:false; response_revision:8491; number_of_response:1; }","duration":"282.700373ms","start":"2026-04-16T23:04:08.133471Z","end":"2026-04-16T23:04:08.416172Z","steps":["trace[1033176789] 'process raft request' (duration: 213.767273ms)","trace[1033176789] 'compare' (duration: 68.042136ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T23:04:08.416397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.093778ms","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-04-16T23:04:08.416439Z","caller":"traceutil/trace.go:171","msg":"trace[811573203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8492; }","duration":"228.18362ms","start":"2026-04-16T23:04:08.188246Z","end":"2026-04-16T23:04:08.416429Z","steps":["trace[811573203] 'agreement among raft nodes before linearized reading' (duration: 228.086088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:08.416674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.701502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-4pzdt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-16T23:04:08.416736Z","caller":"traceutil/trace.go:171","msg":"trace[2048619946] range","detail":"{range_begin:/registry/pods/openstack/keepalived-4pzdt; range_end:; response_count:1; response_revision:8492; }","duration":"217.815534ms","start":"2026-04-16T23:04:08.198905Z","end":"2026-04-16T23:04:08.416721Z","steps":["trace[2048619946] 'agreement among raft nodes before linearized reading' (duration: 217.506826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:08.416732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.143262ms","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-04-16T23:04:08.416841Z","caller":"traceutil/trace.go:171","msg":"trace[1749902872] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8492; }","duration":"227.320397ms","start":"2026-04-16T23:04:08.189495Z","end":"2026-04-16T23:04:08.416816Z","steps":["trace[1749902872] 'agreement among raft nodes before linearized reading' (duration: 226.971317ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:09.367148Z","caller":"traceutil/trace.go:171","msg":"trace[1593189271] linearizableReadLoop","detail":"{readStateIndex:8805; appliedIndex:8804; }","duration":"185.659118ms","start":"2026-04-16T23:04:09.181453Z","end":"2026-04-16T23:04:09.367112Z","steps":["trace[1593189271] 'read index received' (duration: 185.279988ms)","trace[1593189271] 'applied index is now lower than readState.Index' (duration: 378.06µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:04:09.367198Z","caller":"traceutil/trace.go:171","msg":"trace[326797088] transaction","detail":"{read_only:false; response_revision:8499; number_of_response:1; }","duration":"251.834013ms","start":"2026-04-16T23:04:09.115325Z","end":"2026-04-16T23:04:09.367159Z","steps":["trace[326797088] 'process raft request' (duration: 251.528774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:09.367518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.113661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-56bc99599f-ljpc5.18a6f8bbf3f3a978\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-04-16T23:04:09.367606Z","caller":"traceutil/trace.go:171","msg":"trace[969514197] range","detail":"{range_begin:/registry/events/openstack/barbican-api-56bc99599f-ljpc5.18a6f8bbf3f3a978; range_end:; response_count:1; response_revision:8499; }","duration":"186.255794ms","start":"2026-04-16T23:04:09.18133Z","end":"2026-04-16T23:04:09.367586Z","steps":["trace[969514197] 'agreement among raft nodes before linearized reading' (duration: 185.980237ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:10.571764Z","caller":"traceutil/trace.go:171","msg":"trace[1702637723] linearizableReadLoop","detail":"{readStateIndex:8816; appliedIndex:8815; }","duration":"100.157672ms","start":"2026-04-16T23:04:10.471568Z","end":"2026-04-16T23:04:10.571725Z","steps":["trace[1702637723] 'read index received' (duration: 99.807082ms)","trace[1702637723] 'applied index is now lower than readState.Index' (duration: 348.1µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T23:04:10.571816Z","caller":"traceutil/trace.go:171","msg":"trace[2015990810] transaction","detail":"{read_only:false; response_revision:8510; number_of_response:1; }","duration":"100.236733ms","start":"2026-04-16T23:04:10.471548Z","end":"2026-04-16T23:04:10.571784Z","steps":["trace[2015990810] 'process raft request' (duration: 99.959276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T23:04:10.572106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.503911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-4pzdt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-16T23:04:10.572163Z","caller":"traceutil/trace.go:171","msg":"trace[1762109287] range","detail":"{range_begin:/registry/pods/openstack/keepalived-4pzdt; range_end:; response_count:1; response_revision:8510; }","duration":"100.634784ms","start":"2026-04-16T23:04:10.471513Z","end":"2026-04-16T23:04:10.572148Z","steps":["trace[1762109287] 'agreement among raft nodes before linearized reading' (duration: 100.393618ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T23:04:57.148798Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000244f.wal"} {"level":"info","ts":"2026-04-16T23:06:15.954404Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-16T23:06:15.959111Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-16T23:06:15.959221Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-16T23:08:43.21282Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8269} {"level":"info","ts":"2026-04-16T23:08:43.296825Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8269,"took":"81.871988ms","hash":966230644,"current-db-size-bytes":58445824,"current-db-size":"58 MB","current-db-size-in-use-bytes":25116672,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-16T23:08:43.296932Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":966230644,"revision":8269,"compact-revision":6091} {"level":"info","ts":"2026-04-16T23:13:43.221865Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10702} {"level":"info","ts":"2026-04-16T23:13:43.299667Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10702,"took":"75.367206ms","hash":1520220500,"current-db-size-bytes":58445824,"current-db-size":"58 MB","current-db-size-in-use-bytes":20246528,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-16T23:13:43.299734Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1520220500,"revision":10702,"compact-revision":8269}