{"level":"warn","ts":"2026-05-29T11:22:55.684252Z","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-29T11:22:55.684865Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.14: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.19.213.14:2380","--initial-cluster=instance=https://199.19.213.14:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.14:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.14: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-29T11:22:55.685071Z","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-29T11:22:55.685089Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.14:2380"]} {"level":"info","ts":"2026-05-29T11:22:55.685156Z","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-29T11:22:55.686014Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"]} {"level":"info","ts":"2026-05-29T11:22:55.686096Z","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.19.213.14:2380"],"listen-peer-urls":["https://199.19.213.14:2380"],"advertise-client-urls":["https://199.19.213.14:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.14: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-29T11:22:55.690879Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.522169ms"} {"level":"info","ts":"2026-05-29T11:22:55.701515Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"329f95029c2a91ed","cluster-id":"5fd85759a04d0f9f"} {"level":"info","ts":"2026-05-29T11:22:55.701609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=()"} {"level":"info","ts":"2026-05-29T11:22:55.701632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became follower at term 0"} {"level":"info","ts":"2026-05-29T11:22:55.701641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 329f95029c2a91ed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-29T11:22:55.70165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became follower at term 1"} {"level":"info","ts":"2026-05-29T11:22:55.70168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=(3647798061635899885)"} {"level":"warn","ts":"2026-05-29T11:22:55.713456Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-29T11:22:55.71495Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-29T11:22:55.716547Z","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-29T11:22:55.719931Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"329f95029c2a91ed","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-29T11:22:55.720091Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"329f95029c2a91ed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-29T11:22:55.720235Z","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-29T11:22:55.720366Z","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-29T11:22:55.720386Z","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-29T11:22:55.72152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=(3647798061635899885)"} {"level":"info","ts":"2026-05-29T11:22:55.725902Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5fd85759a04d0f9f","local-member-id":"329f95029c2a91ed","added-peer-id":"329f95029c2a91ed","added-peer-peer-urls":["https://199.19.213.14:2380"]} {"level":"info","ts":"2026-05-29T11:22:55.72727Z","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-29T11:22:55.727552Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"329f95029c2a91ed","initial-advertise-peer-urls":["https://199.19.213.14:2380"],"listen-peer-urls":["https://199.19.213.14:2380"],"advertise-client-urls":["https://199.19.213.14:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-29T11:22:55.727542Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.14:2380"} {"level":"info","ts":"2026-05-29T11:22:55.727588Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-29T11:22:55.727616Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.14:2380"} {"level":"info","ts":"2026-05-29T11:22:56.304049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed is starting a new election at term 1"} {"level":"info","ts":"2026-05-29T11:22:56.30411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became pre-candidate at term 1"} {"level":"info","ts":"2026-05-29T11:22:56.304152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed received MsgPreVoteResp from 329f95029c2a91ed at term 1"} {"level":"info","ts":"2026-05-29T11:22:56.304171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became candidate at term 2"} {"level":"info","ts":"2026-05-29T11:22:56.304182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed received MsgVoteResp from 329f95029c2a91ed at term 2"} {"level":"info","ts":"2026-05-29T11:22:56.304198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became leader at term 2"} {"level":"info","ts":"2026-05-29T11:22:56.304211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 329f95029c2a91ed elected leader 329f95029c2a91ed at term 2"} {"level":"info","ts":"2026-05-29T11:22:56.305342Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"329f95029c2a91ed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.14:2379]}","request-path":"/0/members/329f95029c2a91ed/attributes","cluster-id":"5fd85759a04d0f9f","publish-timeout":"7s"} {"level":"info","ts":"2026-05-29T11:22:56.305525Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T11:22:56.305621Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T11:22:56.30583Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T11:22:56.306887Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5fd85759a04d0f9f","local-member-id":"329f95029c2a91ed","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T11:22:56.307026Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T11:22:56.307064Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T11:22:56.30919Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-29T11:22:56.309243Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.14:2379"} {"level":"info","ts":"2026-05-29T11:22:56.321644Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-29T11:22:56.32174Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-05-29T11:23:46.069599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.106408ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T11:23:46.06976Z","caller":"traceutil/trace.go:171","msg":"trace[633211013] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:648; }","duration":"118.280894ms","start":"2026-05-29T11:23:45.951459Z","end":"2026-05-29T11:23:46.06974Z","steps":["trace[633211013] 'range keys from in-memory index tree' (duration: 118.072348ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:23:46.069933Z","caller":"traceutil/trace.go:171","msg":"trace[505127922] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"139.820659ms","start":"2026-05-29T11:23:45.930057Z","end":"2026-05-29T11:23:46.069877Z","steps":["trace[505127922] 'process raft request' (duration: 77.883406ms)","trace[505127922] 'compare' (duration: 61.629795ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:23:46.291561Z","caller":"traceutil/trace.go:171","msg":"trace[2144512047] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"144.889554ms","start":"2026-05-29T11:23:46.14579Z","end":"2026-05-29T11:23:46.290679Z","steps":["trace[2144512047] 'process raft request' (duration: 77.665513ms)","trace[2144512047] 'compare' (duration: 67.099458ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:23:46.789269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.446691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T11:23:46.78937Z","caller":"traceutil/trace.go:171","msg":"trace[1675236102] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"428.823418ms","start":"2026-05-29T11:23:46.360528Z","end":"2026-05-29T11:23:46.789351Z","steps":["trace[1675236102] 'process raft request' (duration: 303.519544ms)","trace[1675236102] 'compare' (duration: 124.320778ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:23:46.789439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:23:46.360516Z","time spent":"428.892669ms","remote":"127.0.0.1:57250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T11:23:46.807495Z","caller":"traceutil/trace.go:171","msg":"trace[1506198079] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:674; }","duration":"254.285453ms","start":"2026-05-29T11:23:46.553179Z","end":"2026-05-29T11:23:46.807465Z","steps":["trace[1506198079] 'read index received' (duration: 111.466414ms)","trace[1506198079] 'applied index is now lower than readState.Index' (duration: 142.817589ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:23:46.807639Z","caller":"traceutil/trace.go:171","msg":"trace[393477060] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"289.840268ms","start":"2026-05-29T11:23:46.517723Z","end":"2026-05-29T11:23:46.807563Z","steps":["trace[393477060] 'process raft request' (duration: 289.212582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:23:46.807713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.514789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T11:23:46.807763Z","caller":"traceutil/trace.go:171","msg":"trace[303547510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"254.639381ms","start":"2026-05-29T11:23:46.553107Z","end":"2026-05-29T11:23:46.807746Z","steps":["trace[303547510] 'agreement among raft nodes before linearized reading' (duration: 254.531779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:23:46.807825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.789042ms","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-29T11:23:46.807888Z","caller":"traceutil/trace.go:171","msg":"trace[1944368433] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:652; }","duration":"164.887535ms","start":"2026-05-29T11:23:46.642984Z","end":"2026-05-29T11:23:46.807871Z","steps":["trace[1944368433] 'agreement among raft nodes before linearized reading' (duration: 164.69985ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:24:33.318205Z","caller":"traceutil/trace.go:171","msg":"trace[513662142] linearizableReadLoop","detail":"{readStateIndex:1260; appliedIndex:1258; }","duration":"168.603139ms","start":"2026-05-29T11:24:33.149566Z","end":"2026-05-29T11:24:33.318169Z","steps":["trace[513662142] 'read index received' (duration: 48.199033ms)","trace[513662142] 'applied index is now lower than readState.Index' (duration: 120.402726ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:24:33.318446Z","caller":"traceutil/trace.go:171","msg":"trace[924543629] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"171.409751ms","start":"2026-05-29T11:24:33.146982Z","end":"2026-05-29T11:24:33.318392Z","steps":["trace[924543629] 'process raft request' (duration: 143.201274ms)","trace[924543629] 'compare' (duration: 27.827431ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:24:33.318544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.946295ms","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-29T11:24:33.318644Z","caller":"traceutil/trace.go:171","msg":"trace[2136683781] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1222; }","duration":"169.109359ms","start":"2026-05-29T11:24:33.149518Z","end":"2026-05-29T11:24:33.318628Z","steps":["trace[2136683781] 'agreement among raft nodes before linearized reading' (duration: 168.842444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:24:33.318818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.143786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-29T11:24:33.318978Z","caller":"traceutil/trace.go:171","msg":"trace[883792437] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1222; }","duration":"141.434662ms","start":"2026-05-29T11:24:33.177523Z","end":"2026-05-29T11:24:33.318958Z","steps":["trace[883792437] 'agreement among raft nodes before linearized reading' (duration: 140.974963ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:24:57.199061Z","caller":"traceutil/trace.go:171","msg":"trace[1623831046] linearizableReadLoop","detail":"{readStateIndex:1532; appliedIndex:1531; }","duration":"107.902189ms","start":"2026-05-29T11:24:57.091117Z","end":"2026-05-29T11:24:57.199019Z","steps":["trace[1623831046] 'read index received' (duration: 107.600084ms)","trace[1623831046] 'applied index is now lower than readState.Index' (duration: 300.945µs)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:24:57.199307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.145383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T11:24:57.199359Z","caller":"traceutil/trace.go:171","msg":"trace[829504013] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1485; }","duration":"108.230804ms","start":"2026-05-29T11:24:57.091111Z","end":"2026-05-29T11:24:57.199342Z","steps":["trace[829504013] 'agreement among raft nodes before linearized reading' (duration: 108.081181ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:24:57.19992Z","caller":"traceutil/trace.go:171","msg":"trace[1086515475] transaction","detail":"{read_only:false; response_revision:1485; number_of_response:1; }","duration":"127.924301ms","start":"2026-05-29T11:24:57.071973Z","end":"2026-05-29T11:24:57.199897Z","steps":["trace[1086515475] 'process raft request' (duration: 126.846604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:25:24.070983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.516668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-29T11:25:24.071236Z","caller":"traceutil/trace.go:171","msg":"trace[837476327] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1906; }","duration":"197.826422ms","start":"2026-05-29T11:25:23.873373Z","end":"2026-05-29T11:25:24.0712Z","steps":["trace[837476327] 'range keys from in-memory index tree' (duration: 197.288305ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:25:24.276199Z","caller":"traceutil/trace.go:171","msg":"trace[1485208053] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"100.079504ms","start":"2026-05-29T11:25:24.176067Z","end":"2026-05-29T11:25:24.276146Z","steps":["trace[1485208053] 'process raft request' (duration: 99.933732ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:25:24.505663Z","caller":"traceutil/trace.go:171","msg":"trace[2085531227] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"308.92697ms","start":"2026-05-29T11:25:24.196694Z","end":"2026-05-29T11:25:24.505621Z","steps":["trace[2085531227] 'process raft request' (duration: 263.057528ms)","trace[2085531227] 'compare' (duration: 45.69578ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:25:24.506033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:25:24.196672Z","time spent":"309.099882ms","remote":"127.0.0.1:57250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T11:25:24.506562Z","caller":"traceutil/trace.go:171","msg":"trace[1951776798] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"161.029595ms","start":"2026-05-29T11:25:24.345503Z","end":"2026-05-29T11:25:24.506533Z","steps":["trace[1951776798] 'process raft request' (duration: 160.801902ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:25:24.50689Z","caller":"traceutil/trace.go:171","msg":"trace[2045742037] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"142.917393ms","start":"2026-05-29T11:25:24.363934Z","end":"2026-05-29T11:25:24.506852Z","steps":["trace[2045742037] 'process raft request' (duration: 142.491768ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:25:33.864542Z","caller":"traceutil/trace.go:171","msg":"trace[42917512] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"116.183879ms","start":"2026-05-29T11:25:33.748328Z","end":"2026-05-29T11:25:33.864512Z","steps":["trace[42917512] 'process raft request' (duration: 116.026986ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:25:41.318593Z","caller":"traceutil/trace.go:171","msg":"trace[1044347802] linearizableReadLoop","detail":"{readStateIndex:2122; appliedIndex:2121; }","duration":"120.779254ms","start":"2026-05-29T11:25:41.197784Z","end":"2026-05-29T11:25:41.318563Z","steps":["trace[1044347802] 'read index received' (duration: 120.531661ms)","trace[1044347802] 'applied index is now lower than readState.Index' (duration: 246.503µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:25:41.318713Z","caller":"traceutil/trace.go:171","msg":"trace[1924305180] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"133.841694ms","start":"2026-05-29T11:25:41.184838Z","end":"2026-05-29T11:25:41.31868Z","steps":["trace[1924305180] 'process raft request' (duration: 133.55019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:25:41.318891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.593204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-29T11:25:41.31898Z","caller":"traceutil/trace.go:171","msg":"trace[686759649] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2043; }","duration":"118.708626ms","start":"2026-05-29T11:25:41.200235Z","end":"2026-05-29T11:25:41.318944Z","steps":["trace[686759649] 'agreement among raft nodes before linearized reading' (duration: 118.479092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:25:41.319653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.809518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-29T11:25:41.319738Z","caller":"traceutil/trace.go:171","msg":"trace[148122488] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:2043; }","duration":"121.989321ms","start":"2026-05-29T11:25:41.19773Z","end":"2026-05-29T11:25:41.319719Z","steps":["trace[148122488] 'agreement among raft nodes before linearized reading' (duration: 121.825379ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:25:41.625838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.896766ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T11:25:41.625994Z","caller":"traceutil/trace.go:171","msg":"trace[905886450] linearizableReadLoop","detail":"{readStateIndex:2123; appliedIndex:2122; }","duration":"250.874047ms","start":"2026-05-29T11:25:41.375097Z","end":"2026-05-29T11:25:41.625971Z","steps":["trace[905886450] 'read index received' (duration: 94.633087ms)","trace[905886450] 'applied index is now lower than readState.Index' (duration: 156.23929ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:25:41.626056Z","caller":"traceutil/trace.go:171","msg":"trace[1475809581] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"294.892499ms","start":"2026-05-29T11:25:41.331132Z","end":"2026-05-29T11:25:41.626025Z","steps":["trace[1475809581] 'process raft request' (duration: 138.626278ms)","trace[1475809581] 'compare' (duration: 155.725214ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:25:41.626236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.142011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11981"} {"level":"info","ts":"2026-05-29T11:25:41.626284Z","caller":"traceutil/trace.go:171","msg":"trace[1793315451] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2044; }","duration":"251.228831ms","start":"2026-05-29T11:25:41.375041Z","end":"2026-05-29T11:25:41.626269Z","steps":["trace[1793315451] 'agreement among raft nodes before linearized reading' (duration: 251.053229ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:25:44.836206Z","caller":"traceutil/trace.go:171","msg":"trace[924703397] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"249.6053ms","start":"2026-05-29T11:25:44.586577Z","end":"2026-05-29T11:25:44.836182Z","steps":["trace[924703397] 'process raft request' (duration: 249.418698ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:25:44.838932Z","caller":"traceutil/trace.go:171","msg":"trace[440086634] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"245.999902ms","start":"2026-05-29T11:25:44.592905Z","end":"2026-05-29T11:25:44.838905Z","steps":["trace[440086634] 'process raft request' (duration: 245.961362ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:25:44.839026Z","caller":"traceutil/trace.go:171","msg":"trace[1961375827] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"246.090724ms","start":"2026-05-29T11:25:44.592897Z","end":"2026-05-29T11:25:44.838988Z","steps":["trace[1961375827] 'process raft request' (duration: 245.84955ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:26:08.384979Z","caller":"traceutil/trace.go:171","msg":"trace[401469598] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"111.624626ms","start":"2026-05-29T11:26:08.273311Z","end":"2026-05-29T11:26:08.384935Z","steps":["trace[401469598] 'process raft request' (duration: 111.416904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:26:08.670157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.529028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-29T11:26:08.670268Z","caller":"traceutil/trace.go:171","msg":"trace[178966932] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2194; }","duration":"154.70887ms","start":"2026-05-29T11:26:08.515534Z","end":"2026-05-29T11:26:08.670243Z","steps":["trace[178966932] 'range keys from in-memory index tree' (duration: 154.093593ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:26:09.092844Z","caller":"traceutil/trace.go:171","msg":"trace[471677489] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"144.573608ms","start":"2026-05-29T11:26:08.94823Z","end":"2026-05-29T11:26:09.092804Z","steps":["trace[471677489] 'process raft request' (duration: 141.539729ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:26:09.096532Z","caller":"traceutil/trace.go:171","msg":"trace[2101297782] linearizableReadLoop","detail":"{readStateIndex:2281; appliedIndex:2279; }","duration":"103.710222ms","start":"2026-05-29T11:26:08.992799Z","end":"2026-05-29T11:26:09.096509Z","steps":["trace[2101297782] 'read index received' (duration: 97.140017ms)","trace[2101297782] 'applied index is now lower than readState.Index' (duration: 6.568825ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:26:09.096819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.999775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-29T11:26:09.096898Z","caller":"traceutil/trace.go:171","msg":"trace[580766996] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2197; }","duration":"104.200508ms","start":"2026-05-29T11:26:08.992682Z","end":"2026-05-29T11:26:09.096882Z","steps":["trace[580766996] 'agreement among raft nodes before linearized reading' (duration: 103.966605ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:26:09.09685Z","caller":"traceutil/trace.go:171","msg":"trace[1823814393] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"145.216606ms","start":"2026-05-29T11:26:08.951573Z","end":"2026-05-29T11:26:09.09679Z","steps":["trace[1823814393] 'process raft request' (duration: 144.852872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:26:09.097091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.473252ms","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-29T11:26:09.097216Z","caller":"traceutil/trace.go:171","msg":"trace[1499592061] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2197; }","duration":"101.699905ms","start":"2026-05-29T11:26:08.995491Z","end":"2026-05-29T11:26:09.097191Z","steps":["trace[1499592061] 'agreement among raft nodes before linearized reading' (duration: 101.348651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:27:27.379259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.861978ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T11:27:27.379391Z","caller":"traceutil/trace.go:171","msg":"trace[317734901] transaction","detail":"{read_only:false; response_revision:2657; number_of_response:1; }","duration":"155.229502ms","start":"2026-05-29T11:27:27.224147Z","end":"2026-05-29T11:27:27.379376Z","steps":["trace[317734901] 'process raft request' (duration: 41.182259ms)","trace[317734901] 'compare' (duration: 113.776766ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:28:08.676025Z","caller":"traceutil/trace.go:171","msg":"trace[223028479] linearizableReadLoop","detail":"{readStateIndex:3052; appliedIndex:3051; }","duration":"121.671746ms","start":"2026-05-29T11:28:08.554316Z","end":"2026-05-29T11:28:08.675988Z","steps":["trace[223028479] 'read index received' (duration: 84.432604ms)","trace[223028479] 'applied index is now lower than readState.Index' (duration: 37.237062ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:28:08.676234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.899292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T11:28:08.676272Z","caller":"traceutil/trace.go:171","msg":"trace[287300146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2941; }","duration":"122.013304ms","start":"2026-05-29T11:28:08.554247Z","end":"2026-05-29T11:28:08.676261Z","steps":["trace[287300146] 'agreement among raft nodes before linearized reading' (duration: 121.882101ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:08.677098Z","caller":"traceutil/trace.go:171","msg":"trace[759264636] transaction","detail":"{read_only:false; response_revision:2941; number_of_response:1; }","duration":"152.558853ms","start":"2026-05-29T11:28:08.523927Z","end":"2026-05-29T11:28:08.676485Z","steps":["trace[759264636] 'process raft request' (duration: 114.845281ms)","trace[759264636] 'compare' (duration: 36.942737ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:28:27.956251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.702336ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T11:28:27.956422Z","caller":"traceutil/trace.go:171","msg":"trace[796312033] linearizableReadLoop","detail":"{readStateIndex:3158; appliedIndex:3157; }","duration":"106.622166ms","start":"2026-05-29T11:28:27.849782Z","end":"2026-05-29T11:28:27.956404Z","steps":["trace[796312033] 'read index received' (duration: 34.991µs)","trace[796312033] 'applied index is now lower than readState.Index' (duration: 106.586185ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:28:27.956441Z","caller":"traceutil/trace.go:171","msg":"trace[230281518] transaction","detail":"{read_only:false; response_revision:3042; number_of_response:1; }","duration":"141.835765ms","start":"2026-05-29T11:28:27.81455Z","end":"2026-05-29T11:28:27.956386Z","steps":["trace[230281518] 'process raft request' (duration: 23.908375ms)","trace[230281518] 'compare' (duration: 117.532162ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:28:27.957423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.631444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T11:28:27.957484Z","caller":"traceutil/trace.go:171","msg":"trace[1914232351] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3042; }","duration":"107.697026ms","start":"2026-05-29T11:28:27.849774Z","end":"2026-05-29T11:28:27.957471Z","steps":["trace[1914232351] 'agreement among raft nodes before linearized reading' (duration: 106.731658ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:28.104002Z","caller":"traceutil/trace.go:171","msg":"trace[33403336] linearizableReadLoop","detail":"{readStateIndex:3161; appliedIndex:3160; }","duration":"114.956209ms","start":"2026-05-29T11:28:27.989025Z","end":"2026-05-29T11:28:28.103982Z","steps":["trace[33403336] 'read index received' (duration: 79.11117ms)","trace[33403336] 'applied index is now lower than readState.Index' (duration: 35.844319ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:28:28.104229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.187953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9281"} {"level":"info","ts":"2026-05-29T11:28:28.104283Z","caller":"traceutil/trace.go:171","msg":"trace[1425551937] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:3045; }","duration":"115.315526ms","start":"2026-05-29T11:28:27.988956Z","end":"2026-05-29T11:28:28.104271Z","steps":["trace[1425551937] 'agreement among raft nodes before linearized reading' (duration: 115.172544ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:28.104213Z","caller":"traceutil/trace.go:171","msg":"trace[1716184159] transaction","detail":"{read_only:false; response_revision:3045; number_of_response:1; }","duration":"138.776651ms","start":"2026-05-29T11:28:27.965386Z","end":"2026-05-29T11:28:28.104163Z","steps":["trace[1716184159] 'process raft request' (duration: 102.868841ms)","trace[1716184159] 'compare' (duration: 35.620415ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:32:17.270548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.611543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9573"} {"level":"info","ts":"2026-05-29T11:32:17.270697Z","caller":"traceutil/trace.go:171","msg":"trace[1032886190] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5018; }","duration":"112.783375ms","start":"2026-05-29T11:32:17.157895Z","end":"2026-05-29T11:32:17.270679Z","steps":["trace[1032886190] 'range keys from in-memory index tree' (duration: 112.552692ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:17.27099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.878127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-205b070f-e8cc-4fd0-8da5-0556e552b3cd\" ","response":"range_response_count:1 size:2580"} {"level":"info","ts":"2026-05-29T11:32:17.271064Z","caller":"traceutil/trace.go:171","msg":"trace[1381279619] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-205b070f-e8cc-4fd0-8da5-0556e552b3cd; range_end:; response_count:1; response_revision:5018; }","duration":"122.978168ms","start":"2026-05-29T11:32:17.148071Z","end":"2026-05-29T11:32:17.271049Z","steps":["trace[1381279619] 'range keys from in-memory index tree' (duration: 122.815616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:17.271231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.428686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-205b070f-e8cc-4fd0-8da5-0556e552b3cd\" ","response":"range_response_count:1 size:2580"} {"level":"info","ts":"2026-05-29T11:32:17.271308Z","caller":"traceutil/trace.go:171","msg":"trace[1608229305] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-205b070f-e8cc-4fd0-8da5-0556e552b3cd; range_end:; response_count:1; response_revision:5018; }","duration":"116.546977ms","start":"2026-05-29T11:32:17.154743Z","end":"2026-05-29T11:32:17.27129Z","steps":["trace[1608229305] 'range keys from in-memory index tree' (duration: 116.355165ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:17.27145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.877599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61060"} {"level":"warn","ts":"2026-05-29T11:32:17.271489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.997047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3223"} {"level":"info","ts":"2026-05-29T11:32:17.271526Z","caller":"traceutil/trace.go:171","msg":"trace[1240350207] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5018; }","duration":"120.089967ms","start":"2026-05-29T11:32:17.151426Z","end":"2026-05-29T11:32:17.271516Z","steps":["trace[1240350207] 'range keys from in-memory index tree' (duration: 119.908976ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:17.271539Z","caller":"traceutil/trace.go:171","msg":"trace[1114841450] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:5018; }","duration":"113.969531ms","start":"2026-05-29T11:32:17.157534Z","end":"2026-05-29T11:32:17.271504Z","steps":["trace[1114841450] 'range keys from in-memory index tree' (duration: 113.610327ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:17.490468Z","caller":"traceutil/trace.go:171","msg":"trace[1873712178] transaction","detail":"{read_only:false; response_revision:5019; number_of_response:1; }","duration":"214.725017ms","start":"2026-05-29T11:32:17.275717Z","end":"2026-05-29T11:32:17.490442Z","steps":["trace[1873712178] 'process raft request' (duration: 214.585005ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:17.592486Z","caller":"traceutil/trace.go:171","msg":"trace[627147086] linearizableReadLoop","detail":"{readStateIndex:5211; appliedIndex:5207; }","duration":"310.316782ms","start":"2026-05-29T11:32:17.282149Z","end":"2026-05-29T11:32:17.592466Z","steps":["trace[627147086] 'read index received' (duration: 208.271507ms)","trace[627147086] 'applied index is now lower than readState.Index' (duration: 102.044385ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:32:17.592709Z","caller":"traceutil/trace.go:171","msg":"trace[2036922970] transaction","detail":"{read_only:false; response_revision:5021; number_of_response:1; }","duration":"313.157741ms","start":"2026-05-29T11:32:17.279347Z","end":"2026-05-29T11:32:17.592504Z","steps":["trace[2036922970] 'process raft request' (duration: 312.959798ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:17.592774Z","caller":"traceutil/trace.go:171","msg":"trace[179655384] transaction","detail":"{read_only:false; response_revision:5022; number_of_response:1; }","duration":"311.059502ms","start":"2026-05-29T11:32:17.281703Z","end":"2026-05-29T11:32:17.592762Z","steps":["trace[179655384] 'process raft request' (duration: 310.658936ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:17.592984Z","caller":"traceutil/trace.go:171","msg":"trace[1724626642] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"296.946764ms","start":"2026-05-29T11:32:17.296027Z","end":"2026-05-29T11:32:17.592974Z","steps":["trace[1724626642] 'process raft request' (duration: 296.385096ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:17.592769Z","caller":"traceutil/trace.go:171","msg":"trace[1241175641] transaction","detail":"{read_only:false; response_revision:5020; number_of_response:1; }","duration":"315.125659ms","start":"2026-05-29T11:32:17.277597Z","end":"2026-05-29T11:32:17.592723Z","steps":["trace[1241175641] 'process raft request' (duration: 314.588882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:17.593145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:32:17.279328Z","time spent":"313.537106ms","remote":"127.0.0.1:57172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3630,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T11:32:17.593241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:32:17.277584Z","time spent":"315.510144ms","remote":"127.0.0.1:57250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T11:32:17.59316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:32:17.281687Z","time spent":"311.339895ms","remote":"127.0.0.1:48156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3228,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T11:32:17.593695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.541348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4848"} {"level":"info","ts":"2026-05-29T11:32:17.593741Z","caller":"traceutil/trace.go:171","msg":"trace[139270277] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5023; }","duration":"311.611549ms","start":"2026-05-29T11:32:17.282119Z","end":"2026-05-29T11:32:17.59373Z","steps":["trace[139270277] 'agreement among raft nodes before linearized reading' (duration: 310.827588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:17.593767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:32:17.282111Z","time spent":"311.649209ms","remote":"127.0.0.1:36550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":4870,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" "} {"level":"info","ts":"2026-05-29T11:32:17.599052Z","caller":"traceutil/trace.go:171","msg":"trace[1448217119] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"105.3318ms","start":"2026-05-29T11:32:17.493696Z","end":"2026-05-29T11:32:17.599028Z","steps":["trace[1448217119] 'process raft request' (duration: 105.200528ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:17.599556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.115331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-05-29T11:32:17.599597Z","caller":"traceutil/trace.go:171","msg":"trace[1362641502] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5024; }","duration":"185.227503ms","start":"2026-05-29T11:32:17.414355Z","end":"2026-05-29T11:32:17.599582Z","steps":["trace[1362641502] 'agreement among raft nodes before linearized reading' (duration: 185.083841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:17.599802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.816663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-05-29T11:32:17.599828Z","caller":"traceutil/trace.go:171","msg":"trace[1614273941] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:5024; }","duration":"267.867984ms","start":"2026-05-29T11:32:17.331952Z","end":"2026-05-29T11:32:17.59982Z","steps":["trace[1614273941] 'agreement among raft nodes before linearized reading' (duration: 267.784983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:17.599997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.197625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-29T11:32:17.600027Z","caller":"traceutil/trace.go:171","msg":"trace[895051467] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5024; }","duration":"284.225685ms","start":"2026-05-29T11:32:17.31579Z","end":"2026-05-29T11:32:17.600016Z","steps":["trace[895051467] 'agreement among raft nodes before linearized reading' (duration: 284.148294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:17.600206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.339602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-05-29T11:32:17.600236Z","caller":"traceutil/trace.go:171","msg":"trace[1693886566] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5024; }","duration":"300.397742ms","start":"2026-05-29T11:32:17.29983Z","end":"2026-05-29T11:32:17.600227Z","steps":["trace[1693886566] 'agreement among raft nodes before linearized reading' (duration: 300.316271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:17.600263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:32:17.299814Z","time spent":"300.441993ms","remote":"127.0.0.1:57078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1843,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-05-29T11:32:18.00031Z","caller":"traceutil/trace.go:171","msg":"trace[1184044223] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"255.219847ms","start":"2026-05-29T11:32:17.74508Z","end":"2026-05-29T11:32:18.0003Z","steps":["trace[1184044223] 'process raft request' (duration: 254.927543ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:18.000262Z","caller":"traceutil/trace.go:171","msg":"trace[95516901] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"267.468918ms","start":"2026-05-29T11:32:17.732729Z","end":"2026-05-29T11:32:18.000198Z","steps":["trace[95516901] 'process raft request' (duration: 262.998676ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:18.000245Z","caller":"traceutil/trace.go:171","msg":"trace[78974203] linearizableReadLoop","detail":"{readStateIndex:5222; appliedIndex:5220; }","duration":"267.441948ms","start":"2026-05-29T11:32:17.732787Z","end":"2026-05-29T11:32:18.000229Z","steps":["trace[78974203] 'read index received' (duration: 41.099448ms)","trace[78974203] 'applied index is now lower than readState.Index' (duration: 226.34168ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:32:18.000648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.831574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-05-29T11:32:18.000939Z","caller":"traceutil/trace.go:171","msg":"trace[828920059] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5034; }","duration":"268.171989ms","start":"2026-05-29T11:32:17.732747Z","end":"2026-05-29T11:32:18.000919Z","steps":["trace[828920059] 'agreement among raft nodes before linearized reading' (duration: 267.642041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:18.001217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.290172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-05-29T11:32:18.001286Z","caller":"traceutil/trace.go:171","msg":"trace[8051778] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5034; }","duration":"266.374193ms","start":"2026-05-29T11:32:17.734895Z","end":"2026-05-29T11:32:18.001269Z","steps":["trace[8051778] 'agreement among raft nodes before linearized reading' (duration: 266.217581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:18.00141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.015054ms","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-29T11:32:18.001457Z","caller":"traceutil/trace.go:171","msg":"trace[1969694149] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5034; }","duration":"176.092534ms","start":"2026-05-29T11:32:17.82535Z","end":"2026-05-29T11:32:18.001443Z","steps":["trace[1969694149] 'agreement among raft nodes before linearized reading' (duration: 175.953263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:18.002124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.805117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-05-29T11:32:18.002167Z","caller":"traceutil/trace.go:171","msg":"trace[1411718983] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5034; }","duration":"243.881577ms","start":"2026-05-29T11:32:17.758273Z","end":"2026-05-29T11:32:18.002155Z","steps":["trace[1411718983] 'agreement among raft nodes before linearized reading' (duration: 243.306779ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:18.195476Z","caller":"traceutil/trace.go:171","msg":"trace[1418280742] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"154.137844ms","start":"2026-05-29T11:32:18.041314Z","end":"2026-05-29T11:32:18.195452Z","steps":["trace[1418280742] 'process raft request' (duration: 70.073024ms)","trace[1418280742] 'compare' (duration: 83.685585ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:32:18.195639Z","caller":"traceutil/trace.go:171","msg":"trace[1572202640] linearizableReadLoop","detail":"{readStateIndex:5225; appliedIndex:5224; }","duration":"152.809296ms","start":"2026-05-29T11:32:18.04282Z","end":"2026-05-29T11:32:18.19563Z","steps":["trace[1572202640] 'read index received' (duration: 68.645374ms)","trace[1572202640] 'applied index is now lower than readState.Index' (duration: 84.162902ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:32:18.195878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.069409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-05-29T11:32:18.195903Z","caller":"traceutil/trace.go:171","msg":"trace[1824932405] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:5037; }","duration":"153.14011ms","start":"2026-05-29T11:32:18.042755Z","end":"2026-05-29T11:32:18.195895Z","steps":["trace[1824932405] 'agreement among raft nodes before linearized reading' (duration: 152.986838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:18.196005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.61711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"warn","ts":"2026-05-29T11:32:18.19602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.778465ms","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-29T11:32:18.19606Z","caller":"traceutil/trace.go:171","msg":"trace[1307178790] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5037; }","duration":"151.68015ms","start":"2026-05-29T11:32:18.044366Z","end":"2026-05-29T11:32:18.196046Z","steps":["trace[1307178790] 'agreement among raft nodes before linearized reading' (duration: 151.508808ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:18.196067Z","caller":"traceutil/trace.go:171","msg":"trace[918975269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5037; }","duration":"137.869747ms","start":"2026-05-29T11:32:18.058185Z","end":"2026-05-29T11:32:18.196054Z","steps":["trace[918975269] 'agreement among raft nodes before linearized reading' (duration: 137.772295ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:28.989351Z","caller":"traceutil/trace.go:171","msg":"trace[1428183323] linearizableReadLoop","detail":"{readStateIndex:5391; appliedIndex:5390; }","duration":"119.054014ms","start":"2026-05-29T11:32:28.870279Z","end":"2026-05-29T11:32:28.989333Z","steps":["trace[1428183323] 'read index received' (duration: 118.904352ms)","trace[1428183323] 'applied index is now lower than readState.Index' (duration: 148.812µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:32:28.989396Z","caller":"traceutil/trace.go:171","msg":"trace[1695188390] transaction","detail":"{read_only:false; response_revision:5197; number_of_response:1; }","duration":"154.856924ms","start":"2026-05-29T11:32:28.834508Z","end":"2026-05-29T11:32:28.989365Z","steps":["trace[1695188390] 'process raft request' (duration: 154.684212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:28.989458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.162985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T11:32:28.989495Z","caller":"traceutil/trace.go:171","msg":"trace[1812892506] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:5197; }","duration":"119.278937ms","start":"2026-05-29T11:32:28.870203Z","end":"2026-05-29T11:32:28.989482Z","steps":["trace[1812892506] 'agreement among raft nodes before linearized reading' (duration: 119.206366ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:28.994078Z","caller":"traceutil/trace.go:171","msg":"trace[85409572] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"118.922192ms","start":"2026-05-29T11:32:28.875136Z","end":"2026-05-29T11:32:28.994058Z","steps":["trace[85409572] 'process raft request' (duration: 118.835201ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:42.758675Z","caller":"traceutil/trace.go:171","msg":"trace[1936021356] linearizableReadLoop","detail":"{readStateIndex:5487; appliedIndex:5486; }","duration":"423.148613ms","start":"2026-05-29T11:32:42.335504Z","end":"2026-05-29T11:32:42.758653Z","steps":["trace[1936021356] 'read index received' (duration: 422.962201ms)","trace[1936021356] 'applied index is now lower than readState.Index' (duration: 185.422µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:32:42.758772Z","caller":"traceutil/trace.go:171","msg":"trace[1535581445] transaction","detail":"{read_only:false; response_revision:5290; number_of_response:1; }","duration":"436.093284ms","start":"2026-05-29T11:32:42.322669Z","end":"2026-05-29T11:32:42.758762Z","steps":["trace[1535581445] 'process raft request' (duration: 435.860249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:42.758942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:32:42.322648Z","time spent":"436.200445ms","remote":"127.0.0.1:57250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T11:32:42.759758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.224369ms","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-29T11:32:42.759843Z","caller":"traceutil/trace.go:171","msg":"trace[1839243768] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5290; }","duration":"424.371871ms","start":"2026-05-29T11:32:42.335454Z","end":"2026-05-29T11:32:42.759826Z","steps":["trace[1839243768] 'agreement among raft nodes before linearized reading' (duration: 423.334767ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:42.759908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:32:42.33543Z","time spent":"424.467672ms","remote":"127.0.0.1:57250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-29T11:32:42.760332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.969727ms","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-29T11:32:42.760363Z","caller":"traceutil/trace.go:171","msg":"trace[1097669692] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5291; }","duration":"123.028178ms","start":"2026-05-29T11:32:42.637327Z","end":"2026-05-29T11:32:42.760355Z","steps":["trace[1097669692] 'agreement among raft nodes before linearized reading' (duration: 122.944657ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:42.76042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.00135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T11:32:42.76048Z","caller":"traceutil/trace.go:171","msg":"trace[2089588815] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:5291; }","duration":"165.072431ms","start":"2026-05-29T11:32:42.595376Z","end":"2026-05-29T11:32:42.760448Z","steps":["trace[2089588815] 'agreement among raft nodes before linearized reading' (duration: 164.97795ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:42.760644Z","caller":"traceutil/trace.go:171","msg":"trace[840869443] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"106.775552ms","start":"2026-05-29T11:32:42.653856Z","end":"2026-05-29T11:32:42.760632Z","steps":["trace[840869443] 'process raft request' (duration: 105.999081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:42.760315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.336521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10883"} {"level":"info","ts":"2026-05-29T11:32:42.760833Z","caller":"traceutil/trace.go:171","msg":"trace[1213607083] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5291; }","duration":"357.927649ms","start":"2026-05-29T11:32:42.402898Z","end":"2026-05-29T11:32:42.760825Z","steps":["trace[1213607083] 'agreement among raft nodes before linearized reading' (duration: 357.188779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:32:42.760953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:32:42.402877Z","time spent":"358.03564ms","remote":"127.0.0.1:57172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10905,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-05-29T11:32:42.761494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.420477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-29T11:32:42.761527Z","caller":"traceutil/trace.go:171","msg":"trace[102643249] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5291; }","duration":"289.495348ms","start":"2026-05-29T11:32:42.472024Z","end":"2026-05-29T11:32:42.761519Z","steps":["trace[102643249] 'agreement among raft nodes before linearized reading' (duration: 289.383596ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:32:56.339763Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2875} {"level":"info","ts":"2026-05-29T11:32:56.404108Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2875,"took":"63.08351ms","hash":1861463239,"current-db-size-bytes":51064832,"current-db-size":"51 MB","current-db-size-in-use-bytes":27607040,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-29T11:32:56.40416Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1861463239,"revision":2875,"compact-revision":-1} {"level":"warn","ts":"2026-05-29T11:33:04.545243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.441844ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T11:33:04.545493Z","caller":"traceutil/trace.go:171","msg":"trace[1641577199] transaction","detail":"{read_only:false; response_revision:5526; number_of_response:1; }","duration":"266.647617ms","start":"2026-05-29T11:33:04.27882Z","end":"2026-05-29T11:33:04.545467Z","steps":["trace[1641577199] 'process raft request' (duration: 103.896629ms)","trace[1641577199] 'compare' (duration: 162.338403ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:33:05.111751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.074692ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-29T11:33:05.312817Z","caller":"traceutil/trace.go:171","msg":"trace[680574682] transaction","detail":"{read_only:false; response_revision:5531; number_of_response:1; }","duration":"171.829663ms","start":"2026-05-29T11:33:05.140962Z","end":"2026-05-29T11:33:05.312792Z","steps":["trace[680574682] 'process raft request' (duration: 169.056115ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:35:36.031271Z","caller":"traceutil/trace.go:171","msg":"trace[1294640933] transaction","detail":"{read_only:false; response_revision:6475; number_of_response:1; }","duration":"196.4847ms","start":"2026-05-29T11:35:35.834759Z","end":"2026-05-29T11:35:36.031244Z","steps":["trace[1294640933] 'process raft request' (duration: 196.345454ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:36:37.481685Z","caller":"traceutil/trace.go:171","msg":"trace[592074743] transaction","detail":"{read_only:false; response_revision:7004; number_of_response:1; }","duration":"125.062471ms","start":"2026-05-29T11:36:37.356601Z","end":"2026-05-29T11:36:37.481663Z","steps":["trace[592074743] 'process raft request' (duration: 80.449644ms)","trace[592074743] 'compare' (duration: 44.531494ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:37:56.351621Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5381} {"level":"info","ts":"2026-05-29T11:37:56.441044Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5381,"took":"88.25998ms","hash":1129205606,"current-db-size-bytes":51064832,"current-db-size":"51 MB","current-db-size-in-use-bytes":18911232,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-05-29T11:37:56.441088Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1129205606,"revision":5381,"compact-revision":2875}