{"level":"warn","ts":"2026-06-11T17:36:01.744022Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-11T17:36:01.744133Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132: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.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-11T17:36:01.744224Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-11T17:36:01.744238Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-06-11T17:36:01.744283Z","caller":"embed/etcd.go:528","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-11T17:36:01.744871Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]} {"level":"info","ts":"2026-06-11T17:36:01.744970Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.5.24","git-sha":"e72f3c2","go-version":"go1.24.9","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.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-11T17:36:01.748319Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.115801ms"} {"level":"info","ts":"2026-06-11T17:36:01.764794Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"} {"level":"info","ts":"2026-06-11T17:36:01.764924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"} {"level":"info","ts":"2026-06-11T17:36:01.764976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"} {"level":"info","ts":"2026-06-11T17:36:01.765001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-11T17:36:01.765023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"} {"level":"info","ts":"2026-06-11T17:36:01.765086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"warn","ts":"2026-06-11T17:36:01.770883Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-11T17:36:01.773519Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-11T17:36:01.773695Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-06-11T17:36:01.774766Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-11T17:36:01.776102Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.24","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-11T17:36:01.776650Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-06-11T17:36:01.777655Z","caller":"etcdserver/server.go:759","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-11T17:36:01.777765Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-11T17:36:01.777797Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-11T17:36:01.777808Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-11T17:36:01.777973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"info","ts":"2026-06-11T17:36:01.778042Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-06-11T17:36:01.778385Z","caller":"embed/etcd.go:762","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-11T17:36:01.778705Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-06-11T17:36:01.778741Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-06-11T17:36:01.778943Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-11T17:36:01.778984Z","caller":"embed/etcd.go:908","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-11T17:36:02.166420Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"} {"level":"info","ts":"2026-06-11T17:36:02.166492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-11T17:36:02.166603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"} {"level":"info","ts":"2026-06-11T17:36:02.166635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"} {"level":"info","ts":"2026-06-11T17:36:02.166655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-06-11T17:36:02.166675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"} {"level":"info","ts":"2026-06-11T17:36:02.166692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-06-11T17:36:02.167600Z","caller":"etcdserver/server.go:2158","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"} {"level":"info","ts":"2026-06-11T17:36:02.167787Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-11T17:36:02.167957Z","caller":"etcdserver/server.go:2711","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T17:36:02.167912Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-11T17:36:02.168171Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-11T17:36:02.168207Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-11T17:36:02.168644Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T17:36:02.168771Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T17:36:02.168812Z","caller":"etcdserver/server.go:2735","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T17:36:02.169490Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-06-11T17:36:02.169542Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-06-11T17:36:02.171245Z","caller":"embed/serve.go:275","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-11T17:36:02.171526Z","caller":"embed/serve.go:275","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"} {"level":"warn","ts":"2026-06-11T17:36:18.273262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.60601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-11T17:36:18.273364Z","caller":"traceutil/trace.go:171","msg":"trace[614532230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:380; }","duration":"246.745061ms","start":"2026-06-11T17:36:18.026599Z","end":"2026-06-11T17:36:18.273344Z","steps":["trace[614532230] 'range keys from in-memory index tree' (duration: 246.498452ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:36:18.399340Z","caller":"traceutil/trace.go:171","msg":"trace[1709964712] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"121.776388ms","start":"2026-06-11T17:36:18.277525Z","end":"2026-06-11T17:36:18.399301Z","steps":["trace[1709964712] 'process raft request' (duration: 121.582552ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:36:41.668461Z","caller":"traceutil/trace.go:171","msg":"trace[1581077624] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"157.725739ms","start":"2026-06-11T17:36:41.510709Z","end":"2026-06-11T17:36:41.668435Z","steps":["trace[1581077624] 'process raft request' (duration: 155.09302ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:36:41.672052Z","caller":"traceutil/trace.go:171","msg":"trace[123258065] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"108.396755ms","start":"2026-06-11T17:36:41.563640Z","end":"2026-06-11T17:36:41.672037Z","steps":["trace[123258065] 'process raft request' (duration: 108.316838ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:36:41.672294Z","caller":"traceutil/trace.go:171","msg":"trace[1458587594] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"158.26055ms","start":"2026-06-11T17:36:41.514007Z","end":"2026-06-11T17:36:41.672268Z","steps":["trace[1458587594] 'process raft request' (duration: 157.716519ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:36:46.660124Z","caller":"traceutil/trace.go:171","msg":"trace[701981072] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"123.61192ms","start":"2026-06-11T17:36:46.536486Z","end":"2026-06-11T17:36:46.660098Z","steps":["trace[701981072] 'process raft request' (duration: 123.125753ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:36:47.734868Z","caller":"traceutil/trace.go:171","msg":"trace[923439154] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"108.335337ms","start":"2026-06-11T17:36:47.626511Z","end":"2026-06-11T17:36:47.734846Z","steps":["trace[923439154] 'process raft request' (duration: 107.872499ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:36:47.929182Z","caller":"traceutil/trace.go:171","msg":"trace[175486005] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"105.288054ms","start":"2026-06-11T17:36:47.823867Z","end":"2026-06-11T17:36:47.929155Z","steps":["trace[175486005] 'read index received' (duration: 105.004011ms)","trace[175486005] 'applied index is now lower than readState.Index' (duration: 282.983µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T17:36:47.929488Z","caller":"traceutil/trace.go:171","msg":"trace[1209922157] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"108.849585ms","start":"2026-06-11T17:36:47.820623Z","end":"2026-06-11T17:36:47.929473Z","steps":["trace[1209922157] 'process raft request' (duration: 108.392237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:36:47.929649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.738743ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T17:36:47.929727Z","caller":"traceutil/trace.go:171","msg":"trace[344963119] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:605; }","duration":"105.86411ms","start":"2026-06-11T17:36:47.823853Z","end":"2026-06-11T17:36:47.929717Z","steps":["trace[344963119] 'agreement among raft nodes before linearized reading' (duration: 105.678855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:36:48.580562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.696625ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T17:36:48.580693Z","caller":"traceutil/trace.go:171","msg":"trace[350973787] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"565.491644ms","start":"2026-06-11T17:36:48.015181Z","end":"2026-06-11T17:36:48.580672Z","steps":["trace[350973787] 'process raft request' (duration: 248.807403ms)","trace[350973787] 'compare' (duration: 315.421501ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T17:36:48.580770Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T17:36:48.015152Z","time spent":"565.583953ms","remote":"127.0.0.1:52332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T17:36:48.603008Z","caller":"traceutil/trace.go:171","msg":"trace[1611874767] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"180.910766ms","start":"2026-06-11T17:36:48.422056Z","end":"2026-06-11T17:36:48.602967Z","steps":["trace[1611874767] 'read index received' (duration: 176.230687ms)","trace[1611874767] 'applied index is now lower than readState.Index' (duration: 4.67919ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T17:36:48.603132Z","caller":"traceutil/trace.go:171","msg":"trace[2020577462] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"256.659889ms","start":"2026-06-11T17:36:48.346463Z","end":"2026-06-11T17:36:48.603123Z","steps":["trace[2020577462] 'process raft request' (duration: 253.571981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:36:48.603314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.25375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T17:36:48.603374Z","caller":"traceutil/trace.go:171","msg":"trace[1936105457] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"181.318967ms","start":"2026-06-11T17:36:48.422041Z","end":"2026-06-11T17:36:48.603360Z","steps":["trace[1936105457] 'agreement among raft nodes before linearized reading' (duration: 181.220309ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:36:50.367115Z","caller":"traceutil/trace.go:171","msg":"trace[1389239998] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"249.322045ms","start":"2026-06-11T17:36:50.117761Z","end":"2026-06-11T17:36:50.367083Z","steps":["trace[1389239998] 'process raft request' (duration: 242.569474ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:37:30.942623Z","caller":"traceutil/trace.go:171","msg":"trace[2061845077] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"109.417839ms","start":"2026-06-11T17:37:30.833169Z","end":"2026-06-11T17:37:30.942587Z","steps":["trace[2061845077] 'process raft request' (duration: 101.602329ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:37:31.767855Z","caller":"traceutil/trace.go:171","msg":"trace[928756297] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"113.27035ms","start":"2026-06-11T17:37:31.654562Z","end":"2026-06-11T17:37:31.767832Z","steps":["trace[928756297] 'process raft request' (duration: 113.111236ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:38:18.431995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.153849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8bc8dbd2-cfe5-449f-83d8-a8f22aff946c\" limit:1 ","response":"range_response_count:1 size:3986"} {"level":"info","ts":"2026-06-11T17:38:18.432079Z","caller":"traceutil/trace.go:171","msg":"trace[1599269614] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8bc8dbd2-cfe5-449f-83d8-a8f22aff946c; range_end:; response_count:1; response_revision:1853; }","duration":"216.249384ms","start":"2026-06-11T17:38:18.215812Z","end":"2026-06-11T17:38:18.432061Z","steps":["trace[1599269614] 'range keys from in-memory index tree' (duration: 216.058255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:38:18.432099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.772651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" limit:1 ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-11T17:38:18.432159Z","caller":"traceutil/trace.go:171","msg":"trace[1943992782] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1853; }","duration":"274.839014ms","start":"2026-06-11T17:38:18.157306Z","end":"2026-06-11T17:38:18.432146Z","steps":["trace[1943992782] 'range keys from in-memory index tree' (duration: 274.685067ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:38:18.432635Z","caller":"traceutil/trace.go:171","msg":"trace[2060320007] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"213.579696ms","start":"2026-06-11T17:38:18.219045Z","end":"2026-06-11T17:38:18.432624Z","steps":["trace[2060320007] 'process raft request' (duration: 212.61856ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:38:18.444486Z","caller":"traceutil/trace.go:171","msg":"trace[1847201024] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"166.297892ms","start":"2026-06-11T17:38:18.278167Z","end":"2026-06-11T17:38:18.444465Z","steps":["trace[1847201024] 'process raft request' (duration: 166.150055ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:38:18.444643Z","caller":"traceutil/trace.go:171","msg":"trace[653502622] linearizableReadLoop","detail":"{readStateIndex:1927; appliedIndex:1925; }","duration":"154.400158ms","start":"2026-06-11T17:38:18.290203Z","end":"2026-06-11T17:38:18.444603Z","steps":["trace[653502622] 'read index received' (duration: 141.710636ms)","trace[653502622] 'applied index is now lower than readState.Index' (duration: 12.688002ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T17:38:18.444858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.64327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8bc8dbd2-cfe5-449f-83d8-a8f22aff946c\" limit:1 ","response":"range_response_count:1 size:3986"} {"level":"info","ts":"2026-06-11T17:38:18.444908Z","caller":"traceutil/trace.go:171","msg":"trace[1622542215] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8bc8dbd2-cfe5-449f-83d8-a8f22aff946c; range_end:; response_count:1; response_revision:1856; }","duration":"154.705223ms","start":"2026-06-11T17:38:18.290190Z","end":"2026-06-11T17:38:18.444895Z","steps":["trace[1622542215] 'agreement among raft nodes before linearized reading' (duration: 154.599348ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:38:18.567638Z","caller":"traceutil/trace.go:171","msg":"trace[610476819] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"113.312977ms","start":"2026-06-11T17:38:18.454296Z","end":"2026-06-11T17:38:18.567609Z","steps":["trace[610476819] 'process raft request' (duration: 110.300525ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:38:18.840664Z","caller":"traceutil/trace.go:171","msg":"trace[1023463223] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"259.62218ms","start":"2026-06-11T17:38:18.580961Z","end":"2026-06-11T17:38:18.840583Z","steps":["trace[1023463223] 'process raft request' (duration: 259.41177ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:38:31.259716Z","caller":"traceutil/trace.go:171","msg":"trace[541540377] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"108.956929ms","start":"2026-06-11T17:38:31.150739Z","end":"2026-06-11T17:38:31.259696Z","steps":["trace[541540377] 'process raft request' (duration: 105.346422ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:38:52.665731Z","caller":"traceutil/trace.go:171","msg":"trace[453816568] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"118.354701ms","start":"2026-06-11T17:38:52.547356Z","end":"2026-06-11T17:38:52.665711Z","steps":["trace[453816568] 'process raft request' (duration: 118.240623ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:38:52.801807Z","caller":"traceutil/trace.go:171","msg":"trace[883924660] linearizableReadLoop","detail":"{readStateIndex:2177; appliedIndex:2175; }","duration":"137.606035ms","start":"2026-06-11T17:38:52.664182Z","end":"2026-06-11T17:38:52.801788Z","steps":["trace[883924660] 'read index received' (duration: 2.367515ms)","trace[883924660] 'applied index is now lower than readState.Index' (duration: 135.23784ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T17:38:52.801916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.719001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" limit:1 ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-11T17:38:52.801943Z","caller":"traceutil/trace.go:171","msg":"trace[2078755164] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2098; }","duration":"137.756543ms","start":"2026-06-11T17:38:52.664176Z","end":"2026-06-11T17:38:52.801933Z","steps":["trace[2078755164] 'agreement among raft nodes before linearized reading' (duration: 137.69152ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:38:52.801910Z","caller":"traceutil/trace.go:171","msg":"trace[300031708] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"254.287281ms","start":"2026-06-11T17:38:52.547559Z","end":"2026-06-11T17:38:52.801846Z","steps":["trace[300031708] 'process raft request' (duration: 239.782856ms)","trace[300031708] 'compare' (duration: 14.059009ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T17:38:52.802003Z","caller":"traceutil/trace.go:171","msg":"trace[264591509] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"252.3453ms","start":"2026-06-11T17:38:52.549629Z","end":"2026-06-11T17:38:52.801974Z","steps":["trace[264591509] 'process raft request' (duration: 252.086585ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:38:53.275363Z","caller":"traceutil/trace.go:171","msg":"trace[1830087360] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"263.678198ms","start":"2026-06-11T17:38:53.011661Z","end":"2026-06-11T17:38:53.275340Z","steps":["trace[1830087360] 'process raft request' (duration: 263.542281ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:38:53.495790Z","caller":"traceutil/trace.go:171","msg":"trace[783782266] linearizableReadLoop","detail":"{readStateIndex:2179; appliedIndex:2178; }","duration":"133.789525ms","start":"2026-06-11T17:38:53.361971Z","end":"2026-06-11T17:38:53.495761Z","steps":["trace[783782266] 'read index received' (duration: 63.196687ms)","trace[783782266] 'applied index is now lower than readState.Index' (duration: 70.591928ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T17:38:53.495846Z","caller":"traceutil/trace.go:171","msg":"trace[1697054155] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"168.546538ms","start":"2026-06-11T17:38:53.327252Z","end":"2026-06-11T17:38:53.495799Z","steps":["trace[1697054155] 'process raft request' (duration: 97.96393ms)","trace[1697054155] 'compare' (duration: 70.401018ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T17:38:53.496006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.805169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T17:38:53.496079Z","caller":"traceutil/trace.go:171","msg":"trace[600658410] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2100; }","duration":"132.899674ms","start":"2026-06-11T17:38:53.363165Z","end":"2026-06-11T17:38:53.496064Z","steps":["trace[600658410] 'agreement among raft nodes before linearized reading' (duration: 132.766997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:38:53.495942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.958695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-11T17:38:53.496332Z","caller":"traceutil/trace.go:171","msg":"trace[966517427] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2100; }","duration":"134.353537ms","start":"2026-06-11T17:38:53.361958Z","end":"2026-06-11T17:38:53.496312Z","steps":["trace[966517427] 'agreement among raft nodes before linearized reading' (duration: 133.922163ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:40:34.787671Z","caller":"traceutil/trace.go:171","msg":"trace[811038769] transaction","detail":"{read_only:false; response_revision:2755; number_of_response:1; }","duration":"107.504284ms","start":"2026-06-11T17:40:34.680068Z","end":"2026-06-11T17:40:34.787573Z","steps":["trace[811038769] 'process raft request' (duration: 107.340153ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:40:40.301857Z","caller":"traceutil/trace.go:171","msg":"trace[1993968735] transaction","detail":"{read_only:false; response_revision:2786; number_of_response:1; }","duration":"198.975834ms","start":"2026-06-11T17:40:40.102867Z","end":"2026-06-11T17:40:40.301843Z","steps":["trace[1993968735] 'process raft request' (duration: 198.889068ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:40:40.301899Z","caller":"traceutil/trace.go:171","msg":"trace[1935532622] linearizableReadLoop","detail":"{readStateIndex:2889; appliedIndex:2889; }","duration":"198.03182ms","start":"2026-06-11T17:40:40.103819Z","end":"2026-06-11T17:40:40.301851Z","steps":["trace[1935532622] 'read index received' (duration: 198.0192ms)","trace[1935532622] 'applied index is now lower than readState.Index' (duration: 10.89µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T17:40:40.302279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.434597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" limit:1 ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-06-11T17:40:40.302323Z","caller":"traceutil/trace.go:171","msg":"trace[1373749794] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2786; }","duration":"198.498812ms","start":"2026-06-11T17:40:40.103814Z","end":"2026-06-11T17:40:40.302313Z","steps":["trace[1373749794] 'agreement among raft nodes before linearized reading' (duration: 198.307979ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:40:40.308030Z","caller":"traceutil/trace.go:171","msg":"trace[843193049] transaction","detail":"{read_only:false; response_revision:2787; number_of_response:1; }","duration":"201.329093ms","start":"2026-06-11T17:40:40.106683Z","end":"2026-06-11T17:40:40.308012Z","steps":["trace[843193049] 'process raft request' (duration: 201.198815ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:44:12.039921Z","caller":"traceutil/trace.go:171","msg":"trace[542371430] transaction","detail":"{read_only:false; response_revision:4474; number_of_response:1; }","duration":"149.789057ms","start":"2026-06-11T17:44:11.890110Z","end":"2026-06-11T17:44:12.039899Z","steps":["trace[542371430] 'process raft request' (duration: 146.962343ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:44:16.399528Z","caller":"traceutil/trace.go:171","msg":"trace[1800569153] transaction","detail":"{read_only:false; response_revision:4594; number_of_response:1; }","duration":"104.87985ms","start":"2026-06-11T17:44:16.294622Z","end":"2026-06-11T17:44:16.399502Z","steps":["trace[1800569153] 'process raft request' (duration: 99.875286ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:44:17.201248Z","caller":"traceutil/trace.go:171","msg":"trace[1517190913] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4632; }","duration":"133.088407ms","start":"2026-06-11T17:44:17.068120Z","end":"2026-06-11T17:44:17.201208Z","steps":["trace[1517190913] 'process raft request' (duration: 132.792215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:17.201415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.308633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" limit:1 ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-06-11T17:44:17.201461Z","caller":"traceutil/trace.go:171","msg":"trace[563102862] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4633; }","duration":"130.379346ms","start":"2026-06-11T17:44:17.071070Z","end":"2026-06-11T17:44:17.201449Z","steps":["trace[563102862] 'agreement among raft nodes before linearized reading' (duration: 130.211809ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:44:17.201082Z","caller":"traceutil/trace.go:171","msg":"trace[1414230395] linearizableReadLoop","detail":"{readStateIndex:4810; appliedIndex:4809; }","duration":"129.98755ms","start":"2026-06-11T17:44:17.071077Z","end":"2026-06-11T17:44:17.201065Z","steps":["trace[1414230395] 'read index received' (duration: 87.763745ms)","trace[1414230395] 'applied index is now lower than readState.Index' (duration: 42.223005ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T17:44:17.288263Z","caller":"traceutil/trace.go:171","msg":"trace[1731046763] transaction","detail":"{read_only:false; response_revision:4634; number_of_response:1; }","duration":"102.433945ms","start":"2026-06-11T17:44:17.185808Z","end":"2026-06-11T17:44:17.288242Z","steps":["trace[1731046763] 'process raft request' (duration: 102.223716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:23.969706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.710482ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-11T17:44:23.969741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.926819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T17:44:23.969825Z","caller":"traceutil/trace.go:171","msg":"trace[617594263] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4751; }","duration":"145.853838ms","start":"2026-06-11T17:44:23.823949Z","end":"2026-06-11T17:44:23.969803Z","steps":["trace[617594263] 'range keys from in-memory index tree' (duration: 145.65034ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:44:23.969859Z","caller":"traceutil/trace.go:171","msg":"trace[520343048] range","detail":"{range_begin:/registry/configmaps; range_end:; response_count:0; response_revision:4751; }","duration":"210.083716ms","start":"2026-06-11T17:44:23.759754Z","end":"2026-06-11T17:44:23.969837Z","steps":["trace[520343048] 'range keys from in-memory index tree' (duration: 209.861236ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:23.969924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.536934ms","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-06-11T17:44:23.969972Z","caller":"traceutil/trace.go:171","msg":"trace[1163813607] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4751; }","duration":"198.581116ms","start":"2026-06-11T17:44:23.771376Z","end":"2026-06-11T17:44:23.969957Z","steps":["trace[1163813607] 'range keys from in-memory index tree' (duration: 198.500243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:23.970767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.852992ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T17:44:23.970867Z","caller":"traceutil/trace.go:171","msg":"trace[1595754867] linearizableReadLoop","detail":"{readStateIndex:4932; appliedIndex:4931; }","duration":"103.047865ms","start":"2026-06-11T17:44:23.867804Z","end":"2026-06-11T17:44:23.970852Z","steps":["trace[1595754867] 'read index received' (duration: 38.041µs)","trace[1595754867] 'applied index is now lower than readState.Index' (duration: 103.008623ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T17:44:23.971057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.246444ms","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":"info","ts":"2026-06-11T17:44:23.971118Z","caller":"traceutil/trace.go:171","msg":"trace[1927961235] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:4752; }","duration":"103.309196ms","start":"2026-06-11T17:44:23.867798Z","end":"2026-06-11T17:44:23.971107Z","steps":["trace[1927961235] 'agreement among raft nodes before linearized reading' (duration: 103.16478ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:44:23.971272Z","caller":"traceutil/trace.go:171","msg":"trace[1790045777] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"166.969019ms","start":"2026-06-11T17:44:23.804290Z","end":"2026-06-11T17:44:23.971259Z","steps":["trace[1790045777] 'process raft request' (duration: 24.534803ms)","trace[1790045777] 'compare' (duration: 141.589711ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T17:44:24.331367Z","caller":"traceutil/trace.go:171","msg":"trace[493836440] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"109.375963ms","start":"2026-06-11T17:44:24.221955Z","end":"2026-06-11T17:44:24.331331Z","steps":["trace[493836440] 'process raft request' (duration: 103.726387ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:44:38.596128Z","caller":"traceutil/trace.go:171","msg":"trace[297649148] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"414.937009ms","start":"2026-06-11T17:44:38.181170Z","end":"2026-06-11T17:44:38.596107Z","steps":["trace[297649148] 'process raft request' (duration: 414.807653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:38.596263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T17:44:38.181151Z","time spent":"415.043464ms","remote":"127.0.0.1:52252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18868,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T17:44:38.669668Z","caller":"traceutil/trace.go:171","msg":"trace[233571396] linearizableReadLoop","detail":"{readStateIndex:5125; appliedIndex:5123; }","duration":"410.733507ms","start":"2026-06-11T17:44:38.258915Z","end":"2026-06-11T17:44:38.669648Z","steps":["trace[233571396] 'read index received' (duration: 337.311937ms)","trace[233571396] 'applied index is now lower than readState.Index' (duration: 73.41775ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T17:44:38.669865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.933205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" limit:1 ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-11T17:44:38.669769Z","caller":"traceutil/trace.go:171","msg":"trace[1215688624] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"427.740298ms","start":"2026-06-11T17:44:38.241973Z","end":"2026-06-11T17:44:38.669713Z","steps":["trace[1215688624] 'process raft request' (duration: 427.392993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:38.669973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.31838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" limit:1 ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-06-11T17:44:38.670008Z","caller":"traceutil/trace.go:171","msg":"trace[634375756] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4940; }","duration":"371.349391ms","start":"2026-06-11T17:44:38.298648Z","end":"2026-06-11T17:44:38.669997Z","steps":["trace[634375756] 'agreement among raft nodes before linearized reading' (duration: 371.291598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:38.670046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T17:44:38.298637Z","time spent":"371.401343ms","remote":"127.0.0.1:57346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":3339,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" limit:1 "} {"level":"info","ts":"2026-06-11T17:44:38.670191Z","caller":"traceutil/trace.go:171","msg":"trace[1602430015] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"416.435035ms","start":"2026-06-11T17:44:38.253281Z","end":"2026-06-11T17:44:38.669716Z","steps":["trace[1602430015] 'process raft request' (duration: 416.31566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:38.670232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T17:44:38.241943Z","time spent":"428.04475ms","remote":"127.0.0.1:52332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T17:44:38.670482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.307089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T17:44:38.669912Z","caller":"traceutil/trace.go:171","msg":"trace[977095040] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4940; }","duration":"410.997118ms","start":"2026-06-11T17:44:38.258903Z","end":"2026-06-11T17:44:38.669901Z","steps":["trace[977095040] 'agreement among raft nodes before linearized reading' (duration: 410.895303ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:44:38.670686Z","caller":"traceutil/trace.go:171","msg":"trace[1211384591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4940; }","duration":"248.522658ms","start":"2026-06-11T17:44:38.422137Z","end":"2026-06-11T17:44:38.670659Z","steps":["trace[1211384591] 'agreement among raft nodes before linearized reading' (duration: 248.204545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:38.670722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T17:44:38.258895Z","time spent":"411.812032ms","remote":"127.0.0.1:52230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" limit:1 "} {"level":"warn","ts":"2026-06-11T17:44:38.670597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T17:44:38.253272Z","time spent":"417.053221ms","remote":"127.0.0.1:52332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T17:44:38.923055Z","caller":"traceutil/trace.go:171","msg":"trace[940947924] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"240.391584ms","start":"2026-06-11T17:44:38.682621Z","end":"2026-06-11T17:44:38.923013Z","steps":["trace[940947924] 'process raft request' (duration: 189.262636ms)","trace[940947924] 'compare' (duration: 50.862616ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T17:44:38.923485Z","caller":"traceutil/trace.go:171","msg":"trace[203595527] linearizableReadLoop","detail":"{readStateIndex:5126; appliedIndex:5125; }","duration":"238.427048ms","start":"2026-06-11T17:44:38.685032Z","end":"2026-06-11T17:44:38.923459Z","steps":["trace[203595527] 'read index received' (duration: 186.863532ms)","trace[203595527] 'applied index is now lower than readState.Index' (duration: 51.561186ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T17:44:38.923639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.590466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18b817d6a317edfa\" limit:1 ","response":"range_response_count:1 size:746"} {"level":"info","ts":"2026-06-11T17:44:38.923692Z","caller":"traceutil/trace.go:171","msg":"trace[536132428] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18b817d6a317edfa; range_end:; response_count:1; response_revision:4941; }","duration":"238.655058ms","start":"2026-06-11T17:44:38.685021Z","end":"2026-06-11T17:44:38.923676Z","steps":["trace[536132428] 'agreement among raft nodes before linearized reading' (duration: 238.522103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:38.924012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.46658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" limit:1 ","response":"range_response_count:1 size:1453"} {"level":"info","ts":"2026-06-11T17:44:38.924086Z","caller":"traceutil/trace.go:171","msg":"trace[1031400974] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4943; }","duration":"238.554793ms","start":"2026-06-11T17:44:38.685518Z","end":"2026-06-11T17:44:38.924072Z","steps":["trace[1031400974] 'agreement among raft nodes before linearized reading' (duration: 238.423878ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:44:38.924232Z","caller":"traceutil/trace.go:171","msg":"trace[1835935928] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"227.712901ms","start":"2026-06-11T17:44:38.696489Z","end":"2026-06-11T17:44:38.924202Z","steps":["trace[1835935928] 'process raft request' (duration: 227.334835ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:44:38.924272Z","caller":"traceutil/trace.go:171","msg":"trace[269721830] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"121.242613ms","start":"2026-06-11T17:44:38.802952Z","end":"2026-06-11T17:44:38.924195Z","steps":["trace[269721830] 'process raft request' (duration: 120.93914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:38.924669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.02724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T17:44:38.924792Z","caller":"traceutil/trace.go:171","msg":"trace[952567094] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:4943; }","duration":"207.171797ms","start":"2026-06-11T17:44:38.717599Z","end":"2026-06-11T17:44:38.924770Z","steps":["trace[952567094] 'agreement among raft nodes before linearized reading' (duration: 206.646623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T17:44:39.164411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.702311ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T17:44:39.164681Z","caller":"traceutil/trace.go:171","msg":"trace[1145376414] transaction","detail":"{read_only:false; response_revision:4952; number_of_response:1; }","duration":"116.133263ms","start":"2026-06-11T17:44:39.048523Z","end":"2026-06-11T17:44:39.164656Z","steps":["trace[1145376414] 'process raft request' (duration: 116.032209ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:44:39.165048Z","caller":"traceutil/trace.go:171","msg":"trace[779249357] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"142.975156ms","start":"2026-06-11T17:44:39.021845Z","end":"2026-06-11T17:44:39.164820Z","steps":["trace[779249357] 'process raft request' (duration: 35.685649ms)","trace[779249357] 'compare' (duration: 106.524174ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T17:46:02.551430Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2904} {"level":"info","ts":"2026-06-11T17:46:02.634035Z","caller":"mvcc/kvstore_compaction.go:72","msg":"finished scheduled compaction","compact-revision":2904,"took":"81.377591ms","hash":3576396934,"current-db-size-bytes":54669312,"current-db-size":"55 MB","current-db-size-in-use-bytes":29765632,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-11T17:46:02.634096Z","caller":"mvcc/hash.go:151","msg":"storing new hash","hash":3576396934,"revision":2904,"compact-revision":-1} {"level":"info","ts":"2026-06-11T17:48:37.047723Z","caller":"traceutil/trace.go:171","msg":"trace[1472505637] transaction","detail":"{read_only:false; response_revision:6684; number_of_response:1; }","duration":"129.545834ms","start":"2026-06-11T17:48:36.918146Z","end":"2026-06-11T17:48:37.047691Z","steps":["trace[1472505637] 'process raft request' (duration: 129.337172ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:48:37.047982Z","caller":"traceutil/trace.go:171","msg":"trace[460569652] linearizableReadLoop","detail":"{readStateIndex:6928; appliedIndex:6928; }","duration":"112.304363ms","start":"2026-06-11T17:48:36.935640Z","end":"2026-06-11T17:48:37.047944Z","steps":["trace[460569652] 'read index received' (duration: 112.289102ms)","trace[460569652] 'applied index is now lower than readState.Index' (duration: 12.531µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T17:48:37.048206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.537657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T17:48:37.048250Z","caller":"traceutil/trace.go:171","msg":"trace[1300792490] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:6684; }","duration":"112.609961ms","start":"2026-06-11T17:48:36.935630Z","end":"2026-06-11T17:48:37.048240Z","steps":["trace[1300792490] 'agreement among raft nodes before linearized reading' (duration: 112.475723ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T17:51:02.558630Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5647} {"level":"info","ts":"2026-06-11T17:51:02.663423Z","caller":"mvcc/kvstore_compaction.go:72","msg":"finished scheduled compaction","compact-revision":5647,"took":"103.813009ms","hash":459999701,"current-db-size-bytes":54669312,"current-db-size":"55 MB","current-db-size-in-use-bytes":18489344,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-11T17:51:02.663476Z","caller":"mvcc/hash.go:151","msg":"storing new hash","hash":459999701,"revision":5647,"compact-revision":2904}