{"level":"warn","ts":"2026-05-26T05:43:02.763256Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T05:43:02.763343Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70: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.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-26T05:43:02.763404Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T05:43:02.763411Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-05-26T05:43:02.76344Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-26T05:43:02.764177Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-05-26T05:43:02.764275Z","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.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-26T05:43:02.769026Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.525113ms"} {"level":"info","ts":"2026-05-26T05:43:02.7861Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-05-26T05:43:02.786178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T05:43:02.786205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-05-26T05:43:02.786218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T05:43:02.786232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-05-26T05:43:02.786273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-05-26T05:43:02.799702Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T05:43:02.801061Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T05:43:02.802276Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-26T05:43:02.804497Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T05:43:02.806318Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T05:43:02.806391Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T05:43:02.8064Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T05:43:02.806396Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T05:43:02.806487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-05-26T05:43:02.807502Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-05-26T05:43:02.814367Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-26T05:43:02.814479Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-05-26T05:43:02.814575Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-05-26T05:43:02.814574Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T05:43:02.814611Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T05:43:03.18719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T05:43:03.187234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T05:43:03.187257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-05-26T05:43:03.187272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-05-26T05:43:03.18728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-05-26T05:43:03.187292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-05-26T05:43:03.18731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-05-26T05:43:03.210779Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:43:03.212257Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:43:03.212339Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:43:03.212701Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T05:43:03.212804Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T05:43:03.215899Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T05:43:03.216338Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-05-26T05:43:03.211967Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T05:43:03.223353Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:43:03.223528Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:43:03.223577Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:43:20.065974Z","caller":"traceutil/trace.go:171","msg":"trace[1505945114] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"241.17618ms","start":"2026-05-26T05:43:19.824774Z","end":"2026-05-26T05:43:20.06595Z","steps":["trace[1505945114] 'process raft request' (duration: 241.025109ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:20.513594Z","caller":"traceutil/trace.go:171","msg":"trace[472143935] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"222.439565ms","start":"2026-05-26T05:43:20.291125Z","end":"2026-05-26T05:43:20.513565Z","steps":["trace[472143935] 'process raft request' (duration: 222.173133ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:53.236376Z","caller":"traceutil/trace.go:171","msg":"trace[821577503] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"129.83142ms","start":"2026-05-26T05:43:53.106517Z","end":"2026-05-26T05:43:53.236349Z","steps":["trace[821577503] 'process raft request' (duration: 129.594652ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:53.278514Z","caller":"traceutil/trace.go:171","msg":"trace[181507429] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"144.617326ms","start":"2026-05-26T05:43:53.133869Z","end":"2026-05-26T05:43:53.278487Z","steps":["trace[181507429] 'process raft request' (duration: 144.558844ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:53.278536Z","caller":"traceutil/trace.go:171","msg":"trace[592423423] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"165.556967ms","start":"2026-05-26T05:43:53.112954Z","end":"2026-05-26T05:43:53.278511Z","steps":["trace[592423423] 'process raft request' (duration: 165.290978ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:55.509393Z","caller":"traceutil/trace.go:171","msg":"trace[728213382] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"132.456564ms","start":"2026-05-26T05:43:55.376889Z","end":"2026-05-26T05:43:55.509346Z","steps":["trace[728213382] 'process raft request' (duration: 132.131711ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:55.694629Z","caller":"traceutil/trace.go:171","msg":"trace[1565551530] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"152.454404ms","start":"2026-05-26T05:43:55.54215Z","end":"2026-05-26T05:43:55.694604Z","steps":["trace[1565551530] 'process raft request' (duration: 151.51923ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:59.559241Z","caller":"traceutil/trace.go:171","msg":"trace[1913054967] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"152.480728ms","start":"2026-05-26T05:43:59.406723Z","end":"2026-05-26T05:43:59.559203Z","steps":["trace[1913054967] 'process raft request' (duration: 152.025993ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:44:00.221704Z","caller":"traceutil/trace.go:171","msg":"trace[598224532] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"471.518277ms","start":"2026-05-26T05:43:59.750163Z","end":"2026-05-26T05:44:00.221681Z","steps":["trace[598224532] 'read index received' (duration: 471.465315ms)","trace[598224532] 'applied index is now lower than readState.Index' (duration: 51.882µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:44:00.221824Z","caller":"traceutil/trace.go:171","msg":"trace[1956217073] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"606.910194ms","start":"2026-05-26T05:43:59.61486Z","end":"2026-05-26T05:44:00.22177Z","steps":["trace[1956217073] 'process raft request' (duration: 606.664165ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:00.221878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.699643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2tbck\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-26T05:44:00.221942Z","caller":"traceutil/trace.go:171","msg":"trace[93649651] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2tbck; range_end:; response_count:1; response_revision:665; }","duration":"471.808277ms","start":"2026-05-26T05:43:59.750123Z","end":"2026-05-26T05:44:00.221932Z","steps":["trace[93649651] 'agreement among raft nodes before linearized reading' (duration: 471.670492ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:00.221978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:43:59.750109Z","time spent":"471.862118ms","remote":"127.0.0.1:60814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-2tbck\" "} {"level":"warn","ts":"2026-05-26T05:44:00.222459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.296899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:44:00.222538Z","caller":"traceutil/trace.go:171","msg":"trace[583299678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:666; }","duration":"454.408163ms","start":"2026-05-26T05:43:59.768108Z","end":"2026-05-26T05:44:00.222517Z","steps":["trace[583299678] 'agreement among raft nodes before linearized reading' (duration: 454.271899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:00.222577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:43:59.768098Z","time spent":"454.471496ms","remote":"127.0.0.1:60628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T05:44:00.222595Z","caller":"traceutil/trace.go:171","msg":"trace[1799651650] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"218.398873ms","start":"2026-05-26T05:44:00.004181Z","end":"2026-05-26T05:44:00.22258Z","steps":["trace[1799651650] 'process raft request' (duration: 218.086813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:00.223506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:43:59.61484Z","time spent":"607.043378ms","remote":"127.0.0.1:60852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:44:16.574973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.78408ms","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-05-26T05:44:16.575086Z","caller":"traceutil/trace.go:171","msg":"trace[959494288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:823; }","duration":"227.949325ms","start":"2026-05-26T05:44:16.347115Z","end":"2026-05-26T05:44:16.575064Z","steps":["trace[959494288] 'range keys from in-memory index tree' (duration: 227.612905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:44:16.576182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.858658ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:44:16.576342Z","caller":"traceutil/trace.go:171","msg":"trace[882917736] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"227.474863ms","start":"2026-05-26T05:44:16.348838Z","end":"2026-05-26T05:44:16.576313Z","steps":["trace[882917736] 'process raft request' (duration: 32.461311ms)","trace[882917736] 'compare' (duration: 193.531419ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:45:12.430601Z","caller":"traceutil/trace.go:171","msg":"trace[793945363] transaction","detail":"{read_only:false; response_revision:1511; number_of_response:1; }","duration":"107.193638ms","start":"2026-05-26T05:45:12.323375Z","end":"2026-05-26T05:45:12.430568Z","steps":["trace[793945363] 'process raft request' (duration: 75.36051ms)","trace[793945363] 'compare' (duration: 30.979142ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:45:27.421131Z","caller":"traceutil/trace.go:171","msg":"trace[1588973917] transaction","detail":"{read_only:false; response_revision:1760; number_of_response:1; }","duration":"265.296442ms","start":"2026-05-26T05:45:27.155812Z","end":"2026-05-26T05:45:27.421109Z","steps":["trace[1588973917] 'process raft request' (duration: 265.132689ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.421487Z","caller":"traceutil/trace.go:171","msg":"trace[1787600542] linearizableReadLoop","detail":"{readStateIndex:1825; appliedIndex:1825; }","duration":"185.416849ms","start":"2026-05-26T05:45:27.236056Z","end":"2026-05-26T05:45:27.421472Z","steps":["trace[1787600542] 'read index received' (duration: 185.408699ms)","trace[1787600542] 'applied index is now lower than readState.Index' (duration: 6.91µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:45:27.421657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.586782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-messaging-topology-operator-7f8596f788-lh9c9\" ","response":"range_response_count:1 size:5781"} {"level":"info","ts":"2026-05-26T05:45:27.421689Z","caller":"traceutil/trace.go:171","msg":"trace[1883511616] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-messaging-topology-operator-7f8596f788-lh9c9; range_end:; response_count:1; response_revision:1760; }","duration":"185.666323ms","start":"2026-05-26T05:45:27.236014Z","end":"2026-05-26T05:45:27.421681Z","steps":["trace[1883511616] 'agreement among raft nodes before linearized reading' (duration: 185.52773ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.518635Z","caller":"traceutil/trace.go:171","msg":"trace[1646687285] transaction","detail":"{read_only:false; response_revision:1761; number_of_response:1; }","duration":"258.232072ms","start":"2026-05-26T05:45:27.260367Z","end":"2026-05-26T05:45:27.5186Z","steps":["trace[1646687285] 'process raft request' (duration: 237.846377ms)","trace[1646687285] 'compare' (duration: 20.122151ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:45:27.51886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.90014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.518948Z","caller":"traceutil/trace.go:171","msg":"trace[1155973513] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:1762; }","duration":"185.032392ms","start":"2026-05-26T05:45:27.333896Z","end":"2026-05-26T05:45:27.518928Z","steps":["trace[1155973513] 'agreement among raft nodes before linearized reading' (duration: 184.849729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.519005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.48358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:45:27.51908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.186826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.519096Z","caller":"traceutil/trace.go:171","msg":"trace[1548546251] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:1762; }","duration":"133.566332ms","start":"2026-05-26T05:45:27.385506Z","end":"2026-05-26T05:45:27.519072Z","steps":["trace[1548546251] 'agreement among raft nodes before linearized reading' (duration: 133.45096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.519203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.340068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.51924Z","caller":"traceutil/trace.go:171","msg":"trace[1230820066] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:1762; }","duration":"149.394838ms","start":"2026-05-26T05:45:27.369837Z","end":"2026-05-26T05:45:27.519231Z","steps":["trace[1230820066] 'agreement among raft nodes before linearized reading' (duration: 149.311917ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.519319Z","caller":"traceutil/trace.go:171","msg":"trace[548164644] transaction","detail":"{read_only:false; response_revision:1762; number_of_response:1; }","duration":"258.607808ms","start":"2026-05-26T05:45:27.260697Z","end":"2026-05-26T05:45:27.519305Z","steps":["trace[548164644] 'process raft request' (duration: 257.836205ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.519321Z","caller":"traceutil/trace.go:171","msg":"trace[801216938] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:1762; }","duration":"185.244866ms","start":"2026-05-26T05:45:27.333866Z","end":"2026-05-26T05:45:27.519111Z","steps":["trace[801216938] 'agreement among raft nodes before linearized reading' (duration: 184.906781ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.51937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.557074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"warn","ts":"2026-05-26T05:45:27.51941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.179738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:45:27.519445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.016143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.519456Z","caller":"traceutil/trace.go:171","msg":"trace[371693536] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1762; }","duration":"236.701877ms","start":"2026-05-26T05:45:27.282734Z","end":"2026-05-26T05:45:27.519436Z","steps":["trace[371693536] 'agreement among raft nodes before linearized reading' (duration: 236.142718ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.519473Z","caller":"traceutil/trace.go:171","msg":"trace[853707958] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:1762; }","duration":"171.32597ms","start":"2026-05-26T05:45:27.348131Z","end":"2026-05-26T05:45:27.519457Z","steps":["trace[853707958] 'agreement among raft nodes before linearized reading' (duration: 171.187108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.519509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.853123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.519551Z","caller":"traceutil/trace.go:171","msg":"trace[507737001] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:1762; }","duration":"121.904864ms","start":"2026-05-26T05:45:27.397636Z","end":"2026-05-26T05:45:27.519541Z","steps":["trace[507737001] 'agreement among raft nodes before linearized reading' (duration: 121.842733ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.519653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.788225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.519694Z","caller":"traceutil/trace.go:171","msg":"trace[221341555] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:1762; }","duration":"133.876277ms","start":"2026-05-26T05:45:27.385809Z","end":"2026-05-26T05:45:27.519685Z","steps":["trace[221341555] 'agreement among raft nodes before linearized reading' (duration: 133.816306ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.519483Z","caller":"traceutil/trace.go:171","msg":"trace[1916736602] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:1762; }","duration":"185.071754ms","start":"2026-05-26T05:45:27.334402Z","end":"2026-05-26T05:45:27.519474Z","steps":["trace[1916736602] 'agreement among raft nodes before linearized reading' (duration: 185.024253ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.519706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.004385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:45:27.519738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.985039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.519764Z","caller":"traceutil/trace.go:171","msg":"trace[701529994] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:1762; }","duration":"171.114497ms","start":"2026-05-26T05:45:27.348634Z","end":"2026-05-26T05:45:27.519749Z","steps":["trace[701529994] 'agreement among raft nodes before linearized reading' (duration: 171.002415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.519852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.232983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-26T05:45:27.519904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.335351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.519907Z","caller":"traceutil/trace.go:171","msg":"trace[332812845] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1762; }","duration":"271.346905ms","start":"2026-05-26T05:45:27.248551Z","end":"2026-05-26T05:45:27.519897Z","steps":["trace[332812845] 'agreement among raft nodes before linearized reading' (duration: 271.235413ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.519929Z","caller":"traceutil/trace.go:171","msg":"trace[545637382] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:1762; }","duration":"122.393102ms","start":"2026-05-26T05:45:27.397528Z","end":"2026-05-26T05:45:27.519921Z","steps":["trace[545637382] 'agreement among raft nodes before linearized reading' (duration: 122.359901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.519769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.006791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-26T05:45:27.519997Z","caller":"traceutil/trace.go:171","msg":"trace[1392421056] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1762; }","duration":"257.252716ms","start":"2026-05-26T05:45:27.262734Z","end":"2026-05-26T05:45:27.519987Z","steps":["trace[1392421056] 'agreement among raft nodes before linearized reading' (duration: 256.949741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.51987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.27729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.519771Z","caller":"traceutil/trace.go:171","msg":"trace[1674716898] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:1762; }","duration":"134.029679ms","start":"2026-05-26T05:45:27.385733Z","end":"2026-05-26T05:45:27.519763Z","steps":["trace[1674716898] 'agreement among raft nodes before linearized reading' (duration: 133.981438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.520124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.828793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.520159Z","caller":"traceutil/trace.go:171","msg":"trace[1801687343] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:1762; }","duration":"150.878734ms","start":"2026-05-26T05:45:27.369271Z","end":"2026-05-26T05:45:27.52015Z","steps":["trace[1801687343] 'agreement among raft nodes before linearized reading' (duration: 150.825663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.520232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.749579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:45:27.519666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.271987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-26T05:45:27.520287Z","caller":"traceutil/trace.go:171","msg":"trace[1399411649] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1762; }","duration":"203.80624ms","start":"2026-05-26T05:45:27.316468Z","end":"2026-05-26T05:45:27.520275Z","steps":["trace[1399411649] 'agreement among raft nodes before linearized reading' (duration: 203.728368ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.520306Z","caller":"traceutil/trace.go:171","msg":"trace[188946994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1762; }","duration":"250.958918ms","start":"2026-05-26T05:45:27.269337Z","end":"2026-05-26T05:45:27.520296Z","steps":["trace[188946994] 'agreement among raft nodes before linearized reading' (duration: 250.219796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.520333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.280821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:45:27.520389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.072046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:45:27.520462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.423854ms","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":"warn","ts":"2026-05-26T05:45:27.519409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.33851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.520502Z","caller":"traceutil/trace.go:171","msg":"trace[1716961820] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1762; }","duration":"203.495464ms","start":"2026-05-26T05:45:27.316997Z","end":"2026-05-26T05:45:27.520493Z","steps":["trace[1716961820] 'agreement among raft nodes before linearized reading' (duration: 203.437683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.520515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.751128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.520521Z","caller":"traceutil/trace.go:171","msg":"trace[601607857] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:1762; }","duration":"172.473651ms","start":"2026-05-26T05:45:27.348037Z","end":"2026-05-26T05:45:27.520511Z","steps":["trace[601607857] 'agreement among raft nodes before linearized reading' (duration: 171.342741ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.520546Z","caller":"traceutil/trace.go:171","msg":"trace[1777922235] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1762; }","duration":"236.81009ms","start":"2026-05-26T05:45:27.283727Z","end":"2026-05-26T05:45:27.520537Z","steps":["trace[1777922235] 'agreement among raft nodes before linearized reading' (duration: 236.762418ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.520072Z","caller":"traceutil/trace.go:171","msg":"trace[1756726934] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:1762; }","duration":"122.478853ms","start":"2026-05-26T05:45:27.397584Z","end":"2026-05-26T05:45:27.520063Z","steps":["trace[1756726934] 'agreement among raft nodes before linearized reading' (duration: 122.25729ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.520465Z","caller":"traceutil/trace.go:171","msg":"trace[59292420] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1762; }","duration":"236.163328ms","start":"2026-05-26T05:45:27.284289Z","end":"2026-05-26T05:45:27.520452Z","steps":["trace[59292420] 'agreement among raft nodes before linearized reading' (duration: 236.052176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.520616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.676199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.52036Z","caller":"traceutil/trace.go:171","msg":"trace[20961828] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1762; }","duration":"236.323071ms","start":"2026-05-26T05:45:27.28403Z","end":"2026-05-26T05:45:27.520353Z","steps":["trace[20961828] 'agreement among raft nodes before linearized reading' (duration: 236.27401ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.520698Z","caller":"traceutil/trace.go:171","msg":"trace[800868990] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1762; }","duration":"203.76818ms","start":"2026-05-26T05:45:27.316912Z","end":"2026-05-26T05:45:27.52068Z","steps":["trace[800868990] 'agreement among raft nodes before linearized reading' (duration: 203.670879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.520836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.442316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:45:27.520836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.873043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.52087Z","caller":"traceutil/trace.go:171","msg":"trace[1746502491] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:1762; }","duration":"219.497027ms","start":"2026-05-26T05:45:27.301365Z","end":"2026-05-26T05:45:27.520862Z","steps":["trace[1746502491] 'agreement among raft nodes before linearized reading' (duration: 219.446056ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:27.520877Z","caller":"traceutil/trace.go:171","msg":"trace[1946896193] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:1762; }","duration":"219.945075ms","start":"2026-05-26T05:45:27.300922Z","end":"2026-05-26T05:45:27.520867Z","steps":["trace[1946896193] 'agreement among raft nodes before linearized reading' (duration: 219.886324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.521009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.074507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.521043Z","caller":"traceutil/trace.go:171","msg":"trace[960734889] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:1762; }","duration":"220.134777ms","start":"2026-05-26T05:45:27.300901Z","end":"2026-05-26T05:45:27.521036Z","steps":["trace[960734889] 'agreement among raft nodes before linearized reading' (duration: 220.085917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.51891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.42871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.522132Z","caller":"traceutil/trace.go:171","msg":"trace[454049828] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1762; }","duration":"237.656034ms","start":"2026-05-26T05:45:27.284441Z","end":"2026-05-26T05:45:27.522097Z","steps":["trace[454049828] 'agreement among raft nodes before linearized reading' (duration: 234.404589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:27.525947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.717273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:27.526012Z","caller":"traceutil/trace.go:171","msg":"trace[217785882] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:1763; }","duration":"156.853736ms","start":"2026-05-26T05:45:27.369144Z","end":"2026-05-26T05:45:27.525998Z","steps":["trace[217785882] 'agreement among raft nodes before linearized reading' (duration: 156.710253ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:36.8208Z","caller":"traceutil/trace.go:171","msg":"trace[1509028617] linearizableReadLoop","detail":"{readStateIndex:1981; appliedIndex:1980; }","duration":"271.048744ms","start":"2026-05-26T05:45:36.549733Z","end":"2026-05-26T05:45:36.820781Z","steps":["trace[1509028617] 'read index received' (duration: 270.901362ms)","trace[1509028617] 'applied index is now lower than readState.Index' (duration: 146.502µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:45:36.820912Z","caller":"traceutil/trace.go:171","msg":"trace[1460368690] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"308.079674ms","start":"2026-05-26T05:45:36.512823Z","end":"2026-05-26T05:45:36.820903Z","steps":["trace[1460368690] 'process raft request' (duration: 307.79986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:36.820997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:45:36.512805Z","time spent":"308.127305ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:45:36.821179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.457001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-26T05:45:36.821202Z","caller":"traceutil/trace.go:171","msg":"trace[358789144] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1914; }","duration":"271.520323ms","start":"2026-05-26T05:45:36.549676Z","end":"2026-05-26T05:45:36.821196Z","steps":["trace[358789144] 'agreement among raft nodes before linearized reading' (duration: 271.430531ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:51.207263Z","caller":"traceutil/trace.go:171","msg":"trace[1714181737] linearizableReadLoop","detail":"{readStateIndex:2101; appliedIndex:2100; }","duration":"197.652592ms","start":"2026-05-26T05:45:51.009587Z","end":"2026-05-26T05:45:51.20724Z","steps":["trace[1714181737] 'read index received' (duration: 197.380678ms)","trace[1714181737] 'applied index is now lower than readState.Index' (duration: 270.744µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:45:51.207498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.898116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-26T05:45:51.20754Z","caller":"traceutil/trace.go:171","msg":"trace[1562654656] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2030; }","duration":"197.986707ms","start":"2026-05-26T05:45:51.009542Z","end":"2026-05-26T05:45:51.207528Z","steps":["trace[1562654656] 'agreement among raft nodes before linearized reading' (duration: 197.793394ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:51.207893Z","caller":"traceutil/trace.go:171","msg":"trace[1029794774] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"204.904641ms","start":"2026-05-26T05:45:51.002978Z","end":"2026-05-26T05:45:51.207882Z","steps":["trace[1029794774] 'process raft request' (duration: 204.072079ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:46:25.507823Z","caller":"traceutil/trace.go:171","msg":"trace[1149134242] transaction","detail":"{read_only:false; response_revision:2228; number_of_response:1; }","duration":"123.487409ms","start":"2026-05-26T05:46:25.384304Z","end":"2026-05-26T05:46:25.507792Z","steps":["trace[1149134242] 'process raft request' (duration: 123.274986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:46:25.994611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.73035ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:46:25.99474Z","caller":"traceutil/trace.go:171","msg":"trace[1815564577] linearizableReadLoop","detail":"{readStateIndex:2309; appliedIndex:2307; }","duration":"225.983115ms","start":"2026-05-26T05:46:25.768745Z","end":"2026-05-26T05:46:25.994728Z","steps":["trace[1815564577] 'read index received' (duration: 209.254869ms)","trace[1815564577] 'applied index is now lower than readState.Index' (duration: 16.727546ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:46:25.994938Z","caller":"traceutil/trace.go:171","msg":"trace[283694864] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"347.512008ms","start":"2026-05-26T05:46:25.647412Z","end":"2026-05-26T05:46:25.994925Z","steps":["trace[283694864] 'process raft request' (duration: 93.406273ms)","trace[283694864] 'compare' (duration: 253.657199ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:46:25.995008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:46:25.647389Z","time spent":"347.585448ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:46:25.995194Z","caller":"traceutil/trace.go:171","msg":"trace[69213157] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"257.278658ms","start":"2026-05-26T05:46:25.737891Z","end":"2026-05-26T05:46:25.99517Z","steps":["trace[69213157] 'process raft request' (duration: 256.804662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:46:25.995229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.505951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:46:25.995259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.577523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-05-26T05:46:25.995282Z","caller":"traceutil/trace.go:171","msg":"trace[1388597292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2230; }","duration":"226.607713ms","start":"2026-05-26T05:46:25.768659Z","end":"2026-05-26T05:46:25.995267Z","steps":["trace[1388597292] 'agreement among raft nodes before linearized reading' (duration: 226.510722ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:46:25.995307Z","caller":"traceutil/trace.go:171","msg":"trace[590714250] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2230; }","duration":"178.648175ms","start":"2026-05-26T05:46:25.816644Z","end":"2026-05-26T05:46:25.995293Z","steps":["trace[590714250] 'agreement among raft nodes before linearized reading' (duration: 178.491862ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:46:25.995356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.443956ms","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-05-26T05:46:25.995393Z","caller":"traceutil/trace.go:171","msg":"trace[1104958701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2230; }","duration":"182.481687ms","start":"2026-05-26T05:46:25.812902Z","end":"2026-05-26T05:46:25.995384Z","steps":["trace[1104958701] 'agreement among raft nodes before linearized reading' (duration: 182.393446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:46:25.995528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.031134ms","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-05-26T05:46:25.995562Z","caller":"traceutil/trace.go:171","msg":"trace[1686113874] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2230; }","duration":"183.084254ms","start":"2026-05-26T05:46:25.812469Z","end":"2026-05-26T05:46:25.995554Z","steps":["trace[1686113874] 'agreement among raft nodes before linearized reading' (duration: 182.996913ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:46:25.995548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.894405ms","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-05-26T05:46:25.996031Z","caller":"traceutil/trace.go:171","msg":"trace[1012006503] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2230; }","duration":"187.406904ms","start":"2026-05-26T05:46:25.808584Z","end":"2026-05-26T05:46:25.995991Z","steps":["trace[1012006503] 'agreement among raft nodes before linearized reading' (duration: 186.529831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:56.876812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.40393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:48:56.877191Z","caller":"traceutil/trace.go:171","msg":"trace[593685090] transaction","detail":"{read_only:false; response_revision:3144; number_of_response:1; }","duration":"356.59091ms","start":"2026-05-26T05:48:56.520571Z","end":"2026-05-26T05:48:56.877162Z","steps":["trace[593685090] 'compare' (duration: 354.842387ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:56.87736Z","caller":"traceutil/trace.go:171","msg":"trace[1732615524] linearizableReadLoop","detail":"{readStateIndex:3258; appliedIndex:3255; }","duration":"232.426094ms","start":"2026-05-26T05:48:56.644918Z","end":"2026-05-26T05:48:56.877344Z","steps":["trace[1732615524] 'read index received' (duration: 43.541µs)","trace[1732615524] 'applied index is now lower than readState.Index' (duration: 232.381523ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:48:56.877426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:56.52055Z","time spent":"356.697952ms","remote":"127.0.0.1:60866","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-05-26T05:48:56.877433Z","caller":"traceutil/trace.go:171","msg":"trace[1478583637] transaction","detail":"{read_only:false; response_revision:3146; number_of_response:1; }","duration":"351.176266ms","start":"2026-05-26T05:48:56.526218Z","end":"2026-05-26T05:48:56.877394Z","steps":["trace[1478583637] 'process raft request' (duration: 350.946009ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:48:56.877552Z","caller":"traceutil/trace.go:171","msg":"trace[350871960] transaction","detail":"{read_only:false; response_revision:3145; number_of_response:1; }","duration":"353.981786ms","start":"2026-05-26T05:48:56.523512Z","end":"2026-05-26T05:48:56.877494Z","steps":["trace[350871960] 'process raft request' (duration: 353.419071ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:56.87763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.710231ms","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-05-26T05:48:56.877692Z","caller":"traceutil/trace.go:171","msg":"trace[2024896624] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3146; }","duration":"232.804624ms","start":"2026-05-26T05:48:56.644875Z","end":"2026-05-26T05:48:56.877679Z","steps":["trace[2024896624] 'agreement among raft nodes before linearized reading' (duration: 232.623159ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:56.877722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.250578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"warn","ts":"2026-05-26T05:48:56.877869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:56.523484Z","time spent":"354.188891ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:48:56.877832Z","caller":"traceutil/trace.go:171","msg":"trace[1576678609] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3146; }","duration":"155.429702ms","start":"2026-05-26T05:48:56.722384Z","end":"2026-05-26T05:48:56.877814Z","steps":["trace[1576678609] 'agreement among raft nodes before linearized reading' (duration: 155.144065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:48:56.877871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:48:56.526193Z","time spent":"351.455593ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:48:56.877992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.055695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:48:56.878097Z","caller":"traceutil/trace.go:171","msg":"trace[2057883358] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3146; }","duration":"110.184978ms","start":"2026-05-26T05:48:56.767887Z","end":"2026-05-26T05:48:56.878071Z","steps":["trace[2057883358] 'agreement among raft nodes before linearized reading' (duration: 110.005594ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:48.42978Z","caller":"traceutil/trace.go:171","msg":"trace[589865230] transaction","detail":"{read_only:false; response_revision:3505; number_of_response:1; }","duration":"300.139915ms","start":"2026-05-26T05:49:48.129613Z","end":"2026-05-26T05:49:48.429752Z","steps":["trace[589865230] 'process raft request' (duration: 299.971892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.429962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.12959Z","time spent":"300.284939ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:51:21.531442Z","caller":"traceutil/trace.go:171","msg":"trace[605652441] transaction","detail":"{read_only:false; response_revision:4581; number_of_response:1; }","duration":"101.900343ms","start":"2026-05-26T05:51:21.429508Z","end":"2026-05-26T05:51:21.531408Z","steps":["trace[605652441] 'process raft request' (duration: 101.789461ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:21.531541Z","caller":"traceutil/trace.go:171","msg":"trace[991423206] linearizableReadLoop","detail":"{readStateIndex:4748; appliedIndex:4743; }","duration":"100.184723ms","start":"2026-05-26T05:51:21.431332Z","end":"2026-05-26T05:51:21.531517Z","steps":["trace[991423206] 'read index received' (duration: 18.570349ms)","trace[991423206] 'applied index is now lower than readState.Index' (duration: 81.613084ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:21.531639Z","caller":"traceutil/trace.go:171","msg":"trace[1340432856] transaction","detail":"{read_only:false; response_revision:4585; number_of_response:1; }","duration":"100.006691ms","start":"2026-05-26T05:51:21.431594Z","end":"2026-05-26T05:51:21.531601Z","steps":["trace[1340432856] 'process raft request' (duration: 99.830227ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:21.531842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.490379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-05-26T05:51:21.532252Z","caller":"traceutil/trace.go:171","msg":"trace[5202586] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4586; }","duration":"100.924225ms","start":"2026-05-26T05:51:21.431311Z","end":"2026-05-26T05:51:21.532235Z","steps":["trace[5202586] 'agreement among raft nodes before linearized reading' (duration: 100.352296ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:21.531406Z","caller":"traceutil/trace.go:171","msg":"trace[1478415577] transaction","detail":"{read_only:false; response_revision:4580; number_of_response:1; }","duration":"102.556603ms","start":"2026-05-26T05:51:21.428824Z","end":"2026-05-26T05:51:21.531381Z","steps":["trace[1478415577] 'process raft request' (duration: 90.303143ms)","trace[1478415577] 'compare' (duration: 12.033886ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:21.532235Z","caller":"traceutil/trace.go:171","msg":"trace[178301041] transaction","detail":"{read_only:false; response_revision:4582; number_of_response:1; }","duration":"100.079921ms","start":"2026-05-26T05:51:21.431418Z","end":"2026-05-26T05:51:21.531498Z","steps":["trace[178301041] 'process raft request' (duration: 99.919458ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:21.768381Z","caller":"traceutil/trace.go:171","msg":"trace[1105214535] transaction","detail":"{read_only:false; response_revision:4588; number_of_response:1; }","duration":"230.671347ms","start":"2026-05-26T05:51:21.537687Z","end":"2026-05-26T05:51:21.768359Z","steps":["trace[1105214535] 'process raft request' (duration: 230.496824ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:21.776484Z","caller":"traceutil/trace.go:171","msg":"trace[697072468] linearizableReadLoop","detail":"{readStateIndex:4756; appliedIndex:4754; }","duration":"232.53882ms","start":"2026-05-26T05:51:21.543926Z","end":"2026-05-26T05:51:21.776465Z","steps":["trace[697072468] 'read index received' (duration: 224.330199ms)","trace[697072468] 'applied index is now lower than readState.Index' (duration: 8.207421ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:21.776588Z","caller":"traceutil/trace.go:171","msg":"trace[602681493] transaction","detail":"{read_only:false; response_revision:4589; number_of_response:1; }","duration":"237.390194ms","start":"2026-05-26T05:51:21.539189Z","end":"2026-05-26T05:51:21.77658Z","steps":["trace[602681493] 'process raft request' (duration: 236.995197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:21.776933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.987337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-26T05:51:21.776985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.434317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-05-26T05:51:21.777046Z","caller":"traceutil/trace.go:171","msg":"trace[1954744503] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4590; }","duration":"232.526339ms","start":"2026-05-26T05:51:21.54451Z","end":"2026-05-26T05:51:21.777036Z","steps":["trace[1954744503] 'agreement among raft nodes before linearized reading' (duration: 232.323786ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:21.777034Z","caller":"traceutil/trace.go:171","msg":"trace[509981956] transaction","detail":"{read_only:false; response_revision:4590; number_of_response:1; }","duration":"227.34371ms","start":"2026-05-26T05:51:21.549666Z","end":"2026-05-26T05:51:21.777009Z","steps":["trace[509981956] 'process raft request' (duration: 226.720139ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:21.777022Z","caller":"traceutil/trace.go:171","msg":"trace[756912035] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4590; }","duration":"233.106929ms","start":"2026-05-26T05:51:21.543899Z","end":"2026-05-26T05:51:21.777006Z","steps":["trace[756912035] 'agreement among raft nodes before linearized reading' (duration: 232.876505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:21.777299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.553565ms","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-05-26T05:51:21.777328Z","caller":"traceutil/trace.go:171","msg":"trace[1248568999] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4590; }","duration":"205.641346ms","start":"2026-05-26T05:51:21.571679Z","end":"2026-05-26T05:51:21.77732Z","steps":["trace[1248568999] 'agreement among raft nodes before linearized reading' (duration: 205.528054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:21.777031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.801411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:51:21.777383Z","caller":"traceutil/trace.go:171","msg":"trace[1169538091] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:4590; }","duration":"184.168847ms","start":"2026-05-26T05:51:21.5932Z","end":"2026-05-26T05:51:21.777368Z","steps":["trace[1169538091] 'agreement among raft nodes before linearized reading' (duration: 183.75953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:21.777589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.013819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T05:51:21.778345Z","caller":"traceutil/trace.go:171","msg":"trace[2085486537] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4590; }","duration":"211.813183ms","start":"2026-05-26T05:51:21.566519Z","end":"2026-05-26T05:51:21.778333Z","steps":["trace[2085486537] 'agreement among raft nodes before linearized reading' (duration: 210.975048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:21.778158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.082177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206966"} {"level":"info","ts":"2026-05-26T05:51:21.778486Z","caller":"traceutil/trace.go:171","msg":"trace[611532830] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4590; }","duration":"216.423943ms","start":"2026-05-26T05:51:21.562052Z","end":"2026-05-26T05:51:21.778476Z","steps":["trace[611532830] 'agreement among raft nodes before linearized reading' (duration: 215.304193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:21.778248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.313758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-26T05:51:21.778655Z","caller":"traceutil/trace.go:171","msg":"trace[2020438783] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4590; }","duration":"225.421538ms","start":"2026-05-26T05:51:21.553222Z","end":"2026-05-26T05:51:21.778644Z","steps":["trace[2020438783] 'agreement among raft nodes before linearized reading' (duration: 224.259377ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:23.390574Z","caller":"traceutil/trace.go:171","msg":"trace[1534217261] transaction","detail":"{read_only:false; response_revision:4608; number_of_response:1; }","duration":"606.91989ms","start":"2026-05-26T05:51:22.783641Z","end":"2026-05-26T05:51:23.390561Z","steps":["trace[1534217261] 'process raft request' (duration: 606.847209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:23.390666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:22.783629Z","time spent":"606.989332ms","remote":"127.0.0.1:60878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1853,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:51:23.393785Z","caller":"traceutil/trace.go:171","msg":"trace[189559579] linearizableReadLoop","detail":"{readStateIndex:4779; appliedIndex:4777; }","duration":"494.883555ms","start":"2026-05-26T05:51:22.898878Z","end":"2026-05-26T05:51:23.393761Z","steps":["trace[189559579] 'read index received' (duration: 492.021206ms)","trace[189559579] 'applied index is now lower than readState.Index' (duration: 2.861689ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:23.394077Z","caller":"traceutil/trace.go:171","msg":"trace[1969768258] transaction","detail":"{read_only:false; response_revision:4609; number_of_response:1; }","duration":"609.750608ms","start":"2026-05-26T05:51:22.784314Z","end":"2026-05-26T05:51:23.394065Z","steps":["trace[1969768258] 'process raft request' (duration: 608.352485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:23.394194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:22.784296Z","time spent":"609.826119ms","remote":"127.0.0.1:60792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1249,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:51:23.394496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.610939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-26T05:51:23.394567Z","caller":"traceutil/trace.go:171","msg":"trace[398155715] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4611; }","duration":"495.72158ms","start":"2026-05-26T05:51:22.898829Z","end":"2026-05-26T05:51:23.394551Z","steps":["trace[398155715] 'agreement among raft nodes before linearized reading' (duration: 495.528726ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:23.394603Z","caller":"traceutil/trace.go:171","msg":"trace[139501580] transaction","detail":"{read_only:false; response_revision:4610; number_of_response:1; }","duration":"609.436364ms","start":"2026-05-26T05:51:22.785146Z","end":"2026-05-26T05:51:23.394583Z","steps":["trace[139501580] 'process raft request' (duration: 608.488067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:23.394671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.275729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:51:23.394677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:22.785127Z","time spent":"609.514895ms","remote":"127.0.0.1:32844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4883,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:51:23.394711Z","caller":"traceutil/trace.go:171","msg":"trace[651638013] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:4611; }","duration":"240.340881ms","start":"2026-05-26T05:51:23.154359Z","end":"2026-05-26T05:51:23.3947Z","steps":["trace[651638013] 'agreement among raft nodes before linearized reading' (duration: 240.28239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:23.394609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:22.898815Z","time spent":"495.785402ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T05:51:23.395008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.957242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-57966dc0-5378-446c-8de7-0b203e293db8\" ","response":"range_response_count:1 size:4079"} {"level":"info","ts":"2026-05-26T05:51:23.395058Z","caller":"traceutil/trace.go:171","msg":"trace[1912834852] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-57966dc0-5378-446c-8de7-0b203e293db8; range_end:; response_count:1; response_revision:4611; }","duration":"139.034694ms","start":"2026-05-26T05:51:23.256004Z","end":"2026-05-26T05:51:23.395038Z","steps":["trace[1912834852] 'agreement among raft nodes before linearized reading' (duration: 138.947082ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:29.369343Z","caller":"traceutil/trace.go:171","msg":"trace[2106308212] transaction","detail":"{read_only:false; response_revision:4687; number_of_response:1; }","duration":"341.656561ms","start":"2026-05-26T05:51:29.027666Z","end":"2026-05-26T05:51:29.369323Z","steps":["trace[2106308212] 'process raft request' (duration: 341.511809ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:29.369461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:29.027644Z","time spent":"341.755172ms","remote":"127.0.0.1:45074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2724,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:51:29.395257Z","caller":"traceutil/trace.go:171","msg":"trace[150156102] linearizableReadLoop","detail":"{readStateIndex:4859; appliedIndex:4857; }","duration":"272.138902ms","start":"2026-05-26T05:51:29.123089Z","end":"2026-05-26T05:51:29.395228Z","steps":["trace[150156102] 'read index received' (duration: 246.141879ms)","trace[150156102] 'applied index is now lower than readState.Index' (duration: 25.995853ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:29.395274Z","caller":"traceutil/trace.go:171","msg":"trace[1759955985] transaction","detail":"{read_only:false; response_revision:4688; number_of_response:1; }","duration":"282.146791ms","start":"2026-05-26T05:51:29.113106Z","end":"2026-05-26T05:51:29.395253Z","steps":["trace[1759955985] 'process raft request' (duration: 281.957298ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:29.395432Z","caller":"traceutil/trace.go:171","msg":"trace[2139147157] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"166.257144ms","start":"2026-05-26T05:51:29.229045Z","end":"2026-05-26T05:51:29.395303Z","steps":["trace[2139147157] 'process raft request' (duration: 166.134932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:29.420327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.215707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:51:29.420487Z","caller":"traceutil/trace.go:171","msg":"trace[921385246] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:4689; }","duration":"297.422931ms","start":"2026-05-26T05:51:29.12304Z","end":"2026-05-26T05:51:29.420463Z","steps":["trace[921385246] 'agreement among raft nodes before linearized reading' (duration: 272.276164ms)","trace[921385246] 'count revisions from in-memory index tree' (duration: 24.949604ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:29.843188Z","caller":"traceutil/trace.go:171","msg":"trace[646323303] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"235.724095ms","start":"2026-05-26T05:51:29.607437Z","end":"2026-05-26T05:51:29.843161Z","steps":["trace[646323303] 'process raft request' (duration: 235.441879ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:29.843363Z","caller":"traceutil/trace.go:171","msg":"trace[1385033831] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"233.235052ms","start":"2026-05-26T05:51:29.610069Z","end":"2026-05-26T05:51:29.843304Z","steps":["trace[1385033831] 'process raft request' (duration: 233.010998ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:29.84354Z","caller":"traceutil/trace.go:171","msg":"trace[1510091106] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"232.326316ms","start":"2026-05-26T05:51:29.611189Z","end":"2026-05-26T05:51:29.843515Z","steps":["trace[1510091106] 'process raft request' (duration: 231.942768ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:29.843735Z","caller":"traceutil/trace.go:171","msg":"trace[2008534726] transaction","detail":"{read_only:false; response_revision:4711; number_of_response:1; }","duration":"232.023511ms","start":"2026-05-26T05:51:29.611698Z","end":"2026-05-26T05:51:29.843721Z","steps":["trace[2008534726] 'process raft request' (duration: 231.696256ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:29.843903Z","caller":"traceutil/trace.go:171","msg":"trace[1444182006] transaction","detail":"{read_only:false; response_revision:4712; number_of_response:1; }","duration":"231.876079ms","start":"2026-05-26T05:51:29.612002Z","end":"2026-05-26T05:51:29.843878Z","steps":["trace[1444182006] 'process raft request' (duration: 231.468642ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:30.128381Z","caller":"traceutil/trace.go:171","msg":"trace[972458329] linearizableReadLoop","detail":"{readStateIndex:4898; appliedIndex:4896; }","duration":"124.455451ms","start":"2026-05-26T05:51:30.00391Z","end":"2026-05-26T05:51:30.128365Z","steps":["trace[972458329] 'read index received' (duration: 112.03133ms)","trace[972458329] 'applied index is now lower than readState.Index' (duration: 12.423581ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:51:30.128536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.610603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-05-26T05:51:30.128562Z","caller":"traceutil/trace.go:171","msg":"trace[2110258113] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4727; }","duration":"124.688755ms","start":"2026-05-26T05:51:30.003865Z","end":"2026-05-26T05:51:30.128554Z","steps":["trace[2110258113] 'agreement among raft nodes before linearized reading' (duration: 124.566823ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:30.128514Z","caller":"traceutil/trace.go:171","msg":"trace[31339637] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"157.062414ms","start":"2026-05-26T05:51:29.971418Z","end":"2026-05-26T05:51:30.12848Z","steps":["trace[31339637] 'process raft request' (duration: 144.507092ms)","trace[31339637] 'compare' (duration: 12.286358ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:30.128602Z","caller":"traceutil/trace.go:171","msg":"trace[2145246432] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"125.331596ms","start":"2026-05-26T05:51:30.003213Z","end":"2026-05-26T05:51:30.128544Z","steps":["trace[2145246432] 'process raft request' (duration: 125.120722ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:03.239274Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2865} {"level":"info","ts":"2026-05-26T05:53:03.320766Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2865,"took":"79.926375ms","hash":2225501064,"current-db-size-bytes":52846592,"current-db-size":"53 MB","current-db-size-in-use-bytes":29138944,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-26T05:53:03.320834Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2225501064,"revision":2865,"compact-revision":-1} {"level":"info","ts":"2026-05-26T05:54:34.323114Z","caller":"traceutil/trace.go:171","msg":"trace[702099828] transaction","detail":"{read_only:false; response_revision:6081; number_of_response:1; }","duration":"193.25102ms","start":"2026-05-26T05:54:34.12984Z","end":"2026-05-26T05:54:34.323091Z","steps":["trace[702099828] 'process raft request' (duration: 193.132579ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:54:34.323687Z","caller":"traceutil/trace.go:171","msg":"trace[2035244567] linearizableReadLoop","detail":"{readStateIndex:6296; appliedIndex:6296; }","duration":"179.605484ms","start":"2026-05-26T05:54:34.14407Z","end":"2026-05-26T05:54:34.323676Z","steps":["trace[2035244567] 'read index received' (duration: 179.601554ms)","trace[2035244567] 'applied index is now lower than readState.Index' (duration: 3.27µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:54:34.323789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.693116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:54:34.323896Z","caller":"traceutil/trace.go:171","msg":"trace[303472961] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:6081; }","duration":"179.846607ms","start":"2026-05-26T05:54:34.144037Z","end":"2026-05-26T05:54:34.323883Z","steps":["trace[303472961] 'agreement among raft nodes before linearized reading' (duration: 179.700775ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:54:34.324165Z","caller":"traceutil/trace.go:171","msg":"trace[263074991] transaction","detail":"{read_only:false; response_revision:6082; number_of_response:1; }","duration":"116.360274ms","start":"2026-05-26T05:54:34.207794Z","end":"2026-05-26T05:54:34.324154Z","steps":["trace[263074991] 'process raft request' (duration: 116.154241ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:54:34.324248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.077101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:54:34.324335Z","caller":"traceutil/trace.go:171","msg":"trace[298624977] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6084; }","duration":"146.216682ms","start":"2026-05-26T05:54:34.1781Z","end":"2026-05-26T05:54:34.324317Z","steps":["trace[298624977] 'agreement among raft nodes before linearized reading' (duration: 146.05944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:57:46.173439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.145691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cert-manager-cainjector\" ","response":"range_response_count:1 size:1368"} {"level":"info","ts":"2026-05-26T05:57:46.173529Z","caller":"traceutil/trace.go:171","msg":"trace[741277689] range","detail":"{range_begin:/registry/clusterroles/cert-manager-cainjector; range_end:; response_count:1; response_revision:7320; }","duration":"957.273636ms","start":"2026-05-26T05:57:45.216234Z","end":"2026-05-26T05:57:46.173508Z","steps":["trace[741277689] 'range keys from in-memory index tree' (duration: 956.989206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:57:46.173568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:57:45.216216Z","time spent":"957.342927ms","remote":"127.0.0.1:60946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":1391,"request content":"key:\"/registry/clusterroles/cert-manager-cainjector\" "} {"level":"warn","ts":"2026-05-26T05:57:46.173624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.024202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:57:46.173732Z","caller":"traceutil/trace.go:171","msg":"trace[779394051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7320; }","duration":"405.177027ms","start":"2026-05-26T05:57:45.768537Z","end":"2026-05-26T05:57:46.173714Z","steps":["trace[779394051] 'range keys from in-memory index tree' (duration: 404.9556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:57:46.173777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:57:45.768522Z","time spent":"405.245259ms","remote":"127.0.0.1:60634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T05:57:46.173795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.2577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cert-manager-controller-approve:cert-manager-io\" ","response":"range_response_count:1 size:1134"} {"level":"info","ts":"2026-05-26T05:57:46.173831Z","caller":"traceutil/trace.go:171","msg":"trace[1444023337] range","detail":"{range_begin:/registry/clusterroles/cert-manager-controller-approve:cert-manager-io; range_end:; response_count:1; response_revision:7320; }","duration":"952.322072ms","start":"2026-05-26T05:57:45.221495Z","end":"2026-05-26T05:57:46.173817Z","steps":["trace[1444023337] 'range keys from in-memory index tree' (duration: 952.155306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:57:46.173872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:57:45.221478Z","time spent":"952.384483ms","remote":"127.0.0.1:60946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":1157,"request content":"key:\"/registry/clusterroles/cert-manager-controller-approve:cert-manager-io\" "} {"level":"warn","ts":"2026-05-26T05:57:46.174142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.158104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T05:57:46.174182Z","caller":"traceutil/trace.go:171","msg":"trace[717658499] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7320; }","duration":"819.227757ms","start":"2026-05-26T05:57:45.354945Z","end":"2026-05-26T05:57:46.174173Z","steps":["trace[717658499] 'range keys from in-memory index tree' (duration: 819.02151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:57:46.174192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.072468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-26T05:57:46.17421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:57:45.354929Z","time spent":"819.273188ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-26T05:57:46.174235Z","caller":"traceutil/trace.go:171","msg":"trace[445230074] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7320; }","duration":"380.164281ms","start":"2026-05-26T05:57:45.794061Z","end":"2026-05-26T05:57:46.174225Z","steps":["trace[445230074] 'range keys from in-memory index tree' (duration: 379.928953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:57:46.174264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:57:45.79404Z","time spent":"380.217122ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T05:57:46.174398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.526934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T05:57:46.174431Z","caller":"traceutil/trace.go:171","msg":"trace[1165478650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7320; }","duration":"377.558355ms","start":"2026-05-26T05:57:45.796864Z","end":"2026-05-26T05:57:46.174422Z","steps":["trace[1165478650] 'range keys from in-memory index tree' (duration: 377.382559ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:57:46.174456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:57:45.796763Z","time spent":"377.68675ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T05:57:46.174585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.797362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T05:57:46.174435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.27043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-26T05:57:46.174694Z","caller":"traceutil/trace.go:171","msg":"trace[1068730513] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7320; }","duration":"791.937517ms","start":"2026-05-26T05:57:45.382732Z","end":"2026-05-26T05:57:46.17467Z","steps":["trace[1068730513] 'count revisions from in-memory index tree' (duration: 791.726408ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:57:46.174739Z","caller":"traceutil/trace.go:171","msg":"trace[1640944819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7320; }","duration":"660.838598ms","start":"2026-05-26T05:57:45.513884Z","end":"2026-05-26T05:57:46.174722Z","steps":["trace[1640944819] 'range keys from in-memory index tree' (duration: 660.139135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:57:46.174754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:57:45.382721Z","time spent":"792.016659ms","remote":"127.0.0.1:47686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-26T05:57:46.17485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:57:45.513869Z","time spent":"660.884029ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T05:57:46.1751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.204256ms","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":"warn","ts":"2026-05-26T05:57:46.175102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.784527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:57:46.175158Z","caller":"traceutil/trace.go:171","msg":"trace[1092638989] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7320; }","duration":"378.262118ms","start":"2026-05-26T05:57:45.796881Z","end":"2026-05-26T05:57:46.175143Z","steps":["trace[1092638989] 'range keys from in-memory index tree' (duration: 377.997519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:57:46.175189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:57:45.796814Z","time spent":"378.367481ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-05-26T05:57:46.175198Z","caller":"traceutil/trace.go:171","msg":"trace[498882763] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:7320; }","duration":"760.90484ms","start":"2026-05-26T05:57:45.414247Z","end":"2026-05-26T05:57:46.175152Z","steps":["trace[498882763] 'count revisions from in-memory index tree' (duration: 760.672044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:57:46.175243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:57:45.414225Z","time spent":"761.004994ms","remote":"127.0.0.1:60720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":81,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-05-26T05:57:46.175585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.113487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-26T05:57:46.175712Z","caller":"traceutil/trace.go:171","msg":"trace[609340419] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7320; }","duration":"711.269742ms","start":"2026-05-26T05:57:45.464427Z","end":"2026-05-26T05:57:46.175696Z","steps":["trace[609340419] 'range keys from in-memory index tree' (duration: 710.945161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:57:46.175769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:57:45.464419Z","time spent":"711.340145ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T05:57:58.466368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.381989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:replicaset-controller\" ","response":"range_response_count:1 size:759"} {"level":"info","ts":"2026-05-26T05:57:58.466455Z","caller":"traceutil/trace.go:171","msg":"trace[720650058] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:replicaset-controller; range_end:; response_count:1; response_revision:7389; }","duration":"117.509643ms","start":"2026-05-26T05:57:58.348926Z","end":"2026-05-26T05:57:58.466436Z","steps":["trace[720650058] 'range keys from in-memory index tree' (duration: 117.276166ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:58:03.244463Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5561} {"level":"info","ts":"2026-05-26T05:58:03.318181Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5561,"took":"72.487712ms","hash":1260881202,"current-db-size-bytes":52846592,"current-db-size":"53 MB","current-db-size-in-use-bytes":18251776,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-26T05:58:03.318231Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1260881202,"revision":5561,"compact-revision":2865}