{"level":"warn","ts":"2026-05-25T10:13:28.92262Z","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-25T10:13:28.922714Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.133: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.133:2380","--initial-cluster=instance=https://199.19.213.133:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.133:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.133: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-25T10:13:28.922788Z","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-25T10:13:28.922803Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.133:2380"]} {"level":"info","ts":"2026-05-25T10:13:28.922826Z","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-25T10:13:28.923433Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.133:2379"]} {"level":"info","ts":"2026-05-25T10:13:28.92352Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.133:2380"],"listen-peer-urls":["https://199.19.213.133:2380"],"advertise-client-urls":["https://199.19.213.133:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.133:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.133: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-25T10:13:28.927963Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.233339ms"} {"level":"info","ts":"2026-05-25T10:13:28.93507Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"21b354698260dd82","cluster-id":"b778216e1db811d5"} {"level":"info","ts":"2026-05-25T10:13:28.935251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 switched to configuration voters=()"} {"level":"info","ts":"2026-05-25T10:13:28.935323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became follower at term 0"} {"level":"info","ts":"2026-05-25T10:13:28.935375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 21b354698260dd82 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-25T10:13:28.935423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became follower at term 1"} {"level":"info","ts":"2026-05-25T10:13:28.935546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 switched to configuration voters=(2428377436218514818)"} {"level":"warn","ts":"2026-05-25T10:13:28.940447Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-25T10:13:28.943172Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-25T10:13:28.944594Z","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-25T10:13:28.947276Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"21b354698260dd82","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-25T10:13:28.947652Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"21b354698260dd82","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-25T10:13:28.947634Z","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-25T10:13:28.947755Z","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-25T10:13:28.947804Z","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-25T10:13:28.948457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 switched to configuration voters=(2428377436218514818)"} {"level":"info","ts":"2026-05-25T10:13:28.948602Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b778216e1db811d5","local-member-id":"21b354698260dd82","added-peer-id":"21b354698260dd82","added-peer-peer-urls":["https://199.19.213.133:2380"]} {"level":"info","ts":"2026-05-25T10:13:28.951264Z","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-25T10:13:28.951474Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.133:2380"} {"level":"info","ts":"2026-05-25T10:13:28.951574Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.133:2380"} {"level":"info","ts":"2026-05-25T10:13:28.952255Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"21b354698260dd82","initial-advertise-peer-urls":["https://199.19.213.133:2380"],"listen-peer-urls":["https://199.19.213.133:2380"],"advertise-client-urls":["https://199.19.213.133:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.133:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-25T10:13:28.952295Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-25T10:13:29.336164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 is starting a new election at term 1"} {"level":"info","ts":"2026-05-25T10:13:29.336287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-25T10:13:29.336348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 received MsgPreVoteResp from 21b354698260dd82 at term 1"} {"level":"info","ts":"2026-05-25T10:13:29.336389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became candidate at term 2"} {"level":"info","ts":"2026-05-25T10:13:29.336431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 received MsgVoteResp from 21b354698260dd82 at term 2"} {"level":"info","ts":"2026-05-25T10:13:29.33647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became leader at term 2"} {"level":"info","ts":"2026-05-25T10:13:29.336514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 21b354698260dd82 elected leader 21b354698260dd82 at term 2"} {"level":"info","ts":"2026-05-25T10:13:29.338076Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T10:13:29.338751Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"21b354698260dd82","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.133:2379]}","request-path":"/0/members/21b354698260dd82/attributes","cluster-id":"b778216e1db811d5","publish-timeout":"7s"} {"level":"info","ts":"2026-05-25T10:13:29.3388Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-25T10:13:29.339164Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b778216e1db811d5","local-member-id":"21b354698260dd82","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T10:13:29.339315Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T10:13:29.339318Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-25T10:13:29.339457Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-25T10:13:29.339566Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-25T10:13:29.343698Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T10:13:29.3442Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.133:2379"} {"level":"info","ts":"2026-05-25T10:13:29.347073Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-25T10:13:50.586875Z","caller":"traceutil/trace.go:171","msg":"trace[524941610] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"240.248292ms","start":"2026-05-25T10:13:50.346597Z","end":"2026-05-25T10:13:50.586846Z","steps":["trace[524941610] 'process raft request' (duration: 240.074889ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:14:13.16313Z","caller":"traceutil/trace.go:171","msg":"trace[1506036629] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"284.761309ms","start":"2026-05-25T10:14:12.878334Z","end":"2026-05-25T10:14:13.163095Z","steps":["trace[1506036629] 'process raft request' (duration: 283.987153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:14:13.812296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.526533ms","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-25T10:14:13.812448Z","caller":"traceutil/trace.go:171","msg":"trace[241668041] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:594; }","duration":"310.746577ms","start":"2026-05-25T10:14:13.501679Z","end":"2026-05-25T10:14:13.812426Z","steps":["trace[241668041] 'range keys from in-memory index tree' (duration: 310.365959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:14:13.812481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:14:13.501623Z","time spent":"310.85152ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-25T10:14:13.812297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.49628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-25T10:14:13.812677Z","caller":"traceutil/trace.go:171","msg":"trace[2027534585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"378.949209ms","start":"2026-05-25T10:14:13.433703Z","end":"2026-05-25T10:14:13.812652Z","steps":["trace[2027534585] 'range keys from in-memory index tree' (duration: 378.253465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:14:13.812711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:14:13.433676Z","time spent":"379.0237ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-25T10:14:13.813202Z","caller":"traceutil/trace.go:171","msg":"trace[1876859547] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"141.378657ms","start":"2026-05-25T10:14:13.671784Z","end":"2026-05-25T10:14:13.813163Z","steps":["trace[1876859547] 'process raft request' (duration: 139.265813ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:14:29.064777Z","caller":"traceutil/trace.go:171","msg":"trace[1924634945] linearizableReadLoop","detail":"{readStateIndex:782; appliedIndex:781; }","duration":"156.717162ms","start":"2026-05-25T10:14:28.908033Z","end":"2026-05-25T10:14:29.06475Z","steps":["trace[1924634945] 'read index received' (duration: 156.569559ms)","trace[1924634945] 'applied index is now lower than readState.Index' (duration: 145.993µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:14:29.06482Z","caller":"traceutil/trace.go:171","msg":"trace[1480289886] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"168.757958ms","start":"2026-05-25T10:14:28.89603Z","end":"2026-05-25T10:14:29.064788Z","steps":["trace[1480289886] 'process raft request' (duration: 168.530063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:14:29.065078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.02992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-kj2rb\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-25T10:14:29.065125Z","caller":"traceutil/trace.go:171","msg":"trace[1025867231] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-kj2rb; range_end:; response_count:1; response_revision:757; }","duration":"157.150242ms","start":"2026-05-25T10:14:28.907962Z","end":"2026-05-25T10:14:29.065112Z","steps":["trace[1025867231] 'agreement among raft nodes before linearized reading' (duration: 156.898167ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:14:29.175633Z","caller":"traceutil/trace.go:171","msg":"trace[1886307511] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"101.351822ms","start":"2026-05-25T10:14:29.074244Z","end":"2026-05-25T10:14:29.175596Z","steps":["trace[1886307511] 'process raft request' (duration: 101.073286ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:14:58.381374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.471724ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-25T10:14:58.381659Z","caller":"traceutil/trace.go:171","msg":"trace[214181506] linearizableReadLoop","detail":"{readStateIndex:1184; appliedIndex:1183; }","duration":"300.795889ms","start":"2026-05-25T10:14:58.080834Z","end":"2026-05-25T10:14:58.38163Z","steps":["trace[214181506] 'read index received' (duration: 85.848865ms)","trace[214181506] 'applied index is now lower than readState.Index' (duration: 214.944684ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:14:58.381971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.124575ms","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-25T10:14:58.382021Z","caller":"traceutil/trace.go:171","msg":"trace[460844065] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1152; }","duration":"301.247408ms","start":"2026-05-25T10:14:58.080758Z","end":"2026-05-25T10:14:58.382006Z","steps":["trace[460844065] 'agreement among raft nodes before linearized reading' (duration: 300.994663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:14:58.382082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:14:58.080716Z","time spent":"301.34463ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-25T10:14:58.487649Z","caller":"traceutil/trace.go:171","msg":"trace[617026440] linearizableReadLoop","detail":"{readStateIndex:1185; appliedIndex:1184; }","duration":"105.9285ms","start":"2026-05-25T10:14:58.381696Z","end":"2026-05-25T10:14:58.487625Z","steps":["trace[617026440] 'read index received' (duration: 105.666994ms)","trace[617026440] 'applied index is now lower than readState.Index' (duration: 260.076µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:14:58.487706Z","caller":"traceutil/trace.go:171","msg":"trace[968211999] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"382.858443ms","start":"2026-05-25T10:14:58.104816Z","end":"2026-05-25T10:14:58.487674Z","steps":["trace[968211999] 'process raft request' (duration: 382.561337ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:14:58.487928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.688618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-25T10:14:58.487981Z","caller":"traceutil/trace.go:171","msg":"trace[1022928136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1153; }","duration":"398.78137ms","start":"2026-05-25T10:14:58.089185Z","end":"2026-05-25T10:14:58.487966Z","steps":["trace[1022928136] 'agreement among raft nodes before linearized reading' (duration: 398.545985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:14:58.488027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:14:58.089167Z","time spent":"398.848671ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-25T10:14:58.488359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:14:58.104785Z","time spent":"383.018747ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":532,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T10:14:58.798051Z","caller":"traceutil/trace.go:171","msg":"trace[915939652] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"411.446976ms","start":"2026-05-25T10:14:58.386567Z","end":"2026-05-25T10:14:58.798014Z","steps":["trace[915939652] 'process raft request' (duration: 402.154399ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:14:58.798138Z","caller":"traceutil/trace.go:171","msg":"trace[938188998] linearizableReadLoop","detail":"{readStateIndex:1187; appliedIndex:1185; }","duration":"121.260934ms","start":"2026-05-25T10:14:58.676828Z","end":"2026-05-25T10:14:58.798088Z","steps":["trace[938188998] 'read index received' (duration: 111.856905ms)","trace[938188998] 'applied index is now lower than readState.Index' (duration: 9.402799ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:14:58.798509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:14:58.386514Z","time spent":"411.64259ms","remote":"127.0.0.1:42572","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-05-25T10:14:58.798935Z","caller":"traceutil/trace.go:171","msg":"trace[1400424278] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"305.469656ms","start":"2026-05-25T10:14:58.4934Z","end":"2026-05-25T10:14:58.79887Z","steps":["trace[1400424278] 'process raft request' (duration: 304.536796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:14:58.799146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.274805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-25T10:14:58.79918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:14:58.49337Z","time spent":"305.686041ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T10:14:58.799215Z","caller":"traceutil/trace.go:171","msg":"trace[1147832356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1155; }","duration":"122.427408ms","start":"2026-05-25T10:14:58.676767Z","end":"2026-05-25T10:14:58.799195Z","steps":["trace[1147832356] 'agreement among raft nodes before linearized reading' (duration: 122.135162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:15:44.658025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.186068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T10:15:44.658159Z","caller":"traceutil/trace.go:171","msg":"trace[1922933313] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1814; }","duration":"190.321981ms","start":"2026-05-25T10:15:44.467792Z","end":"2026-05-25T10:15:44.658114Z","steps":["trace[1922933313] 'count revisions from in-memory index tree' (duration: 190.065765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:15:44.658201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.527477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-05-25T10:15:44.658303Z","caller":"traceutil/trace.go:171","msg":"trace[170501527] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1814; }","duration":"371.698081ms","start":"2026-05-25T10:15:44.286584Z","end":"2026-05-25T10:15:44.658282Z","steps":["trace[170501527] 'range keys from in-memory index tree' (duration: 371.309393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:15:44.65835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:15:44.286559Z","time spent":"371.781363ms","remote":"127.0.0.1:42488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10691,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"info","ts":"2026-05-25T10:15:44.809464Z","caller":"traceutil/trace.go:171","msg":"trace[2018181669] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"137.490451ms","start":"2026-05-25T10:15:44.671929Z","end":"2026-05-25T10:15:44.809419Z","steps":["trace[2018181669] 'process raft request' (duration: 91.957908ms)","trace[2018181669] 'compare' (duration: 45.234317ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:15:44.809661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.187383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f014ec12-141c-4b57-be31-c3039a33eeda\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-25T10:15:44.809698Z","caller":"traceutil/trace.go:171","msg":"trace[974806784] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f014ec12-141c-4b57-be31-c3039a33eeda; range_end:; response_count:1; response_revision:1819; }","duration":"100.328486ms","start":"2026-05-25T10:15:44.709362Z","end":"2026-05-25T10:15:44.80969Z","steps":["trace[974806784] 'agreement among raft nodes before linearized reading' (duration: 100.103891ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:15:45.062869Z","caller":"traceutil/trace.go:171","msg":"trace[2068211460] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"244.834348ms","start":"2026-05-25T10:15:44.817992Z","end":"2026-05-25T10:15:45.062826Z","steps":["trace[2068211460] 'process raft request' (duration: 229.417657ms)","trace[2068211460] 'compare' (duration: 14.126182ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:15:45.062992Z","caller":"traceutil/trace.go:171","msg":"trace[813889970] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"107.650403ms","start":"2026-05-25T10:15:44.955291Z","end":"2026-05-25T10:15:45.062941Z","steps":["trace[813889970] 'process raft request' (duration: 107.418588ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:15:57.219533Z","caller":"traceutil/trace.go:171","msg":"trace[1774648523] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"104.216539ms","start":"2026-05-25T10:15:57.11529Z","end":"2026-05-25T10:15:57.219506Z","steps":["trace[1774648523] 'process raft request' (duration: 103.725029ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:16:39.878427Z","caller":"traceutil/trace.go:171","msg":"trace[1369862771] linearizableReadLoop","detail":"{readStateIndex:2246; appliedIndex:2245; }","duration":"181.219551ms","start":"2026-05-25T10:16:39.697176Z","end":"2026-05-25T10:16:39.878396Z","steps":["trace[1369862771] 'read index received' (duration: 161.78761ms)","trace[1369862771] 'applied index is now lower than readState.Index' (duration: 19.430561ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:16:39.87858Z","caller":"traceutil/trace.go:171","msg":"trace[1824005622] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"193.992087ms","start":"2026-05-25T10:16:39.684533Z","end":"2026-05-25T10:16:39.878525Z","steps":["trace[1824005622] 'process raft request' (duration: 174.278799ms)","trace[1824005622] 'compare' (duration: 19.142135ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:16:39.878689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.487516ms","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-25T10:16:39.878735Z","caller":"traceutil/trace.go:171","msg":"trace[1797957241] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2167; }","duration":"181.579568ms","start":"2026-05-25T10:16:39.69714Z","end":"2026-05-25T10:16:39.87872Z","steps":["trace[1797957241] 'agreement among raft nodes before linearized reading' (duration: 181.402514ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:16:39.879197Z","caller":"traceutil/trace.go:171","msg":"trace[1869455538] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"105.882355ms","start":"2026-05-25T10:16:39.773278Z","end":"2026-05-25T10:16:39.87916Z","steps":["trace[1869455538] 'process raft request' (duration: 105.722202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:16:39.879421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.167384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-25T10:16:39.879496Z","caller":"traceutil/trace.go:171","msg":"trace[1622633518] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2168; }","duration":"101.286726ms","start":"2026-05-25T10:16:39.778195Z","end":"2026-05-25T10:16:39.879482Z","steps":["trace[1622633518] 'agreement among raft nodes before linearized reading' (duration: 100.930518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:16:40.203838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.422062ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-25T10:16:40.204022Z","caller":"traceutil/trace.go:171","msg":"trace[648898414] linearizableReadLoop","detail":"{readStateIndex:2250; appliedIndex:2249; }","duration":"245.121155ms","start":"2026-05-25T10:16:39.958881Z","end":"2026-05-25T10:16:40.204002Z","steps":["trace[648898414] 'read index received' (duration: 64.378356ms)","trace[648898414] 'applied index is now lower than readState.Index' (duration: 180.741039ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:16:40.204138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.248057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T10:16:40.204173Z","caller":"traceutil/trace.go:171","msg":"trace[889815628] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:2171; }","duration":"245.316109ms","start":"2026-05-25T10:16:39.958846Z","end":"2026-05-25T10:16:40.204162Z","steps":["trace[889815628] 'agreement among raft nodes before linearized reading' (duration: 245.207797ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:16:40.20425Z","caller":"traceutil/trace.go:171","msg":"trace[770703663] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"260.154721ms","start":"2026-05-25T10:16:39.944046Z","end":"2026-05-25T10:16:40.204201Z","steps":["trace[770703663] 'process raft request' (duration: 79.228458ms)","trace[770703663] 'compare' (duration: 180.007963ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:17:48.350479Z","caller":"traceutil/trace.go:171","msg":"trace[346283094] transaction","detail":"{read_only:false; response_revision:2736; number_of_response:1; }","duration":"133.541041ms","start":"2026-05-25T10:17:48.216922Z","end":"2026-05-25T10:17:48.350463Z","steps":["trace[346283094] 'process raft request' (duration: 67.755187ms)","trace[346283094] 'compare' (duration: 65.678132ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:17:48.350889Z","caller":"traceutil/trace.go:171","msg":"trace[1704004367] transaction","detail":"{read_only:false; response_revision:2737; number_of_response:1; }","duration":"133.797538ms","start":"2026-05-25T10:17:48.217032Z","end":"2026-05-25T10:17:48.35083Z","steps":["trace[1704004367] 'process raft request' (duration: 133.403289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:17:49.566178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.8486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-05-25T10:17:49.56637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.491546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T10:17:49.566498Z","caller":"traceutil/trace.go:171","msg":"trace[917349256] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2740; }","duration":"167.683111ms","start":"2026-05-25T10:17:49.398786Z","end":"2026-05-25T10:17:49.566469Z","steps":["trace[917349256] 'count revisions from in-memory index tree' (duration: 167.389374ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:17:49.566279Z","caller":"traceutil/trace.go:171","msg":"trace[419806633] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2740; }","duration":"135.010594ms","start":"2026-05-25T10:17:49.43124Z","end":"2026-05-25T10:17:49.56625Z","steps":["trace[419806633] 'range keys from in-memory index tree' (duration: 134.626605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:20:25.355712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.751677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-05-25T10:20:25.355892Z","caller":"traceutil/trace.go:171","msg":"trace[1160130247] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3763; }","duration":"164.950231ms","start":"2026-05-25T10:20:25.190921Z","end":"2026-05-25T10:20:25.355871Z","steps":["trace[1160130247] 'range keys from in-memory index tree' (duration: 164.601072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:20:25.355954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.994239ms","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-25T10:20:25.356038Z","caller":"traceutil/trace.go:171","msg":"trace[789790221] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3763; }","duration":"176.090271ms","start":"2026-05-25T10:20:25.179928Z","end":"2026-05-25T10:20:25.356019Z","steps":["trace[789790221] 'range keys from in-memory index tree' (duration: 175.721614ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:21:52.792909Z","caller":"traceutil/trace.go:171","msg":"trace[1636678232] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"261.727584ms","start":"2026-05-25T10:21:52.53115Z","end":"2026-05-25T10:21:52.792878Z","steps":["trace[1636678232] 'process raft request' (duration: 194.663435ms)","trace[1636678232] 'compare' (duration: 66.867615ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:21:52.853442Z","caller":"traceutil/trace.go:171","msg":"trace[1001389279] linearizableReadLoop","detail":"{readStateIndex:5132; appliedIndex:5130; }","duration":"311.907737ms","start":"2026-05-25T10:21:52.541518Z","end":"2026-05-25T10:21:52.853426Z","steps":["trace[1001389279] 'read index received' (duration: 184.25834ms)","trace[1001389279] 'applied index is now lower than readState.Index' (duration: 127.648577ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:21:52.853532Z","caller":"traceutil/trace.go:171","msg":"trace[1520369879] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"321.696419ms","start":"2026-05-25T10:21:52.531827Z","end":"2026-05-25T10:21:52.853523Z","steps":["trace[1520369879] 'process raft request' (duration: 321.453974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:21:52.853586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:21:52.531818Z","time spent":"321.72868ms","remote":"127.0.0.1:42488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4888,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-25T10:21:52.853627Z","caller":"traceutil/trace.go:171","msg":"trace[381566029] transaction","detail":"{read_only:false; response_revision:4952; number_of_response:1; }","duration":"238.760757ms","start":"2026-05-25T10:21:52.614836Z","end":"2026-05-25T10:21:52.853597Z","steps":["trace[381566029] 'process raft request' (duration: 238.568613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:21:52.853793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.275275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jbqn9\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-05-25T10:21:52.853819Z","caller":"traceutil/trace.go:171","msg":"trace[967024147] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jbqn9; range_end:; response_count:1; response_revision:4952; }","duration":"312.344966ms","start":"2026-05-25T10:21:52.541468Z","end":"2026-05-25T10:21:52.853813Z","steps":["trace[967024147] 'agreement among raft nodes before linearized reading' (duration: 312.241694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:21:52.853834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:21:52.541453Z","time spent":"312.378747ms","remote":"127.0.0.1:42488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-jbqn9\" "} {"level":"info","ts":"2026-05-25T10:21:52.853857Z","caller":"traceutil/trace.go:171","msg":"trace[524849954] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"253.867703ms","start":"2026-05-25T10:21:52.599975Z","end":"2026-05-25T10:21:52.853842Z","steps":["trace[524849954] 'process raft request' (duration: 253.391923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:21:52.853943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.407062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-dg86v-tls\" ","response":"range_response_count:1 size:1967"} {"level":"info","ts":"2026-05-25T10:21:52.853957Z","caller":"traceutil/trace.go:171","msg":"trace[527788950] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-dg86v-tls; range_end:; response_count:1; response_revision:4952; }","duration":"296.453343ms","start":"2026-05-25T10:21:52.557498Z","end":"2026-05-25T10:21:52.853952Z","steps":["trace[527788950] 'agreement among raft nodes before linearized reading' (duration: 296.406922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:21:52.854095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.50849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T10:21:52.854111Z","caller":"traceutil/trace.go:171","msg":"trace[1636151010] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:4952; }","duration":"206.551051ms","start":"2026-05-25T10:21:52.647555Z","end":"2026-05-25T10:21:52.854106Z","steps":["trace[1636151010] 'agreement among raft nodes before linearized reading' (duration: 206.47768ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:21:52.854209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.771724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b0d7492b-1f90-417e-a79b-5ddd44955a6b\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-05-25T10:21:52.854228Z","caller":"traceutil/trace.go:171","msg":"trace[1401752488] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b0d7492b-1f90-417e-a79b-5ddd44955a6b; range_end:; response_count:1; response_revision:4952; }","duration":"217.812475ms","start":"2026-05-25T10:21:52.636411Z","end":"2026-05-25T10:21:52.854224Z","steps":["trace[1401752488] 'agreement among raft nodes before linearized reading' (duration: 217.763073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:21:52.854263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.396637ms","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-25T10:21:52.8543Z","caller":"traceutil/trace.go:171","msg":"trace[1802324898] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:4952; }","duration":"236.452838ms","start":"2026-05-25T10:21:52.617833Z","end":"2026-05-25T10:21:52.854285Z","steps":["trace[1802324898] 'agreement among raft nodes before linearized reading' (duration: 236.399927ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:22:05.534862Z","caller":"traceutil/trace.go:171","msg":"trace[1793451796] linearizableReadLoop","detail":"{readStateIndex:5395; appliedIndex:5394; }","duration":"109.779231ms","start":"2026-05-25T10:22:05.42505Z","end":"2026-05-25T10:22:05.534829Z","steps":["trace[1793451796] 'read index received' (duration: 104.077308ms)","trace[1793451796] 'applied index is now lower than readState.Index' (duration: 5.700613ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:22:05.534975Z","caller":"traceutil/trace.go:171","msg":"trace[125259128] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"115.926363ms","start":"2026-05-25T10:22:05.41901Z","end":"2026-05-25T10:22:05.534937Z","steps":["trace[125259128] 'process raft request' (duration: 110.238951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:22:05.53519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.118548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-25T10:22:05.535304Z","caller":"traceutil/trace.go:171","msg":"trace[6386294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5204; }","duration":"110.292232ms","start":"2026-05-25T10:22:05.424988Z","end":"2026-05-25T10:22:05.53528Z","steps":["trace[6386294] 'agreement among raft nodes before linearized reading' (duration: 109.991455ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:22:06.051648Z","caller":"traceutil/trace.go:171","msg":"trace[663686656] linearizableReadLoop","detail":"{readStateIndex:5404; appliedIndex:5403; }","duration":"167.067659ms","start":"2026-05-25T10:22:05.884563Z","end":"2026-05-25T10:22:06.05163Z","steps":["trace[663686656] 'read index received' (duration: 166.895144ms)","trace[663686656] 'applied index is now lower than readState.Index' (duration: 171.415µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:22:06.051732Z","caller":"traceutil/trace.go:171","msg":"trace[1322721981] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"194.281127ms","start":"2026-05-25T10:22:05.857405Z","end":"2026-05-25T10:22:06.051686Z","steps":["trace[1322721981] 'process raft request' (duration: 194.070423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:22:06.051833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.264504ms","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-25T10:22:06.051864Z","caller":"traceutil/trace.go:171","msg":"trace[1128316926] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5213; }","duration":"167.354176ms","start":"2026-05-25T10:22:05.8845Z","end":"2026-05-25T10:22:06.051854Z","steps":["trace[1128316926] 'agreement among raft nodes before linearized reading' (duration: 167.244163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:22:06.05185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.858543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T10:22:06.051909Z","caller":"traceutil/trace.go:171","msg":"trace[1926206032] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5213; }","duration":"152.986745ms","start":"2026-05-25T10:22:05.898909Z","end":"2026-05-25T10:22:06.051896Z","steps":["trace[1926206032] 'agreement among raft nodes before linearized reading' (duration: 152.858782ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:22:14.211028Z","caller":"traceutil/trace.go:171","msg":"trace[765567515] transaction","detail":"{read_only:false; response_revision:5370; number_of_response:1; }","duration":"105.042279ms","start":"2026-05-25T10:22:14.105945Z","end":"2026-05-25T10:22:14.210988Z","steps":["trace[765567515] 'process raft request' (duration: 80.482348ms)","trace[765567515] 'compare' (duration: 24.388387ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:22:24.423959Z","caller":"traceutil/trace.go:171","msg":"trace[1450429894] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"103.020366ms","start":"2026-05-25T10:22:24.320916Z","end":"2026-05-25T10:22:24.423936Z","steps":["trace[1450429894] 'process raft request' (duration: 71.387003ms)","trace[1450429894] 'compare' (duration: 31.50045ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:22:24.424226Z","caller":"traceutil/trace.go:171","msg":"trace[222689945] transaction","detail":"{read_only:false; response_revision:5524; number_of_response:1; }","duration":"102.260859ms","start":"2026-05-25T10:22:24.32193Z","end":"2026-05-25T10:22:24.424191Z","steps":["trace[222689945] 'process raft request' (duration: 101.970353ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:23:29.691875Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2959} {"level":"info","ts":"2026-05-25T10:23:29.760626Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2959,"took":"67.129173ms","hash":870258168,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":34189312,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-25T10:23:29.760729Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":870258168,"revision":2959,"compact-revision":-1} {"level":"info","ts":"2026-05-25T10:28:13.304849Z","caller":"traceutil/trace.go:171","msg":"trace[651939555] transaction","detail":"{read_only:false; response_revision:8172; number_of_response:1; }","duration":"171.516361ms","start":"2026-05-25T10:28:13.133297Z","end":"2026-05-25T10:28:13.304814Z","steps":["trace[651939555] 'process raft request' (duration: 171.293907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:28:24.898586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.29883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T10:28:24.898712Z","caller":"traceutil/trace.go:171","msg":"trace[560066518] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8234; }","duration":"139.521684ms","start":"2026-05-25T10:28:24.759164Z","end":"2026-05-25T10:28:24.898686Z","steps":["trace[560066518] 'count revisions from in-memory index tree' (duration: 139.152547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:28:25.609693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.637217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-25T10:28:25.609707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.879495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-25T10:28:25.609782Z","caller":"traceutil/trace.go:171","msg":"trace[885883854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8236; }","duration":"132.788521ms","start":"2026-05-25T10:28:25.476973Z","end":"2026-05-25T10:28:25.609761Z","steps":["trace[885883854] 'range keys from in-memory index tree' (duration: 132.457574ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:28:25.60979Z","caller":"traceutil/trace.go:171","msg":"trace[759138611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8236; }","duration":"135.015458ms","start":"2026-05-25T10:28:25.474754Z","end":"2026-05-25T10:28:25.609769Z","steps":["trace[759138611] 'range keys from in-memory index tree' (duration: 134.596349ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:28:29.697872Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6063} {"level":"info","ts":"2026-05-25T10:28:29.808611Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6063,"took":"108.652153ms","hash":754659656,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":23826432,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-05-25T10:28:29.808701Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":754659656,"revision":6063,"compact-revision":2959} {"level":"info","ts":"2026-05-25T10:28:53.830558Z","caller":"traceutil/trace.go:171","msg":"trace[249555482] linearizableReadLoop","detail":"{readStateIndex:8735; appliedIndex:8734; }","duration":"157.92478ms","start":"2026-05-25T10:28:53.672604Z","end":"2026-05-25T10:28:53.830528Z","steps":["trace[249555482] 'read index received' (duration: 121.534499ms)","trace[249555482] 'applied index is now lower than readState.Index' (duration: 36.389191ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:28:53.830639Z","caller":"traceutil/trace.go:171","msg":"trace[2037736539] transaction","detail":"{read_only:false; response_revision:8440; number_of_response:1; }","duration":"170.531661ms","start":"2026-05-25T10:28:53.660076Z","end":"2026-05-25T10:28:53.830608Z","steps":["trace[2037736539] 'process raft request' (duration: 134.12543ms)","trace[2037736539] 'compare' (duration: 36.217677ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:28:53.830735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.114224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T10:28:53.830773Z","caller":"traceutil/trace.go:171","msg":"trace[1244683796] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:8440; }","duration":"158.203886ms","start":"2026-05-25T10:28:53.672561Z","end":"2026-05-25T10:28:53.830765Z","steps":["trace[1244683796] 'agreement among raft nodes before linearized reading' (duration: 158.116424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:28:56.820171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.185524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T10:28:56.820238Z","caller":"traceutil/trace.go:171","msg":"trace[787410194] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:8458; }","duration":"171.300607ms","start":"2026-05-25T10:28:56.648922Z","end":"2026-05-25T10:28:56.820223Z","steps":["trace[787410194] 'count revisions from in-memory index tree' (duration: 171.116573ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:28:56.833788Z","caller":"traceutil/trace.go:171","msg":"trace[1576990283] transaction","detail":"{read_only:false; response_revision:8459; number_of_response:1; }","duration":"103.271537ms","start":"2026-05-25T10:28:56.730486Z","end":"2026-05-25T10:28:56.833758Z","steps":["trace[1576990283] 'process raft request' (duration: 103.073903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:29:06.728655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.021872ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-25T10:29:06.728868Z","caller":"traceutil/trace.go:171","msg":"trace[1806558837] transaction","detail":"{read_only:false; response_revision:8552; number_of_response:1; }","duration":"234.543565ms","start":"2026-05-25T10:29:06.494299Z","end":"2026-05-25T10:29:06.728843Z","steps":["trace[1806558837] 'process raft request' (duration: 103.235727ms)","trace[1806558837] 'compare' (duration: 130.90454ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:29:06.72907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.08984ms","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-25T10:29:06.729162Z","caller":"traceutil/trace.go:171","msg":"trace[668744911] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8552; }","duration":"142.228592ms","start":"2026-05-25T10:29:06.586912Z","end":"2026-05-25T10:29:06.729141Z","steps":["trace[668744911] 'agreement among raft nodes before linearized reading' (duration: 142.001198ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:29:06.72926Z","caller":"traceutil/trace.go:171","msg":"trace[1333245686] linearizableReadLoop","detail":"{readStateIndex:8853; appliedIndex:8852; }","duration":"141.801424ms","start":"2026-05-25T10:29:06.586952Z","end":"2026-05-25T10:29:06.728754Z","steps":["trace[1333245686] 'read index received' (duration: 10.521776ms)","trace[1333245686] 'applied index is now lower than readState.Index' (duration: 131.278478ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:29:23.49972Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000233f.wal"} {"level":"info","ts":"2026-05-25T10:30:08.821529Z","caller":"traceutil/trace.go:171","msg":"trace[1256103916] transaction","detail":"{read_only:false; response_revision:9214; number_of_response:1; }","duration":"112.927944ms","start":"2026-05-25T10:30:08.708569Z","end":"2026-05-25T10:30:08.821497Z","steps":["trace[1256103916] 'process raft request' (duration: 22.078944ms)","trace[1256103916] 'compare' (duration: 90.689756ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:31:12.524206Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"21b354698260dd82","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-25T10:31:12.53022Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-25T10:31:12.530308Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-25T10:33:29.704463Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8264} {"level":"info","ts":"2026-05-25T10:33:29.790362Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8264,"took":"82.734715ms","hash":4063921642,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":25485312,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-25T10:33:29.790458Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4063921642,"revision":8264,"compact-revision":6063} {"level":"info","ts":"2026-05-25T10:34:09.074389Z","caller":"traceutil/trace.go:171","msg":"trace[697015652] transaction","detail":"{read_only:false; response_revision:11161; number_of_response:1; }","duration":"124.926639ms","start":"2026-05-25T10:34:08.949438Z","end":"2026-05-25T10:34:09.074364Z","steps":["trace[697015652] 'process raft request' (duration: 124.775696ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:34:09.140508Z","caller":"traceutil/trace.go:171","msg":"trace[1560965471] transaction","detail":"{read_only:false; response_revision:11162; number_of_response:1; }","duration":"154.236338ms","start":"2026-05-25T10:34:08.986223Z","end":"2026-05-25T10:34:09.140459Z","steps":["trace[1560965471] 'process raft request' (duration: 153.987333ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:38:29.712077Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10759} {"level":"info","ts":"2026-05-25T10:38:29.792854Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10759,"took":"77.845609ms","hash":3930637945,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":27807744,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-25T10:38:29.792938Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3930637945,"revision":10759,"compact-revision":8264} {"level":"info","ts":"2026-05-25T10:40:40.041373Z","caller":"traceutil/trace.go:171","msg":"trace[1371720524] linearizableReadLoop","detail":"{readStateIndex:14253; appliedIndex:14252; }","duration":"137.93531ms","start":"2026-05-25T10:40:39.903402Z","end":"2026-05-25T10:40:40.041337Z","steps":["trace[1371720524] 'read index received' (duration: 137.799417ms)","trace[1371720524] 'applied index is now lower than readState.Index' (duration: 134.643µs)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:40:40.041527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.100503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T10:40:40.041569Z","caller":"traceutil/trace.go:171","msg":"trace[1647403796] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:13785; }","duration":"138.198246ms","start":"2026-05-25T10:40:39.903358Z","end":"2026-05-25T10:40:40.041556Z","steps":["trace[1647403796] 'agreement among raft nodes before linearized reading' (duration: 138.076643ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:40:40.041862Z","caller":"traceutil/trace.go:171","msg":"trace[537294966] transaction","detail":"{read_only:false; response_revision:13785; number_of_response:1; }","duration":"148.617725ms","start":"2026-05-25T10:40:39.89323Z","end":"2026-05-25T10:40:40.041848Z","steps":["trace[537294966] 'process raft request' (duration: 147.965271ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:40:40.700732Z","caller":"traceutil/trace.go:171","msg":"trace[169664603] transaction","detail":"{read_only:false; response_revision:13787; number_of_response:1; }","duration":"160.714271ms","start":"2026-05-25T10:40:40.539987Z","end":"2026-05-25T10:40:40.700701Z","steps":["trace[169664603] 'process raft request' (duration: 157.956852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:40:49.791729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.320828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-25T10:40:49.791813Z","caller":"traceutil/trace.go:171","msg":"trace[2010489155] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:13946; }","duration":"346.469532ms","start":"2026-05-25T10:40:49.445327Z","end":"2026-05-25T10:40:49.791797Z","steps":["trace[2010489155] 'range keys from in-memory index tree' (duration: 346.158025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:40:49.791847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:40:49.445301Z","time spent":"346.536304ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-05-25T10:40:49.792087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.567648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-25T10:40:49.792202Z","caller":"traceutil/trace.go:171","msg":"trace[1087120718] linearizableReadLoop","detail":"{readStateIndex:14419; appliedIndex:14418; }","duration":"327.892299ms","start":"2026-05-25T10:40:49.464292Z","end":"2026-05-25T10:40:49.792185Z","steps":["trace[1087120718] 'read index received' (duration: 47.064336ms)","trace[1087120718] 'applied index is now lower than readState.Index' (duration: 280.826523ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:40:49.792303Z","caller":"traceutil/trace.go:171","msg":"trace[1306933767] transaction","detail":"{read_only:false; response_revision:13947; number_of_response:1; }","duration":"345.026871ms","start":"2026-05-25T10:40:49.447262Z","end":"2026-05-25T10:40:49.792289Z","steps":["trace[1306933767] 'process raft request' (duration: 64.162538ms)","trace[1306933767] 'compare' (duration: 280.297822ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:40:49.792368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:40:49.447243Z","time spent":"345.087832ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T10:40:49.792579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.065484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-25T10:40:49.792647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.328968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T10:40:49.792685Z","caller":"traceutil/trace.go:171","msg":"trace[603495555] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13947; }","duration":"321.235627ms","start":"2026-05-25T10:40:49.471421Z","end":"2026-05-25T10:40:49.792657Z","steps":["trace[603495555] 'agreement among raft nodes before linearized reading' (duration: 320.925191ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:40:49.792738Z","caller":"traceutil/trace.go:171","msg":"trace[1274945479] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:13947; }","duration":"328.488401ms","start":"2026-05-25T10:40:49.464225Z","end":"2026-05-25T10:40:49.792714Z","steps":["trace[1274945479] 'agreement among raft nodes before linearized reading' (duration: 328.214036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:40:49.792745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:40:49.47141Z","time spent":"321.32379ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-25T10:40:49.792765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.077126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-25T10:40:49.792786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:40:49.464189Z","time spent":"328.586745ms","remote":"127.0.0.1:42642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":90,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-05-25T10:40:49.792824Z","caller":"traceutil/trace.go:171","msg":"trace[1024327508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13947; }","duration":"313.161227ms","start":"2026-05-25T10:40:49.479646Z","end":"2026-05-25T10:40:49.792808Z","steps":["trace[1024327508] 'agreement among raft nodes before linearized reading' (duration: 312.967922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:40:49.792861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:40:49.479636Z","time spent":"313.216939ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-25T10:40:49.79285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.837832ms","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-25T10:40:49.792934Z","caller":"traceutil/trace.go:171","msg":"trace[319566950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13947; }","duration":"313.956205ms","start":"2026-05-25T10:40:49.478954Z","end":"2026-05-25T10:40:49.79291Z","steps":["trace[319566950] 'agreement among raft nodes before linearized reading' (duration: 313.679049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:40:49.792989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:40:49.478947Z","time spent":"314.030497ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-25T10:42:28.255172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.95938ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-25T10:42:28.255428Z","caller":"traceutil/trace.go:171","msg":"trace[229566941] linearizableReadLoop","detail":"{readStateIndex:15535; appliedIndex:15533; }","duration":"131.586155ms","start":"2026-05-25T10:42:28.123825Z","end":"2026-05-25T10:42:28.255411Z","steps":["trace[229566941] 'read index received' (duration: 18.384399ms)","trace[229566941] 'applied index is now lower than readState.Index' (duration: 113.200746ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:42:28.255537Z","caller":"traceutil/trace.go:171","msg":"trace[237154593] transaction","detail":"{read_only:false; response_revision:15031; number_of_response:1; }","duration":"140.513105ms","start":"2026-05-25T10:42:28.114991Z","end":"2026-05-25T10:42:28.255504Z","steps":["trace[237154593] 'process raft request' (duration: 140.28397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:42:28.255606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.767999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-bpz6k\" ","response":"range_response_count:1 size:20763"} {"level":"info","ts":"2026-05-25T10:42:28.255639Z","caller":"traceutil/trace.go:171","msg":"trace[1006646171] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-bpz6k; range_end:; response_count:1; response_revision:15031; }","duration":"131.842701ms","start":"2026-05-25T10:42:28.123788Z","end":"2026-05-25T10:42:28.25563Z","steps":["trace[1006646171] 'agreement among raft nodes before linearized reading' (duration: 131.696198ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:42:28.528554Z","caller":"traceutil/trace.go:171","msg":"trace[1516602441] transaction","detail":"{read_only:false; response_revision:15032; number_of_response:1; }","duration":"136.956178ms","start":"2026-05-25T10:42:28.39156Z","end":"2026-05-25T10:42:28.528516Z","steps":["trace[1516602441] 'process raft request' (duration: 136.729293ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:43:29.717549Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12931} {"level":"info","ts":"2026-05-25T10:43:29.79643Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12931,"took":"76.137234ms","hash":3287244799,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":30781440,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-25T10:43:29.796511Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3287244799,"revision":12931,"compact-revision":10759} {"level":"info","ts":"2026-05-25T10:48:13.68645Z","caller":"traceutil/trace.go:171","msg":"trace[1942223996] transaction","detail":"{read_only:false; response_revision:17657; number_of_response:1; }","duration":"163.743313ms","start":"2026-05-25T10:48:13.522674Z","end":"2026-05-25T10:48:13.686417Z","steps":["trace[1942223996] 'process raft request' (duration: 163.546428ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:48:14.203301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.6464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T10:48:14.203527Z","caller":"traceutil/trace.go:171","msg":"trace[1971025674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17658; }","duration":"155.881545ms","start":"2026-05-25T10:48:14.047623Z","end":"2026-05-25T10:48:14.203505Z","steps":["trace[1971025674] 'range keys from in-memory index tree' (duration: 155.568838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:48:14.784745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.969742ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-25T10:48:14.78486Z","caller":"traceutil/trace.go:171","msg":"trace[1857801914] linearizableReadLoop","detail":"{readStateIndex:18249; appliedIndex:18248; }","duration":"462.269197ms","start":"2026-05-25T10:48:14.322573Z","end":"2026-05-25T10:48:14.784842Z","steps":["trace[1857801914] 'read index received' (duration: 25.968967ms)","trace[1857801914] 'applied index is now lower than readState.Index' (duration: 436.29921ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:48:14.78495Z","caller":"traceutil/trace.go:171","msg":"trace[1184580089] transaction","detail":"{read_only:false; response_revision:17660; number_of_response:1; }","duration":"502.148703ms","start":"2026-05-25T10:48:14.28279Z","end":"2026-05-25T10:48:14.784939Z","steps":["trace[1184580089] 'process raft request' (duration: 65.861794ms)","trace[1184580089] 'compare' (duration: 435.850039ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:48:14.785166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:48:14.282766Z","time spent":"502.214625ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T10:48:14.785397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.496144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T10:48:14.785504Z","caller":"traceutil/trace.go:171","msg":"trace[250884380] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:17660; }","duration":"140.619767ms","start":"2026-05-25T10:48:14.644858Z","end":"2026-05-25T10:48:14.785478Z","steps":["trace[250884380] 'agreement among raft nodes before linearized reading' (duration: 140.428983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:48:14.785576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.985372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-05-25T10:48:14.785589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.37841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-25T10:48:14.785767Z","caller":"traceutil/trace.go:171","msg":"trace[226838803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17660; }","duration":"455.644685ms","start":"2026-05-25T10:48:14.330098Z","end":"2026-05-25T10:48:14.785742Z","steps":["trace[226838803] 'agreement among raft nodes before linearized reading' (duration: 455.250137ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:48:14.786049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:48:14.330072Z","time spent":"455.960631ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-25T10:48:14.785667Z","caller":"traceutil/trace.go:171","msg":"trace[698132111] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17660; }","duration":"463.120865ms","start":"2026-05-25T10:48:14.322522Z","end":"2026-05-25T10:48:14.785642Z","steps":["trace[698132111] 'agreement among raft nodes before linearized reading' (duration: 462.822749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:48:14.786233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:48:14.322503Z","time spent":"463.678026ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-25T10:48:14.786872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.647924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-25T10:48:14.787029Z","caller":"traceutil/trace.go:171","msg":"trace[198005016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17660; }","duration":"462.038822ms","start":"2026-05-25T10:48:14.324974Z","end":"2026-05-25T10:48:14.787013Z","steps":["trace[198005016] 'agreement among raft nodes before linearized reading' (duration: 460.136202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:48:14.787129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:48:14.324952Z","time spent":"462.163864ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-25T10:48:29.722907Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15445} {"level":"info","ts":"2026-05-25T10:48:29.812838Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15445,"took":"86.573867ms","hash":1983933948,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":32817152,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-05-25T10:48:29.812906Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1983933948,"revision":15445,"compact-revision":12931} {"level":"info","ts":"2026-05-25T10:51:34.494201Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"21b354698260dd82","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-25T10:51:34.498879Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-25T10:51:34.499072Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"warn","ts":"2026-05-25T10:52:59.16746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.251666ms","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:8"} {"level":"info","ts":"2026-05-25T10:52:59.167539Z","caller":"traceutil/trace.go:171","msg":"trace[778783605] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:19919; }","duration":"195.518492ms","start":"2026-05-25T10:52:58.972005Z","end":"2026-05-25T10:52:59.167524Z","steps":["trace[778783605] 'count revisions from in-memory index tree' (duration: 195.065713ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:53:16.083513Z","caller":"traceutil/trace.go:171","msg":"trace[1524501490] linearizableReadLoop","detail":"{readStateIndex:20669; appliedIndex:20668; }","duration":"194.42218ms","start":"2026-05-25T10:53:15.889063Z","end":"2026-05-25T10:53:16.083485Z","steps":["trace[1524501490] 'read index received' (duration: 194.281837ms)","trace[1524501490] 'applied index is now lower than readState.Index' (duration: 139.143µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:53:16.083587Z","caller":"traceutil/trace.go:171","msg":"trace[1988616852] transaction","detail":"{read_only:false; response_revision:20002; number_of_response:1; }","duration":"232.7262ms","start":"2026-05-25T10:53:15.850821Z","end":"2026-05-25T10:53:16.083547Z","steps":["trace[1988616852] 'process raft request' (duration: 232.502775ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:53:16.083639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.560832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-25T10:53:16.08368Z","caller":"traceutil/trace.go:171","msg":"trace[1768106314] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:20002; }","duration":"194.653914ms","start":"2026-05-25T10:53:15.889015Z","end":"2026-05-25T10:53:16.083669Z","steps":["trace[1768106314] 'agreement among raft nodes before linearized reading' (duration: 194.568263ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:53:16.141779Z","caller":"traceutil/trace.go:171","msg":"trace[1284530340] transaction","detail":"{read_only:false; response_revision:20003; number_of_response:1; }","duration":"227.574779ms","start":"2026-05-25T10:53:15.914179Z","end":"2026-05-25T10:53:16.141753Z","steps":["trace[1284530340] 'process raft request' (duration: 227.407766ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:53:16.281594Z","caller":"traceutil/trace.go:171","msg":"trace[2064414669] transaction","detail":"{read_only:false; response_revision:20004; number_of_response:1; }","duration":"110.792425ms","start":"2026-05-25T10:53:16.170785Z","end":"2026-05-25T10:53:16.281577Z","steps":["trace[2064414669] 'process raft request' (duration: 109.10205ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:53:29.729363Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17995} {"level":"info","ts":"2026-05-25T10:53:29.848653Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17995,"took":"115.750031ms","hash":347239884,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":29356032,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-25T10:53:29.848732Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":347239884,"revision":17995,"compact-revision":15445} {"level":"warn","ts":"2026-05-25T10:56:58.063969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.031792ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-25T10:56:58.064194Z","caller":"traceutil/trace.go:171","msg":"trace[136750645] transaction","detail":"{read_only:false; response_revision:22363; number_of_response:1; }","duration":"371.501239ms","start":"2026-05-25T10:56:57.692668Z","end":"2026-05-25T10:56:58.064169Z","steps":["trace[136750645] 'process raft request' (duration: 58.178782ms)","trace[136750645] 'compare' (duration: 312.905308ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:56:58.064308Z","caller":"traceutil/trace.go:171","msg":"trace[627958177] transaction","detail":"{read_only:false; response_revision:22368; number_of_response:1; }","duration":"148.866458ms","start":"2026-05-25T10:56:57.915422Z","end":"2026-05-25T10:56:58.064288Z","steps":["trace[627958177] 'process raft request' (duration: 148.815347ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:56:58.064358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:56:57.692623Z","time spent":"371.644282ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T10:56:58.064539Z","caller":"traceutil/trace.go:171","msg":"trace[305843549] transaction","detail":"{read_only:false; response_revision:22367; number_of_response:1; }","duration":"312.081411ms","start":"2026-05-25T10:56:57.752433Z","end":"2026-05-25T10:56:58.064515Z","steps":["trace[305843549] 'process raft request' (duration: 311.771405ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:56:58.064545Z","caller":"traceutil/trace.go:171","msg":"trace[262406076] transaction","detail":"{read_only:false; response_revision:22365; number_of_response:1; }","duration":"371.266584ms","start":"2026-05-25T10:56:57.693236Z","end":"2026-05-25T10:56:58.064502Z","steps":["trace[262406076] 'process raft request' (duration: 370.896236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:56:58.064643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:56:57.752411Z","time spent":"312.181854ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T10:56:58.064627Z","caller":"traceutil/trace.go:171","msg":"trace[353726460] transaction","detail":"{read_only:false; response_revision:22364; number_of_response:1; }","duration":"371.389457ms","start":"2026-05-25T10:56:57.693163Z","end":"2026-05-25T10:56:58.064552Z","steps":["trace[353726460] 'process raft request' (duration: 370.912177ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:56:58.064718Z","caller":"traceutil/trace.go:171","msg":"trace[835088773] transaction","detail":"{read_only:false; response_revision:22366; number_of_response:1; }","duration":"370.16398ms","start":"2026-05-25T10:56:57.694459Z","end":"2026-05-25T10:56:58.064623Z","steps":["trace[835088773] 'process raft request' (duration: 369.70796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:56:58.064952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:56:57.693148Z","time spent":"371.623462ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T10:56:58.065044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:56:57.694447Z","time spent":"370.452606ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T10:56:58.0655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:56:57.693228Z","time spent":"371.487789ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T10:56:58.135712Z","caller":"traceutil/trace.go:171","msg":"trace[1008851921] transaction","detail":"{read_only:false; response_revision:22369; number_of_response:1; }","duration":"152.049335ms","start":"2026-05-25T10:56:57.983614Z","end":"2026-05-25T10:56:58.135663Z","steps":["trace[1008851921] 'process raft request' (duration: 151.799169ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:58:29.736441Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20074} {"level":"info","ts":"2026-05-25T10:58:29.841628Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20074,"took":"101.183643ms","hash":2581178479,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":41586688,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-05-25T10:58:29.8417Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2581178479,"revision":20074,"compact-revision":17995} {"level":"info","ts":"2026-05-25T11:00:16.701431Z","caller":"traceutil/trace.go:171","msg":"trace[396200118] transaction","detail":"{read_only:false; response_revision:24455; number_of_response:1; }","duration":"101.976149ms","start":"2026-05-25T11:00:16.599431Z","end":"2026-05-25T11:00:16.701407Z","steps":["trace[396200118] 'process raft request' (duration: 55.752807ms)","trace[396200118] 'compare' (duration: 45.949947ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:19.079858Z","caller":"traceutil/trace.go:171","msg":"trace[546599013] linearizableReadLoop","detail":"{readStateIndex:25260; appliedIndex:25259; }","duration":"101.866237ms","start":"2026-05-25T11:00:18.977957Z","end":"2026-05-25T11:00:19.079824Z","steps":["trace[546599013] 'read index received' (duration: 75.261805ms)","trace[546599013] 'applied index is now lower than readState.Index' (duration: 26.602852ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:19.079908Z","caller":"traceutil/trace.go:171","msg":"trace[935502990] transaction","detail":"{read_only:false; response_revision:24471; number_of_response:1; }","duration":"141.235132ms","start":"2026-05-25T11:00:18.938634Z","end":"2026-05-25T11:00:19.079869Z","steps":["trace[935502990] 'process raft request' (duration: 114.601319ms)","trace[935502990] 'compare' (duration: 26.078281ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:19.080142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.169593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:00:19.080233Z","caller":"traceutil/trace.go:171","msg":"trace[481710912] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:24471; }","duration":"102.276485ms","start":"2026-05-25T11:00:18.977939Z","end":"2026-05-25T11:00:19.080215Z","steps":["trace[481710912] 'agreement among raft nodes before linearized reading' (duration: 101.999179ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:19.404273Z","caller":"traceutil/trace.go:171","msg":"trace[1501869126] linearizableReadLoop","detail":"{readStateIndex:25264; appliedIndex:25261; }","duration":"129.165603ms","start":"2026-05-25T11:00:19.275087Z","end":"2026-05-25T11:00:19.404252Z","steps":["trace[1501869126] 'read index received' (duration: 118.629597ms)","trace[1501869126] 'applied index is now lower than readState.Index' (duration: 10.535006ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:19.404326Z","caller":"traceutil/trace.go:171","msg":"trace[1002569791] transaction","detail":"{read_only:false; response_revision:24473; number_of_response:1; }","duration":"319.111092ms","start":"2026-05-25T11:00:19.08516Z","end":"2026-05-25T11:00:19.404271Z","steps":["trace[1002569791] 'process raft request' (duration: 308.628966ms)","trace[1002569791] 'compare' (duration: 10.022086ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:19.404525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.429578ms","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-25T11:00:19.404573Z","caller":"traceutil/trace.go:171","msg":"trace[1777686616] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24475; }","duration":"129.531971ms","start":"2026-05-25T11:00:19.275028Z","end":"2026-05-25T11:00:19.40456Z","steps":["trace[1777686616] 'agreement among raft nodes before linearized reading' (duration: 129.376517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:19.404568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:19.085139Z","time spent":"319.298476ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:00:19.404393Z","caller":"traceutil/trace.go:171","msg":"trace[1709102503] transaction","detail":"{read_only:false; response_revision:24474; number_of_response:1; }","duration":"318.402077ms","start":"2026-05-25T11:00:19.085979Z","end":"2026-05-25T11:00:19.404381Z","steps":["trace[1709102503] 'process raft request' (duration: 318.184852ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:19.404774Z","caller":"traceutil/trace.go:171","msg":"trace[1633622863] transaction","detail":"{read_only:false; response_revision:24475; number_of_response:1; }","duration":"318.276484ms","start":"2026-05-25T11:00:19.086487Z","end":"2026-05-25T11:00:19.404764Z","steps":["trace[1633622863] 'process raft request' (duration: 317.728482ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:19.404857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:19.086479Z","time spent":"318.319235ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:00:19.404861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:19.085961Z","time spent":"318.824005ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:00:19.562091Z","caller":"traceutil/trace.go:171","msg":"trace[381840200] linearizableReadLoop","detail":"{readStateIndex:25265; appliedIndex:25264; }","duration":"151.815759ms","start":"2026-05-25T11:00:19.410251Z","end":"2026-05-25T11:00:19.562067Z","steps":["trace[381840200] 'read index received' (duration: 148.949418ms)","trace[381840200] 'applied index is now lower than readState.Index' (duration: 2.865061ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:19.562316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.040204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:00:19.562397Z","caller":"traceutil/trace.go:171","msg":"trace[2142469801] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24476; }","duration":"152.151587ms","start":"2026-05-25T11:00:19.410227Z","end":"2026-05-25T11:00:19.562378Z","steps":["trace[2142469801] 'agreement among raft nodes before linearized reading' (duration: 152.013154ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:19.562336Z","caller":"traceutil/trace.go:171","msg":"trace[968207221] transaction","detail":"{read_only:false; response_revision:24476; number_of_response:1; }","duration":"152.398791ms","start":"2026-05-25T11:00:19.409857Z","end":"2026-05-25T11:00:19.562256Z","steps":["trace[968207221] 'process raft request' (duration: 149.437838ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:19.799683Z","caller":"traceutil/trace.go:171","msg":"trace[1102584695] transaction","detail":"{read_only:false; response_revision:24478; number_of_response:1; }","duration":"149.252714ms","start":"2026-05-25T11:00:19.650404Z","end":"2026-05-25T11:00:19.799657Z","steps":["trace[1102584695] 'process raft request' (duration: 146.928464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:22.828843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.753385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:00:22.828916Z","caller":"traceutil/trace.go:171","msg":"trace[817821156] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:24518; }","duration":"163.875658ms","start":"2026-05-25T11:00:22.665022Z","end":"2026-05-25T11:00:22.828898Z","steps":["trace[817821156] 'count revisions from in-memory index tree' (duration: 163.666434ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:23.127592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.845676ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-05-25T11:00:23.291193Z","caller":"traceutil/trace.go:171","msg":"trace[972908710] linearizableReadLoop","detail":"{readStateIndex:25310; appliedIndex:25309; }","duration":"163.51967ms","start":"2026-05-25T11:00:23.127652Z","end":"2026-05-25T11:00:23.291172Z","steps":["trace[972908710] 'read index received' (duration: 152.926103ms)","trace[972908710] 'applied index is now lower than readState.Index' (duration: 10.592637ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:23.291553Z","caller":"traceutil/trace.go:171","msg":"trace[272348934] transaction","detail":"{read_only:false; response_revision:24520; number_of_response:1; }","duration":"200.347481ms","start":"2026-05-25T11:00:23.091197Z","end":"2026-05-25T11:00:23.291545Z","steps":["trace[272348934] 'process raft request' (duration: 189.383976ms)","trace[272348934] 'compare' (duration: 10.329782ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:23.291745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.28589ms","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-25T11:00:23.291769Z","caller":"traceutil/trace.go:171","msg":"trace[79751115] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24520; }","duration":"166.322751ms","start":"2026-05-25T11:00:23.125438Z","end":"2026-05-25T11:00:23.291761Z","steps":["trace[79751115] 'agreement among raft nodes before linearized reading' (duration: 166.218588ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:23.291918Z","caller":"traceutil/trace.go:171","msg":"trace[360407169] transaction","detail":"{read_only:false; response_revision:24521; number_of_response:1; }","duration":"162.928029ms","start":"2026-05-25T11:00:23.128982Z","end":"2026-05-25T11:00:23.29191Z","steps":["trace[360407169] 'process raft request' (duration: 162.723973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:23.291966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.815066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:00:23.292054Z","caller":"traceutil/trace.go:171","msg":"trace[2066889830] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24521; }","duration":"162.941869ms","start":"2026-05-25T11:00:23.129092Z","end":"2026-05-25T11:00:23.292033Z","steps":["trace[2066889830] 'agreement among raft nodes before linearized reading' (duration: 162.792625ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:33.805285Z","caller":"traceutil/trace.go:171","msg":"trace[801619504] transaction","detail":"{read_only:false; response_revision:24610; number_of_response:1; }","duration":"139.920365ms","start":"2026-05-25T11:00:33.665341Z","end":"2026-05-25T11:00:33.805261Z","steps":["trace[801619504] 'process raft request' (duration: 139.428815ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:33.989594Z","caller":"traceutil/trace.go:171","msg":"trace[1207062489] transaction","detail":"{read_only:false; response_revision:24613; number_of_response:1; }","duration":"133.494606ms","start":"2026-05-25T11:00:33.856078Z","end":"2026-05-25T11:00:33.989572Z","steps":["trace[1207062489] 'process raft request' (duration: 133.248201ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:33.989773Z","caller":"traceutil/trace.go:171","msg":"trace[1146865192] transaction","detail":"{read_only:false; response_revision:24611; number_of_response:1; }","duration":"144.40743ms","start":"2026-05-25T11:00:33.845355Z","end":"2026-05-25T11:00:33.989763Z","steps":["trace[1146865192] 'process raft request' (duration: 135.472438ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:33.989596Z","caller":"traceutil/trace.go:171","msg":"trace[15580749] transaction","detail":"{read_only:false; response_revision:24612; number_of_response:1; }","duration":"133.855795ms","start":"2026-05-25T11:00:33.855714Z","end":"2026-05-25T11:00:33.98957Z","steps":["trace[15580749] 'process raft request' (duration: 133.542788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:34.248262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.312611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:00:34.248323Z","caller":"traceutil/trace.go:171","msg":"trace[1277232231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24614; }","duration":"159.411863ms","start":"2026-05-25T11:00:34.088899Z","end":"2026-05-25T11:00:34.24831Z","steps":["trace[1277232231] 'range keys from in-memory index tree' (duration: 159.212008ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:37.506181Z","caller":"traceutil/trace.go:171","msg":"trace[81040227] linearizableReadLoop","detail":"{readStateIndex:25487; appliedIndex:25486; }","duration":"168.508379ms","start":"2026-05-25T11:00:37.337658Z","end":"2026-05-25T11:00:37.506166Z","steps":["trace[81040227] 'read index received' (duration: 168.343375ms)","trace[81040227] 'applied index is now lower than readState.Index' (duration: 164.454µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:37.506283Z","caller":"traceutil/trace.go:171","msg":"trace[1563631006] transaction","detail":"{read_only:false; response_revision:24693; number_of_response:1; }","duration":"172.083395ms","start":"2026-05-25T11:00:37.334174Z","end":"2026-05-25T11:00:37.506258Z","steps":["trace[1563631006] 'process raft request' (duration: 171.869731ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:37.506387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.730754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-05-25T11:00:37.506413Z","caller":"traceutil/trace.go:171","msg":"trace[1222496601] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24693; }","duration":"168.816195ms","start":"2026-05-25T11:00:37.33759Z","end":"2026-05-25T11:00:37.506407Z","steps":["trace[1222496601] 'agreement among raft nodes before linearized reading' (duration: 168.675902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:37.506533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.944336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-05-25T11:00:37.506568Z","caller":"traceutil/trace.go:171","msg":"trace[571413704] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24693; }","duration":"154.023178ms","start":"2026-05-25T11:00:37.352533Z","end":"2026-05-25T11:00:37.506557Z","steps":["trace[571413704] 'agreement among raft nodes before linearized reading' (duration: 153.889815ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:37.65542Z","caller":"traceutil/trace.go:171","msg":"trace[1614155882] transaction","detail":"{read_only:false; response_revision:24695; number_of_response:1; }","duration":"144.176686ms","start":"2026-05-25T11:00:37.511217Z","end":"2026-05-25T11:00:37.655393Z","steps":["trace[1614155882] 'process raft request' (duration: 142.725205ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:37.65572Z","caller":"traceutil/trace.go:171","msg":"trace[1167318496] linearizableReadLoop","detail":"{readStateIndex:25490; appliedIndex:25487; }","duration":"143.583773ms","start":"2026-05-25T11:00:37.51211Z","end":"2026-05-25T11:00:37.655694Z","steps":["trace[1167318496] 'read index received' (duration: 19.840556ms)","trace[1167318496] 'applied index is now lower than readState.Index' (duration: 123.742337ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:37.655769Z","caller":"traceutil/trace.go:171","msg":"trace[821230376] transaction","detail":"{read_only:false; response_revision:24696; number_of_response:1; }","duration":"144.081064ms","start":"2026-05-25T11:00:37.51166Z","end":"2026-05-25T11:00:37.655741Z","steps":["trace[821230376] 'process raft request' (duration: 143.688095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:37.65592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.788957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-05-25T11:00:37.655958Z","caller":"traceutil/trace.go:171","msg":"trace[320622827] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24697; }","duration":"143.863259ms","start":"2026-05-25T11:00:37.512084Z","end":"2026-05-25T11:00:37.655948Z","steps":["trace[320622827] 'agreement among raft nodes before linearized reading' (duration: 143.703486ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:37.655972Z","caller":"traceutil/trace.go:171","msg":"trace[216484955] transaction","detail":"{read_only:false; response_revision:24697; number_of_response:1; }","duration":"143.683885ms","start":"2026-05-25T11:00:37.512279Z","end":"2026-05-25T11:00:37.655963Z","steps":["trace[216484955] 'process raft request' (duration: 143.308627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:37.870876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.442377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-05-25T11:00:37.870982Z","caller":"traceutil/trace.go:171","msg":"trace[1201044594] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24697; }","duration":"113.570869ms","start":"2026-05-25T11:00:37.757381Z","end":"2026-05-25T11:00:37.870952Z","steps":["trace[1201044594] 'range keys from in-memory index tree' (duration: 113.333234ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:38.295008Z","caller":"traceutil/trace.go:171","msg":"trace[1520838010] linearizableReadLoop","detail":"{readStateIndex:25493; appliedIndex:25491; }","duration":"413.788635ms","start":"2026-05-25T11:00:37.881188Z","end":"2026-05-25T11:00:38.294977Z","steps":["trace[1520838010] 'read index received' (duration: 3.527876ms)","trace[1520838010] 'applied index is now lower than readState.Index' (duration: 410.259419ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:38.295197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.990489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fae70f7f-a188-48d3-be7f-fb1aa63a6ec4\" ","response":"range_response_count:1 size:3764"} {"level":"info","ts":"2026-05-25T11:00:38.295191Z","caller":"traceutil/trace.go:171","msg":"trace[1881126791] transaction","detail":"{read_only:false; response_revision:24699; number_of_response:1; }","duration":"414.056441ms","start":"2026-05-25T11:00:37.881091Z","end":"2026-05-25T11:00:38.295147Z","steps":["trace[1881126791] 'process raft request' (duration: 413.709744ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:38.295246Z","caller":"traceutil/trace.go:171","msg":"trace[1858918319] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fae70f7f-a188-48d3-be7f-fb1aa63a6ec4; range_end:; response_count:1; response_revision:24699; }","duration":"414.076562ms","start":"2026-05-25T11:00:37.881157Z","end":"2026-05-25T11:00:38.295234Z","steps":["trace[1858918319] 'agreement among raft nodes before linearized reading' (duration: 413.959129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:38.295287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:37.881136Z","time spent":"414.142763ms","remote":"127.0.0.1:42488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3787,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fae70f7f-a188-48d3-be7f-fb1aa63a6ec4\" "} {"level":"warn","ts":"2026-05-25T11:00:38.295336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:37.881079Z","time spent":"414.178253ms","remote":"127.0.0.1:42488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3746,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:00:38.459704Z","caller":"traceutil/trace.go:171","msg":"trace[2000843964] transaction","detail":"{read_only:false; response_revision:24700; number_of_response:1; }","duration":"453.58052ms","start":"2026-05-25T11:00:38.006095Z","end":"2026-05-25T11:00:38.459676Z","steps":["trace[2000843964] 'process raft request' (duration: 453.285174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:38.459881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:38.006064Z","time spent":"453.728702ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":532,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:00:38.45997Z","caller":"traceutil/trace.go:171","msg":"trace[67309096] transaction","detail":"{read_only:false; response_revision:24701; number_of_response:1; }","duration":"453.754543ms","start":"2026-05-25T11:00:38.006187Z","end":"2026-05-25T11:00:38.459941Z","steps":["trace[67309096] 'process raft request' (duration: 453.399186ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:38.459995Z","caller":"traceutil/trace.go:171","msg":"trace[83892238] linearizableReadLoop","detail":"{readStateIndex:25497; appliedIndex:25493; }","duration":"164.88886ms","start":"2026-05-25T11:00:38.295084Z","end":"2026-05-25T11:00:38.459973Z","steps":["trace[83892238] 'read index received' (duration: 164.39056ms)","trace[83892238] 'applied index is now lower than readState.Index' (duration: 497.36µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:38.460091Z","caller":"traceutil/trace.go:171","msg":"trace[1828624076] transaction","detail":"{read_only:false; response_revision:24703; number_of_response:1; }","duration":"453.661011ms","start":"2026-05-25T11:00:38.006391Z","end":"2026-05-25T11:00:38.460052Z","steps":["trace[1828624076] 'process raft request' (duration: 453.532188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:38.460115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:38.006163Z","time spent":"453.870075ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:00:38.460199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:38.006377Z","time spent":"453.771424ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:00:38.46024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.156839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"warn","ts":"2026-05-25T11:00:38.460225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.159999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3236"} {"level":"info","ts":"2026-05-25T11:00:38.460253Z","caller":"traceutil/trace.go:171","msg":"trace[1107765555] transaction","detail":"{read_only:false; response_revision:24702; number_of_response:1; }","duration":"453.959198ms","start":"2026-05-25T11:00:38.006277Z","end":"2026-05-25T11:00:38.460237Z","steps":["trace[1107765555] 'process raft request' (duration: 453.540189ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:38.460277Z","caller":"traceutil/trace.go:171","msg":"trace[2122356407] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:24703; }","duration":"514.248551ms","start":"2026-05-25T11:00:37.946017Z","end":"2026-05-25T11:00:38.460265Z","steps":["trace[2122356407] 'agreement among raft nodes before linearized reading' (duration: 514.059137ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:38.460294Z","caller":"traceutil/trace.go:171","msg":"trace[407502943] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:24703; }","duration":"513.274602ms","start":"2026-05-25T11:00:37.947001Z","end":"2026-05-25T11:00:38.460276Z","steps":["trace[407502943] 'agreement among raft nodes before linearized reading' (duration: 513.082387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:38.460314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:37.945998Z","time spent":"514.304803ms","remote":"127.0.0.1:42514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":242,"response size":32,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-05-25T11:00:38.460318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:38.006265Z","time spent":"454.022019ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:00:38.460336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:37.946982Z","time spent":"513.345363ms","remote":"127.0.0.1:55094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":3259,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"warn","ts":"2026-05-25T11:00:38.617838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.549009ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-25T11:00:38.618047Z","caller":"traceutil/trace.go:171","msg":"trace[1892678213] linearizableReadLoop","detail":"{readStateIndex:25498; appliedIndex:25497; }","duration":"157.973352ms","start":"2026-05-25T11:00:38.460055Z","end":"2026-05-25T11:00:38.618028Z","steps":["trace[1892678213] 'read index received' (duration: 9.182847ms)","trace[1892678213] 'applied index is now lower than readState.Index' (duration: 148.789445ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:38.618298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.464929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-25T11:00:38.618339Z","caller":"traceutil/trace.go:171","msg":"trace[182564972] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24703; }","duration":"203.550421ms","start":"2026-05-25T11:00:38.414777Z","end":"2026-05-25T11:00:38.618328Z","steps":["trace[182564972] 'agreement among raft nodes before linearized reading' (duration: 203.402308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:38.643085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.060474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-25T11:00:38.643171Z","caller":"traceutil/trace.go:171","msg":"trace[562159793] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:24704; }","duration":"240.208897ms","start":"2026-05-25T11:00:38.402941Z","end":"2026-05-25T11:00:38.64315Z","steps":["trace[562159793] 'agreement among raft nodes before linearized reading' (duration: 215.448336ms)","trace[562159793] 'count revisions from in-memory index tree' (duration: 24.611488ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:38.643636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.869249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1155"} {"level":"info","ts":"2026-05-25T11:00:38.643686Z","caller":"traceutil/trace.go:171","msg":"trace[2067573430] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:24704; }","duration":"170.93777ms","start":"2026-05-25T11:00:38.472733Z","end":"2026-05-25T11:00:38.643671Z","steps":["trace[2067573430] 'agreement among raft nodes before linearized reading' (duration: 145.645397ms)","trace[2067573430] 'range keys from in-memory index tree' (duration: 25.15054ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:38.838347Z","caller":"traceutil/trace.go:171","msg":"trace[2110649504] linearizableReadLoop","detail":"{readStateIndex:25500; appliedIndex:25499; }","duration":"189.474339ms","start":"2026-05-25T11:00:38.648833Z","end":"2026-05-25T11:00:38.838307Z","steps":["trace[2110649504] 'read index received' (duration: 189.271075ms)","trace[2110649504] 'applied index is now lower than readState.Index' (duration: 202.644µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:38.83858Z","caller":"traceutil/trace.go:171","msg":"trace[157756896] transaction","detail":"{read_only:false; response_revision:24705; number_of_response:1; }","duration":"216.042729ms","start":"2026-05-25T11:00:38.622529Z","end":"2026-05-25T11:00:38.838571Z","steps":["trace[157756896] 'process raft request' (duration: 215.63934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:38.838775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.934648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" ","response":"range_response_count:1 size:1258"} {"level":"info","ts":"2026-05-25T11:00:38.838802Z","caller":"traceutil/trace.go:171","msg":"trace[1752291403] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila-nodes; range_end:; response_count:1; response_revision:24705; }","duration":"190.00358ms","start":"2026-05-25T11:00:38.648792Z","end":"2026-05-25T11:00:38.838795Z","steps":["trace[1752291403] 'agreement among raft nodes before linearized reading' (duration: 189.897248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:38.838968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.726443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-manila-server-0.18b2c9f01b9ffcb6\" ","response":"range_response_count:1 size:1010"} {"level":"info","ts":"2026-05-25T11:00:38.839035Z","caller":"traceutil/trace.go:171","msg":"trace[1109187393] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-manila-server-0.18b2c9f01b9ffcb6; range_end:; response_count:1; response_revision:24705; }","duration":"121.831906ms","start":"2026-05-25T11:00:38.717187Z","end":"2026-05-25T11:00:38.839018Z","steps":["trace[1109187393] 'agreement among raft nodes before linearized reading' (duration: 121.645172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:39.242405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.641658ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-25T11:00:39.242504Z","caller":"traceutil/trace.go:171","msg":"trace[1307725144] linearizableReadLoop","detail":"{readStateIndex:25503; appliedIndex:25502; }","duration":"299.192243ms","start":"2026-05-25T11:00:38.943296Z","end":"2026-05-25T11:00:39.242488Z","steps":["trace[1307725144] 'read index received' (duration: 139.323051ms)","trace[1307725144] 'applied index is now lower than readState.Index' (duration: 159.867972ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:39.242611Z","caller":"traceutil/trace.go:171","msg":"trace[1993984207] transaction","detail":"{read_only:false; response_revision:24708; number_of_response:1; }","duration":"301.574424ms","start":"2026-05-25T11:00:38.941019Z","end":"2026-05-25T11:00:39.242594Z","steps":["trace[1993984207] 'process raft request' (duration: 141.656991ms)","trace[1993984207] 'compare' (duration: 159.558816ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:39.242716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:38.941004Z","time spent":"301.648347ms","remote":"127.0.0.1:42400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":724,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:00:39.242946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.227006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:00:39.243028Z","caller":"traceutil/trace.go:171","msg":"trace[681778527] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24708; }","duration":"198.356879ms","start":"2026-05-25T11:00:39.044649Z","end":"2026-05-25T11:00:39.243006Z","steps":["trace[681778527] 'agreement among raft nodes before linearized reading' (duration: 198.227285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:39.243169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.872468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9602"} {"level":"warn","ts":"2026-05-25T11:00:39.243171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.512358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:00:39.243219Z","caller":"traceutil/trace.go:171","msg":"trace[567490566] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:24708; }","duration":"299.95265ms","start":"2026-05-25T11:00:38.943251Z","end":"2026-05-25T11:00:39.243204Z","steps":["trace[567490566] 'agreement among raft nodes before linearized reading' (duration: 299.811657ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:39.243261Z","caller":"traceutil/trace.go:171","msg":"trace[887944887] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:24708; }","duration":"195.631121ms","start":"2026-05-25T11:00:39.047607Z","end":"2026-05-25T11:00:39.243238Z","steps":["trace[887944887] 'agreement among raft nodes before linearized reading' (duration: 195.495528ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:39.243267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:38.943235Z","time spent":"300.019471ms","remote":"127.0.0.1:42754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":9625,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" "} {"level":"warn","ts":"2026-05-25T11:00:39.518303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.363571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-25T11:00:39.518422Z","caller":"traceutil/trace.go:171","msg":"trace[116002652] linearizableReadLoop","detail":"{readStateIndex:25504; appliedIndex:25503; }","duration":"260.858642ms","start":"2026-05-25T11:00:39.257547Z","end":"2026-05-25T11:00:39.518405Z","steps":["trace[116002652] 'read index received' (duration: 129.225995ms)","trace[116002652] 'applied index is now lower than readState.Index' (duration: 131.630997ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:39.51851Z","caller":"traceutil/trace.go:171","msg":"trace[697585801] transaction","detail":"{read_only:false; response_revision:24709; number_of_response:1; }","duration":"269.596108ms","start":"2026-05-25T11:00:39.24888Z","end":"2026-05-25T11:00:39.518476Z","steps":["trace[697585801] 'process raft request' (duration: 137.943341ms)","trace[697585801] 'compare' (duration: 131.036894ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:39.518796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.25099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9602"} {"level":"info","ts":"2026-05-25T11:00:39.518828Z","caller":"traceutil/trace.go:171","msg":"trace[451580980] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:24709; }","duration":"261.2836ms","start":"2026-05-25T11:00:39.257534Z","end":"2026-05-25T11:00:39.518818Z","steps":["trace[451580980] 'agreement among raft nodes before linearized reading' (duration: 261.150278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:39.804657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.520146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-25T11:00:39.804869Z","caller":"traceutil/trace.go:171","msg":"trace[1862263626] linearizableReadLoop","detail":"{readStateIndex:25505; appliedIndex:25504; }","duration":"286.365578ms","start":"2026-05-25T11:00:39.518448Z","end":"2026-05-25T11:00:39.804813Z","steps":["trace[1862263626] 'read index received' (duration: 125.570966ms)","trace[1862263626] 'applied index is now lower than readState.Index' (duration: 160.793032ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:39.80523Z","caller":"traceutil/trace.go:171","msg":"trace[1082664288] transaction","detail":"{read_only:false; response_revision:24710; number_of_response:1; }","duration":"293.501803ms","start":"2026-05-25T11:00:39.511713Z","end":"2026-05-25T11:00:39.805214Z","steps":["trace[1082664288] 'process raft request' (duration: 132.314772ms)","trace[1082664288] 'compare' (duration: 160.276181ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:39.805436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.929845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-manila.18b2c9f023a99a30\" ","response":"range_response_count:1 size:747"} {"level":"info","ts":"2026-05-25T11:00:39.805499Z","caller":"traceutil/trace.go:171","msg":"trace[1288888287] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-manila.18b2c9f023a99a30; range_end:; response_count:1; response_revision:24710; }","duration":"283.014927ms","start":"2026-05-25T11:00:39.522467Z","end":"2026-05-25T11:00:39.805481Z","steps":["trace[1288888287] 'agreement among raft nodes before linearized reading' (duration: 282.825823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:39.805668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.239546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-25T11:00:39.805692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.171996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-05-25T11:00:39.805708Z","caller":"traceutil/trace.go:171","msg":"trace[568113118] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24710; }","duration":"191.307228ms","start":"2026-05-25T11:00:39.61439Z","end":"2026-05-25T11:00:39.805697Z","steps":["trace[568113118] 'agreement among raft nodes before linearized reading' (duration: 191.246767ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:39.805728Z","caller":"traceutil/trace.go:171","msg":"trace[1441579193] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24710; }","duration":"145.260868ms","start":"2026-05-25T11:00:39.660456Z","end":"2026-05-25T11:00:39.805717Z","steps":["trace[1441579193] 'agreement among raft nodes before linearized reading' (duration: 145.151676ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:39.805932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.453307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fae70f7f-a188-48d3-be7f-fb1aa63a6ec4\" ","response":"range_response_count:1 size:3764"} {"level":"warn","ts":"2026-05-25T11:00:39.805939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.753152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-05-25T11:00:39.805965Z","caller":"traceutil/trace.go:171","msg":"trace[2028616430] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fae70f7f-a188-48d3-be7f-fb1aa63a6ec4; range_end:; response_count:1; response_revision:24710; }","duration":"507.485737ms","start":"2026-05-25T11:00:39.298469Z","end":"2026-05-25T11:00:39.805955Z","steps":["trace[2028616430] 'agreement among raft nodes before linearized reading' (duration: 507.392105ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:39.805989Z","caller":"traceutil/trace.go:171","msg":"trace[346998995] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24710; }","duration":"269.849345ms","start":"2026-05-25T11:00:39.53613Z","end":"2026-05-25T11:00:39.80598Z","steps":["trace[346998995] 'agreement among raft nodes before linearized reading' (duration: 269.739001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:39.805993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:39.298422Z","time spent":"507.56418ms","remote":"127.0.0.1:42488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3787,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fae70f7f-a188-48d3-be7f-fb1aa63a6ec4\" "} {"level":"warn","ts":"2026-05-25T11:00:39.806167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.263618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-25T11:00:39.806199Z","caller":"traceutil/trace.go:171","msg":"trace[364033583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24710; }","duration":"143.303358ms","start":"2026-05-25T11:00:39.662886Z","end":"2026-05-25T11:00:39.806189Z","steps":["trace[364033583] 'agreement among raft nodes before linearized reading' (duration: 143.224086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:39.806389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.639456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-25T11:00:39.806429Z","caller":"traceutil/trace.go:171","msg":"trace[367978419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24710; }","duration":"144.703888ms","start":"2026-05-25T11:00:39.661717Z","end":"2026-05-25T11:00:39.80642Z","steps":["trace[367978419] 'agreement among raft nodes before linearized reading' (duration: 144.616516ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:40.094306Z","caller":"traceutil/trace.go:171","msg":"trace[1587526705] transaction","detail":"{read_only:false; response_revision:24712; number_of_response:1; }","duration":"280.8142ms","start":"2026-05-25T11:00:39.813468Z","end":"2026-05-25T11:00:40.094282Z","steps":["trace[1587526705] 'process raft request' (duration: 238.051661ms)","trace[1587526705] 'compare' (duration: 42.540564ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:40.09431Z","caller":"traceutil/trace.go:171","msg":"trace[642114830] transaction","detail":"{read_only:false; response_revision:24713; number_of_response:1; }","duration":"280.282769ms","start":"2026-05-25T11:00:39.814005Z","end":"2026-05-25T11:00:40.094288Z","steps":["trace[642114830] 'process raft request' (duration: 280.202497ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:40.094494Z","caller":"traceutil/trace.go:171","msg":"trace[1257480287] transaction","detail":"{read_only:false; response_revision:24714; number_of_response:1; }","duration":"279.986672ms","start":"2026-05-25T11:00:39.814494Z","end":"2026-05-25T11:00:40.094481Z","steps":["trace[1257480287] 'process raft request' (duration: 279.754517ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:40.094659Z","caller":"traceutil/trace.go:171","msg":"trace[1450036946] linearizableReadLoop","detail":"{readStateIndex:25507; appliedIndex:25506; }","duration":"280.906273ms","start":"2026-05-25T11:00:39.813728Z","end":"2026-05-25T11:00:40.094635Z","steps":["trace[1450036946] 'read index received' (duration: 57.23529ms)","trace[1450036946] 'applied index is now lower than readState.Index' (duration: 223.670123ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:40.094688Z","caller":"traceutil/trace.go:171","msg":"trace[1442021000] transaction","detail":"{read_only:false; response_revision:24715; number_of_response:1; }","duration":"277.646113ms","start":"2026-05-25T11:00:39.817021Z","end":"2026-05-25T11:00:40.094667Z","steps":["trace[1442021000] 'process raft request' (duration: 277.408627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:40.094799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.053016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:00:40.094832Z","caller":"traceutil/trace.go:171","msg":"trace[62050982] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24715; }","duration":"281.134068ms","start":"2026-05-25T11:00:39.813688Z","end":"2026-05-25T11:00:40.094822Z","steps":["trace[62050982] 'agreement among raft nodes before linearized reading' (duration: 281.062476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:40.094876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.751549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-05-25T11:00:40.094938Z","caller":"traceutil/trace.go:171","msg":"trace[1923944586] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24715; }","duration":"205.849201ms","start":"2026-05-25T11:00:39.889074Z","end":"2026-05-25T11:00:40.094923Z","steps":["trace[1923944586] 'agreement among raft nodes before linearized reading' (duration: 205.710618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:40.345499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.816258ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-25T11:00:40.345614Z","caller":"traceutil/trace.go:171","msg":"trace[65798799] transaction","detail":"{read_only:false; response_revision:24716; number_of_response:1; }","duration":"234.739101ms","start":"2026-05-25T11:00:40.110855Z","end":"2026-05-25T11:00:40.345594Z","steps":["trace[65798799] 'process raft request' (duration: 124.740729ms)","trace[65798799] 'compare' (duration: 109.691715ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:40.615731Z","caller":"traceutil/trace.go:171","msg":"trace[1312936119] transaction","detail":"{read_only:false; response_revision:24717; number_of_response:1; }","duration":"144.015383ms","start":"2026-05-25T11:00:40.471694Z","end":"2026-05-25T11:00:40.615709Z","steps":["trace[1312936119] 'process raft request' (duration: 143.863109ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:40.762852Z","caller":"traceutil/trace.go:171","msg":"trace[37120065] transaction","detail":"{read_only:false; response_revision:24721; number_of_response:1; }","duration":"175.309715ms","start":"2026-05-25T11:00:40.58752Z","end":"2026-05-25T11:00:40.76283Z","steps":["trace[37120065] 'process raft request' (duration: 175.264494ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:40.763231Z","caller":"traceutil/trace.go:171","msg":"trace[623910444] transaction","detail":"{read_only:false; response_revision:24718; number_of_response:1; }","duration":"291.012759ms","start":"2026-05-25T11:00:40.472206Z","end":"2026-05-25T11:00:40.763219Z","steps":["trace[623910444] 'process raft request' (duration: 290.364196ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:40.763357Z","caller":"traceutil/trace.go:171","msg":"trace[865808249] transaction","detail":"{read_only:false; response_revision:24719; number_of_response:1; }","duration":"291.090111ms","start":"2026-05-25T11:00:40.472257Z","end":"2026-05-25T11:00:40.763347Z","steps":["trace[865808249] 'process raft request' (duration: 290.448378ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:40.763525Z","caller":"traceutil/trace.go:171","msg":"trace[374708523] transaction","detail":"{read_only:false; response_revision:24720; number_of_response:1; }","duration":"290.332194ms","start":"2026-05-25T11:00:40.473182Z","end":"2026-05-25T11:00:40.763514Z","steps":["trace[374708523] 'process raft request' (duration: 289.566597ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:40.782591Z","caller":"traceutil/trace.go:171","msg":"trace[2109943045] transaction","detail":"{read_only:false; response_revision:24722; number_of_response:1; }","duration":"159.384863ms","start":"2026-05-25T11:00:40.623165Z","end":"2026-05-25T11:00:40.782549Z","steps":["trace[2109943045] 'process raft request' (duration: 159.206959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:41.206671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.847562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-25T11:00:41.206805Z","caller":"traceutil/trace.go:171","msg":"trace[1375743695] linearizableReadLoop","detail":"{readStateIndex:25519; appliedIndex:25517; }","duration":"159.608638ms","start":"2026-05-25T11:00:41.047186Z","end":"2026-05-25T11:00:41.206795Z","steps":["trace[1375743695] 'read index received' (duration: 13.373747ms)","trace[1375743695] 'applied index is now lower than readState.Index' (duration: 146.234351ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:41.20689Z","caller":"traceutil/trace.go:171","msg":"trace[1330187293] transaction","detail":"{read_only:false; response_revision:24724; number_of_response:1; }","duration":"261.139079ms","start":"2026-05-25T11:00:40.945742Z","end":"2026-05-25T11:00:41.206881Z","steps":["trace[1330187293] 'process raft request' (duration: 260.995956ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:41.206912Z","caller":"traceutil/trace.go:171","msg":"trace[1482995469] transaction","detail":"{read_only:false; response_revision:24723; number_of_response:1; }","duration":"360.268417ms","start":"2026-05-25T11:00:40.846609Z","end":"2026-05-25T11:00:41.206878Z","steps":["trace[1482995469] 'process raft request' (duration: 98.155078ms)","trace[1482995469] 'compare' (duration: 261.584376ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:41.207029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:40.846594Z","time spent":"360.379699ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:00:41.207078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.897243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:00:41.207096Z","caller":"traceutil/trace.go:171","msg":"trace[1012892793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24724; }","duration":"159.966695ms","start":"2026-05-25T11:00:41.047124Z","end":"2026-05-25T11:00:41.207091Z","steps":["trace[1012892793] 'agreement among raft nodes before linearized reading' (duration: 159.700209ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:42.251193Z","caller":"traceutil/trace.go:171","msg":"trace[322419970] linearizableReadLoop","detail":"{readStateIndex:25520; appliedIndex:25519; }","duration":"436.038192ms","start":"2026-05-25T11:00:41.815129Z","end":"2026-05-25T11:00:42.251168Z","steps":["trace[322419970] 'read index received' (duration: 435.874588ms)","trace[322419970] 'applied index is now lower than readState.Index' (duration: 162.494µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:42.251249Z","caller":"traceutil/trace.go:171","msg":"trace[1582692563] transaction","detail":"{read_only:false; response_revision:24725; number_of_response:1; }","duration":"437.515264ms","start":"2026-05-25T11:00:41.813699Z","end":"2026-05-25T11:00:42.251214Z","steps":["trace[1582692563] 'process raft request' (duration: 437.309229ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:42.251398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:41.81368Z","time spent":"437.638927ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:00:42.251655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.472072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fae70f7f-a188-48d3-be7f-fb1aa63a6ec4\" ","response":"range_response_count:1 size:3764"} {"level":"info","ts":"2026-05-25T11:00:42.251788Z","caller":"traceutil/trace.go:171","msg":"trace[1320282860] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fae70f7f-a188-48d3-be7f-fb1aa63a6ec4; range_end:; response_count:1; response_revision:24725; }","duration":"436.632925ms","start":"2026-05-25T11:00:41.815124Z","end":"2026-05-25T11:00:42.251757Z","steps":["trace[1320282860] 'agreement among raft nodes before linearized reading' (duration: 436.161034ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:42.251873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:41.815089Z","time spent":"436.773709ms","remote":"127.0.0.1:42488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3787,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fae70f7f-a188-48d3-be7f-fb1aa63a6ec4\" "} {"level":"warn","ts":"2026-05-25T11:00:42.779352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.270683ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-25T11:00:42.779565Z","caller":"traceutil/trace.go:171","msg":"trace[283871534] transaction","detail":"{read_only:false; response_revision:24727; number_of_response:1; }","duration":"259.222447ms","start":"2026-05-25T11:00:42.520324Z","end":"2026-05-25T11:00:42.779547Z","steps":["trace[283871534] 'process raft request' (duration: 259.151826ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:42.779699Z","caller":"traceutil/trace.go:171","msg":"trace[682427894] linearizableReadLoop","detail":"{readStateIndex:25521; appliedIndex:25520; }","duration":"528.426807ms","start":"2026-05-25T11:00:42.251262Z","end":"2026-05-25T11:00:42.779689Z","steps":["trace[682427894] 'read index received' (duration: 264.725085ms)","trace[682427894] 'applied index is now lower than readState.Index' (duration: 263.700622ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:42.779701Z","caller":"traceutil/trace.go:171","msg":"trace[278167611] transaction","detail":"{read_only:false; response_revision:24726; number_of_response:1; }","duration":"613.288829ms","start":"2026-05-25T11:00:42.166345Z","end":"2026-05-25T11:00:42.779634Z","steps":["trace[278167611] 'process raft request' (duration: 349.659998ms)","trace[278167611] 'compare' (duration: 262.982007ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:00:42.779841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.414802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-05-25T11:00:42.779873Z","caller":"traceutil/trace.go:171","msg":"trace[655042062] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24727; }","duration":"681.447723ms","start":"2026-05-25T11:00:42.098414Z","end":"2026-05-25T11:00:42.779862Z","steps":["trace[655042062] 'agreement among raft nodes before linearized reading' (duration: 681.33077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:42.77991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.098369Z","time spent":"681.532695ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-25T11:00:42.77998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.023064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-05-25T11:00:42.780045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.95905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-05-25T11:00:42.780077Z","caller":"traceutil/trace.go:171","msg":"trace[1903575307] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24727; }","duration":"890.034892ms","start":"2026-05-25T11:00:41.890033Z","end":"2026-05-25T11:00:42.780068Z","steps":["trace[1903575307] 'agreement among raft nodes before linearized reading' (duration: 889.94914ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:42.780085Z","caller":"traceutil/trace.go:171","msg":"trace[1389303181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24727; }","duration":"681.150096ms","start":"2026-05-25T11:00:42.098915Z","end":"2026-05-25T11:00:42.780065Z","steps":["trace[1389303181] 'agreement among raft nodes before linearized reading' (duration: 680.797279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:42.780108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:41.890009Z","time spent":"890.093063ms","remote":"127.0.0.1:42422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":380,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"warn","ts":"2026-05-25T11:00:42.780157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.098908Z","time spent":"681.209617ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-25T11:00:42.780176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.832079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-05-25T11:00:42.780229Z","caller":"traceutil/trace.go:171","msg":"trace[1750130405] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24727; }","duration":"680.89803ms","start":"2026-05-25T11:00:42.099319Z","end":"2026-05-25T11:00:42.780217Z","steps":["trace[1750130405] 'agreement among raft nodes before linearized reading' (duration: 680.763047ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:42.780269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.099312Z","time spent":"680.949732ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-25T11:00:42.780277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.262258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-25T11:00:42.780313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"897.319668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18572"} {"level":"info","ts":"2026-05-25T11:00:42.780408Z","caller":"traceutil/trace.go:171","msg":"trace[2006572021] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:24727; }","duration":"897.463551ms","start":"2026-05-25T11:00:41.882931Z","end":"2026-05-25T11:00:42.780394Z","steps":["trace[2006572021] 'agreement among raft nodes before linearized reading' (duration: 897.194345ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:42.780354Z","caller":"traceutil/trace.go:171","msg":"trace[58202998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24727; }","duration":"681.35077ms","start":"2026-05-25T11:00:42.09899Z","end":"2026-05-25T11:00:42.780341Z","steps":["trace[58202998] 'agreement among raft nodes before linearized reading' (duration: 681.100414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:42.780557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:41.882913Z","time spent":"897.607084ms","remote":"127.0.0.1:42480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":18595,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" "} {"level":"warn","ts":"2026-05-25T11:00:42.780411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.166326Z","time spent":"613.532114ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:00:42.780544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.098986Z","time spent":"681.547764ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-25T11:00:42.859141Z","caller":"traceutil/trace.go:171","msg":"trace[588940023] transaction","detail":"{read_only:false; response_revision:24728; number_of_response:1; }","duration":"273.196226ms","start":"2026-05-25T11:00:42.585918Z","end":"2026-05-25T11:00:42.859114Z","steps":["trace[588940023] 'process raft request' (duration: 273.052253ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:43.098914Z","caller":"traceutil/trace.go:171","msg":"trace[1030017663] linearizableReadLoop","detail":"{readStateIndex:25527; appliedIndex:25522; }","duration":"319.162803ms","start":"2026-05-25T11:00:42.779724Z","end":"2026-05-25T11:00:43.098887Z","steps":["trace[1030017663] 'read index received' (duration: 79.242521ms)","trace[1030017663] 'applied index is now lower than readState.Index' (duration: 239.919132ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:43.099059Z","caller":"traceutil/trace.go:171","msg":"trace[518063032] transaction","detail":"{read_only:false; response_revision:24733; number_of_response:1; }","duration":"313.933131ms","start":"2026-05-25T11:00:42.785111Z","end":"2026-05-25T11:00:43.099044Z","steps":["trace[518063032] 'process raft request' (duration: 313.547103ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.099307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.78508Z","time spent":"314.017043ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:00:43.099351Z","caller":"traceutil/trace.go:171","msg":"trace[1240353250] transaction","detail":"{read_only:false; response_revision:24732; number_of_response:1; }","duration":"326.540903ms","start":"2026-05-25T11:00:42.772459Z","end":"2026-05-25T11:00:43.099Z","steps":["trace[1240353250] 'process raft request' (duration: 326.157864ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.099703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.772433Z","time spent":"327.108494ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:00:43.099609Z","caller":"traceutil/trace.go:171","msg":"trace[808311531] transaction","detail":"{read_only:false; response_revision:24734; number_of_response:1; }","duration":"314.416811ms","start":"2026-05-25T11:00:42.785175Z","end":"2026-05-25T11:00:43.099591Z","steps":["trace[808311531] 'process raft request' (duration: 313.535712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.099995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.78517Z","time spent":"314.767998ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:00:43.100215Z","caller":"traceutil/trace.go:171","msg":"trace[28082382] transaction","detail":"{read_only:false; response_revision:24735; number_of_response:1; }","duration":"313.783358ms","start":"2026-05-25T11:00:42.786415Z","end":"2026-05-25T11:00:43.100198Z","steps":["trace[28082382] 'process raft request' (duration: 312.340407ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.100304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.786403Z","time spent":"313.852349ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:00:43.100426Z","caller":"traceutil/trace.go:171","msg":"trace[776982912] transaction","detail":"{read_only:false; response_revision:24736; number_of_response:1; }","duration":"313.277587ms","start":"2026-05-25T11:00:42.787131Z","end":"2026-05-25T11:00:43.100408Z","steps":["trace[776982912] 'process raft request' (duration: 311.668082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.100506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.787121Z","time spent":"313.344649ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:00:43.100622Z","caller":"traceutil/trace.go:171","msg":"trace[842194268] transaction","detail":"{read_only:false; response_revision:24737; number_of_response:1; }","duration":"312.680725ms","start":"2026-05-25T11:00:42.787928Z","end":"2026-05-25T11:00:43.100608Z","steps":["trace[842194268] 'process raft request' (duration: 310.914696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.100716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.787922Z","time spent":"312.737076ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:00:43.100955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.684738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-05-25T11:00:43.101011Z","caller":"traceutil/trace.go:171","msg":"trace[383413057] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24737; }","duration":"749.78717ms","start":"2026-05-25T11:00:42.351208Z","end":"2026-05-25T11:00:43.100995Z","steps":["trace[383413057] 'agreement among raft nodes before linearized reading' (duration: 749.604246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.101054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.351184Z","time spent":"749.857512ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-05-25T11:00:43.101302Z","caller":"traceutil/trace.go:171","msg":"trace[516009528] transaction","detail":"{read_only:false; response_revision:24730; number_of_response:1; }","duration":"332.253385ms","start":"2026-05-25T11:00:42.769032Z","end":"2026-05-25T11:00:43.101285Z","steps":["trace[516009528] 'process raft request' (duration: 329.510206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.101396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.769001Z","time spent":"332.346946ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:00:43.10161Z","caller":"traceutil/trace.go:171","msg":"trace[50067145] transaction","detail":"{read_only:false; response_revision:24729; number_of_response:1; }","duration":"480.024307ms","start":"2026-05-25T11:00:42.621571Z","end":"2026-05-25T11:00:43.101595Z","steps":["trace[50067145] 'process raft request' (duration: 476.828429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.101695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.62155Z","time spent":"480.102179ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:00:43.101794Z","caller":"traceutil/trace.go:171","msg":"trace[2073439931] transaction","detail":"{read_only:false; response_revision:24731; number_of_response:1; }","duration":"332.681844ms","start":"2026-05-25T11:00:42.769076Z","end":"2026-05-25T11:00:43.101758Z","steps":["trace[2073439931] 'process raft request' (duration: 329.503916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.101832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.247409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.133\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-05-25T11:00:43.101901Z","caller":"traceutil/trace.go:171","msg":"trace[2029289440] range","detail":"{range_begin:/registry/masterleases/199.19.213.133; range_end:; response_count:1; response_revision:24737; }","duration":"199.32094ms","start":"2026-05-25T11:00:42.90256Z","end":"2026-05-25T11:00:43.101881Z","steps":["trace[2029289440] 'agreement among raft nodes before linearized reading' (duration: 199.110426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.101947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.769032Z","time spent":"332.830237ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:00:43.10195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.898746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-05-25T11:00:43.102015Z","caller":"traceutil/trace.go:171","msg":"trace[1547248439] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24737; }","duration":"216.036329ms","start":"2026-05-25T11:00:42.885962Z","end":"2026-05-25T11:00:43.101998Z","steps":["trace[1547248439] 'agreement among raft nodes before linearized reading' (duration: 215.771903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.102057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.227801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-prometheus-stack-kubelet\" ","response":"range_response_count:1 size:1137"} {"level":"info","ts":"2026-05-25T11:00:43.102115Z","caller":"traceutil/trace.go:171","msg":"trace[1319140012] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-prometheus-stack-kubelet; range_end:; response_count:1; response_revision:24737; }","duration":"316.302602ms","start":"2026-05-25T11:00:42.785798Z","end":"2026-05-25T11:00:43.1021Z","steps":["trace[1319140012] 'agreement among raft nodes before linearized reading' (duration: 315.361742ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:43.102181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:00:42.785789Z","time spent":"316.379933ms","remote":"127.0.0.1:42498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":1160,"request content":"key:\"/registry/services/specs/kube-system/kube-prometheus-stack-kubelet\" "} {"level":"info","ts":"2026-05-25T11:00:45.30017Z","caller":"traceutil/trace.go:171","msg":"trace[493181598] transaction","detail":"{read_only:false; response_revision:24745; number_of_response:1; }","duration":"192.238938ms","start":"2026-05-25T11:00:45.10789Z","end":"2026-05-25T11:00:45.300129Z","steps":["trace[493181598] 'process raft request' (duration: 191.911731ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:45.300295Z","caller":"traceutil/trace.go:171","msg":"trace[316233107] transaction","detail":"{read_only:false; response_revision:24746; number_of_response:1; }","duration":"191.764209ms","start":"2026-05-25T11:00:45.108471Z","end":"2026-05-25T11:00:45.300235Z","steps":["trace[316233107] 'process raft request' (duration: 191.576925ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:45.300322Z","caller":"traceutil/trace.go:171","msg":"trace[1809028419] linearizableReadLoop","detail":"{readStateIndex:25541; appliedIndex:25540; }","duration":"192.134017ms","start":"2026-05-25T11:00:45.108155Z","end":"2026-05-25T11:00:45.300289Z","steps":["trace[1809028419] 'read index received' (duration: 52.961648ms)","trace[1809028419] 'applied index is now lower than readState.Index' (duration: 139.171159ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:45.300355Z","caller":"traceutil/trace.go:171","msg":"trace[678940567] transaction","detail":"{read_only:false; response_revision:24748; number_of_response:1; }","duration":"190.270566ms","start":"2026-05-25T11:00:45.110037Z","end":"2026-05-25T11:00:45.300307Z","steps":["trace[678940567] 'process raft request' (duration: 190.137913ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:45.300361Z","caller":"traceutil/trace.go:171","msg":"trace[422518831] transaction","detail":"{read_only:false; response_revision:24747; number_of_response:1; }","duration":"190.323877ms","start":"2026-05-25T11:00:45.109977Z","end":"2026-05-25T11:00:45.300301Z","steps":["trace[422518831] 'process raft request' (duration: 190.137243ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:45.300363Z","caller":"traceutil/trace.go:171","msg":"trace[733561963] transaction","detail":"{read_only:false; response_revision:24749; number_of_response:1; }","duration":"189.822197ms","start":"2026-05-25T11:00:45.110509Z","end":"2026-05-25T11:00:45.300332Z","steps":["trace[733561963] 'process raft request' (duration: 189.717324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:45.30069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.504494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-25T11:00:45.300777Z","caller":"traceutil/trace.go:171","msg":"trace[923356364] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24749; }","duration":"192.638877ms","start":"2026-05-25T11:00:45.108119Z","end":"2026-05-25T11:00:45.300758Z","steps":["trace[923356364] 'agreement among raft nodes before linearized reading' (duration: 192.31446ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:45.349395Z","caller":"traceutil/trace.go:171","msg":"trace[1102804445] transaction","detail":"{read_only:false; response_revision:24750; number_of_response:1; }","duration":"127.980168ms","start":"2026-05-25T11:00:45.221387Z","end":"2026-05-25T11:00:45.349367Z","steps":["trace[1102804445] 'process raft request' (duration: 127.846005ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:45.349815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.709032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-25T11:00:45.349854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.737518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-25T11:00:45.349881Z","caller":"traceutil/trace.go:171","msg":"trace[2107506331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24750; }","duration":"236.790264ms","start":"2026-05-25T11:00:45.113071Z","end":"2026-05-25T11:00:45.349861Z","steps":["trace[2107506331] 'agreement among raft nodes before linearized reading' (duration: 236.59827ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:45.349901Z","caller":"traceutil/trace.go:171","msg":"trace[956140221] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24750; }","duration":"125.838612ms","start":"2026-05-25T11:00:45.224049Z","end":"2026-05-25T11:00:45.349887Z","steps":["trace[956140221] 'agreement among raft nodes before linearized reading' (duration: 125.646097ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:45.349897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.883329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-05-25T11:00:45.349931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.678222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-25T11:00:45.349957Z","caller":"traceutil/trace.go:171","msg":"trace[1895765243] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24750; }","duration":"231.968261ms","start":"2026-05-25T11:00:45.117972Z","end":"2026-05-25T11:00:45.34994Z","steps":["trace[1895765243] 'agreement among raft nodes before linearized reading' (duration: 231.777126ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:45.349987Z","caller":"traceutil/trace.go:171","msg":"trace[514948139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24750; }","duration":"236.751834ms","start":"2026-05-25T11:00:45.113221Z","end":"2026-05-25T11:00:45.349972Z","steps":["trace[514948139] 'agreement among raft nodes before linearized reading' (duration: 236.565979ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:48.271846Z","caller":"traceutil/trace.go:171","msg":"trace[914331356] linearizableReadLoop","detail":"{readStateIndex:25584; appliedIndex:25583; }","duration":"238.056412ms","start":"2026-05-25T11:00:48.033769Z","end":"2026-05-25T11:00:48.271826Z","steps":["trace[914331356] 'read index received' (duration: 237.915828ms)","trace[914331356] 'applied index is now lower than readState.Index' (duration: 139.654µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:48.271954Z","caller":"traceutil/trace.go:171","msg":"trace[1660013732] transaction","detail":"{read_only:false; response_revision:24787; number_of_response:1; }","duration":"250.798416ms","start":"2026-05-25T11:00:48.021126Z","end":"2026-05-25T11:00:48.271924Z","steps":["trace[1660013732] 'process raft request' (duration: 250.538469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:48.272048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.282006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-05-25T11:00:48.272092Z","caller":"traceutil/trace.go:171","msg":"trace[1269417996] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24787; }","duration":"238.378758ms","start":"2026-05-25T11:00:48.0337Z","end":"2026-05-25T11:00:48.272079Z","steps":["trace[1269417996] 'agreement among raft nodes before linearized reading' (duration: 238.247965ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:48.328229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.235275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-05-25T11:00:48.328323Z","caller":"traceutil/trace.go:171","msg":"trace[1129048396] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24788; }","duration":"136.385868ms","start":"2026-05-25T11:00:48.191916Z","end":"2026-05-25T11:00:48.328302Z","steps":["trace[1129048396] 'agreement among raft nodes before linearized reading' (duration: 136.099582ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:48.457695Z","caller":"traceutil/trace.go:171","msg":"trace[1318288691] transaction","detail":"{read_only:false; response_revision:24789; number_of_response:1; }","duration":"181.297833ms","start":"2026-05-25T11:00:48.276358Z","end":"2026-05-25T11:00:48.457656Z","steps":["trace[1318288691] 'process raft request' (duration: 180.951436ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:48.45822Z","caller":"traceutil/trace.go:171","msg":"trace[1918932997] transaction","detail":"{read_only:false; response_revision:24790; number_of_response:1; }","duration":"180.108777ms","start":"2026-05-25T11:00:48.278064Z","end":"2026-05-25T11:00:48.458173Z","steps":["trace[1918932997] 'process raft request' (duration: 179.525095ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:48.45828Z","caller":"traceutil/trace.go:171","msg":"trace[2042197117] transaction","detail":"{read_only:false; response_revision:24791; number_of_response:1; }","duration":"179.158108ms","start":"2026-05-25T11:00:48.279091Z","end":"2026-05-25T11:00:48.45825Z","steps":["trace[2042197117] 'process raft request' (duration: 178.78471ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:48.458362Z","caller":"traceutil/trace.go:171","msg":"trace[1995328606] linearizableReadLoop","detail":"{readStateIndex:25589; appliedIndex:25585; }","duration":"130.365159ms","start":"2026-05-25T11:00:48.327973Z","end":"2026-05-25T11:00:48.458338Z","steps":["trace[1995328606] 'read index received' (duration: 129.509481ms)","trace[1995328606] 'applied index is now lower than readState.Index' (duration: 854.288µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:00:48.458601Z","caller":"traceutil/trace.go:171","msg":"trace[385049822] transaction","detail":"{read_only:false; response_revision:24792; number_of_response:1; }","duration":"178.896782ms","start":"2026-05-25T11:00:48.279601Z","end":"2026-05-25T11:00:48.458498Z","steps":["trace[385049822] 'process raft request' (duration: 178.396801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:00:48.458747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.916359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-fae70f7f-a188-48d3-be7f-fb1aa63a6ec4\" ","response":"range_response_count:1 size:1322"} {"level":"warn","ts":"2026-05-25T11:00:48.458784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.093619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-05-25T11:00:48.458801Z","caller":"traceutil/trace.go:171","msg":"trace[225437481] range","detail":"{range_begin:/registry/persistentvolumes/pvc-fae70f7f-a188-48d3-be7f-fb1aa63a6ec4; range_end:; response_count:1; response_revision:24792; }","duration":"184.001531ms","start":"2026-05-25T11:00:48.274782Z","end":"2026-05-25T11:00:48.458784Z","steps":["trace[225437481] 'agreement among raft nodes before linearized reading' (duration: 183.834607ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:00:48.458842Z","caller":"traceutil/trace.go:171","msg":"trace[913118802] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24792; }","duration":"127.186981ms","start":"2026-05-25T11:00:48.331638Z","end":"2026-05-25T11:00:48.458825Z","steps":["trace[913118802] 'agreement among raft nodes before linearized reading' (duration: 126.962226ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:06.080712Z","caller":"traceutil/trace.go:171","msg":"trace[1411107143] transaction","detail":"{read_only:false; response_revision:24934; number_of_response:1; }","duration":"294.063124ms","start":"2026-05-25T11:01:05.786606Z","end":"2026-05-25T11:01:06.080669Z","steps":["trace[1411107143] 'process raft request' (duration: 293.909821ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:06.258304Z","caller":"traceutil/trace.go:171","msg":"trace[1476660290] linearizableReadLoop","detail":"{readStateIndex:25735; appliedIndex:25734; }","duration":"441.817717ms","start":"2026-05-25T11:01:05.81646Z","end":"2026-05-25T11:01:06.258277Z","steps":["trace[1476660290] 'read index received' (duration: 264.236634ms)","trace[1476660290] 'applied index is now lower than readState.Index' (duration: 177.580233ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:06.258388Z","caller":"traceutil/trace.go:171","msg":"trace[118074870] transaction","detail":"{read_only:false; response_revision:24935; number_of_response:1; }","duration":"457.411341ms","start":"2026-05-25T11:01:05.800944Z","end":"2026-05-25T11:01:06.258355Z","steps":["trace[118074870] 'process raft request' (duration: 441.764406ms)","trace[118074870] 'compare' (duration: 15.438011ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:01:06.258461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.97612ms","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:8"} {"level":"warn","ts":"2026-05-25T11:01:06.258523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:05.800921Z","time spent":"457.523833ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:01:06.258541Z","caller":"traceutil/trace.go:171","msg":"trace[1365004165] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:24935; }","duration":"442.105033ms","start":"2026-05-25T11:01:05.816416Z","end":"2026-05-25T11:01:06.258521Z","steps":["trace[1365004165] 'agreement among raft nodes before linearized reading' (duration: 441.94838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:06.258586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:05.816401Z","time spent":"442.174454ms","remote":"127.0.0.1:40552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":31,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"warn","ts":"2026-05-25T11:01:06.258625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.666318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-25T11:01:06.258633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.390628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3236"} {"level":"info","ts":"2026-05-25T11:01:06.258682Z","caller":"traceutil/trace.go:171","msg":"trace[1622076405] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:24935; }","duration":"435.448869ms","start":"2026-05-25T11:01:05.823221Z","end":"2026-05-25T11:01:06.25867Z","steps":["trace[1622076405] 'agreement among raft nodes before linearized reading' (duration: 435.306026ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:06.258684Z","caller":"traceutil/trace.go:171","msg":"trace[1579257784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24935; }","duration":"213.77486ms","start":"2026-05-25T11:01:06.044889Z","end":"2026-05-25T11:01:06.258664Z","steps":["trace[1579257784] 'agreement among raft nodes before linearized reading' (duration: 213.672208ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:06.258705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:05.823189Z","time spent":"435.512171ms","remote":"127.0.0.1:55094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":3259,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"info","ts":"2026-05-25T11:01:06.519144Z","caller":"traceutil/trace.go:171","msg":"trace[741977996] transaction","detail":"{read_only:false; response_revision:24936; number_of_response:1; }","duration":"127.626699ms","start":"2026-05-25T11:01:06.391283Z","end":"2026-05-25T11:01:06.51891Z","steps":["trace[741977996] 'process raft request' (duration: 127.409495ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:06.790866Z","caller":"traceutil/trace.go:171","msg":"trace[369242758] transaction","detail":"{read_only:false; response_revision:24937; number_of_response:1; }","duration":"238.111943ms","start":"2026-05-25T11:01:06.552716Z","end":"2026-05-25T11:01:06.790828Z","steps":["trace[369242758] 'process raft request' (duration: 231.977472ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:07.476085Z","caller":"traceutil/trace.go:171","msg":"trace[2088352649] transaction","detail":"{read_only:false; response_revision:24938; number_of_response:1; }","duration":"299.368238ms","start":"2026-05-25T11:01:07.176691Z","end":"2026-05-25T11:01:07.47606Z","steps":["trace[2088352649] 'process raft request' (duration: 299.159994ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:07.721332Z","caller":"traceutil/trace.go:171","msg":"trace[1879344598] transaction","detail":"{read_only:false; response_revision:24941; number_of_response:1; }","duration":"345.504708ms","start":"2026-05-25T11:01:07.375799Z","end":"2026-05-25T11:01:07.721303Z","steps":["trace[1879344598] 'process raft request' (duration: 345.424917ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:07.721355Z","caller":"traceutil/trace.go:171","msg":"trace[590044162] transaction","detail":"{read_only:false; response_revision:24939; number_of_response:1; }","duration":"484.410472ms","start":"2026-05-25T11:01:07.236901Z","end":"2026-05-25T11:01:07.721312Z","steps":["trace[590044162] 'process raft request' (duration: 484.097795ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:07.721384Z","caller":"traceutil/trace.go:171","msg":"trace[1214436484] transaction","detail":"{read_only:false; response_revision:24940; number_of_response:1; }","duration":"346.217463ms","start":"2026-05-25T11:01:07.375132Z","end":"2026-05-25T11:01:07.721349Z","steps":["trace[1214436484] 'process raft request' (duration: 346.05034ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:07.721503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.375772Z","time spent":"345.645002ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:01:07.721534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.236881Z","time spent":"484.553004ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:01:07.721544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.375111Z","time spent":"346.340237ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:01:07.72167Z","caller":"traceutil/trace.go:171","msg":"trace[2077644472] transaction","detail":"{read_only:false; response_revision:24942; number_of_response:1; }","duration":"344.750114ms","start":"2026-05-25T11:01:07.376892Z","end":"2026-05-25T11:01:07.721642Z","steps":["trace[2077644472] 'process raft request' (duration: 344.371755ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:07.721703Z","caller":"traceutil/trace.go:171","msg":"trace[920109564] transaction","detail":"{read_only:false; response_revision:24943; number_of_response:1; }","duration":"343.198871ms","start":"2026-05-25T11:01:07.378489Z","end":"2026-05-25T11:01:07.721688Z","steps":["trace[920109564] 'process raft request' (duration: 343.015086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:07.721735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.376876Z","time spent":"344.824026ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:01:07.721748Z","caller":"traceutil/trace.go:171","msg":"trace[464821504] transaction","detail":"{read_only:false; response_revision:24944; number_of_response:1; }","duration":"293.752897ms","start":"2026-05-25T11:01:07.427976Z","end":"2026-05-25T11:01:07.721729Z","steps":["trace[464821504] 'process raft request' (duration: 293.655035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:07.721811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.37847Z","time spent":"343.291352ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:01:07.721699Z","caller":"traceutil/trace.go:171","msg":"trace[1025649425] linearizableReadLoop","detail":"{readStateIndex:25743; appliedIndex:25738; }","duration":"324.543409ms","start":"2026-05-25T11:01:07.397137Z","end":"2026-05-25T11:01:07.72168Z","steps":["trace[1025649425] 'read index received' (duration: 79.15475ms)","trace[1025649425] 'applied index is now lower than readState.Index' (duration: 245.387779ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:01:07.721834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.688752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-05-25T11:01:07.721939Z","caller":"traceutil/trace.go:171","msg":"trace[882415052] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24944; }","duration":"324.811424ms","start":"2026-05-25T11:01:07.397096Z","end":"2026-05-25T11:01:07.721908Z","steps":["trace[882415052] 'agreement among raft nodes before linearized reading' (duration: 324.63843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:07.721999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.397079Z","time spent":"324.902027ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-25T11:01:08.111501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.735229ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-25T11:01:08.111717Z","caller":"traceutil/trace.go:171","msg":"trace[1738053438] transaction","detail":"{read_only:false; response_revision:24945; number_of_response:1; }","duration":"627.907953ms","start":"2026-05-25T11:01:07.483793Z","end":"2026-05-25T11:01:08.111701Z","steps":["trace[1738053438] 'process raft request' (duration: 393.874227ms)","trace[1738053438] 'compare' (duration: 233.496244ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:01:08.111776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.483775Z","time spent":"627.976054ms","remote":"127.0.0.1:42576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1415,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:01:08.111904Z","caller":"traceutil/trace.go:171","msg":"trace[430071857] transaction","detail":"{read_only:false; response_revision:24946; number_of_response:1; }","duration":"627.805191ms","start":"2026-05-25T11:01:07.484072Z","end":"2026-05-25T11:01:08.111877Z","steps":["trace[430071857] 'process raft request' (duration: 627.509854ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:08.111945Z","caller":"traceutil/trace.go:171","msg":"trace[321301815] transaction","detail":"{read_only:false; response_revision:24947; number_of_response:1; }","duration":"627.220888ms","start":"2026-05-25T11:01:07.484668Z","end":"2026-05-25T11:01:08.111889Z","steps":["trace[321301815] 'process raft request' (duration: 626.988453ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:08.111997Z","caller":"traceutil/trace.go:171","msg":"trace[1556890743] transaction","detail":"{read_only:false; response_revision:24948; number_of_response:1; }","duration":"620.849302ms","start":"2026-05-25T11:01:07.491128Z","end":"2026-05-25T11:01:08.111977Z","steps":["trace[1556890743] 'process raft request' (duration: 620.671398ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:08.112051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.484055Z","time spent":"627.906132ms","remote":"127.0.0.1:42576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T11:01:08.112065Z","caller":"traceutil/trace.go:171","msg":"trace[313025360] linearizableReadLoop","detail":"{readStateIndex:25748; appliedIndex:25744; }","duration":"390.178328ms","start":"2026-05-25T11:01:07.72187Z","end":"2026-05-25T11:01:08.112049Z","steps":["trace[313025360] 'read index received' (duration: 155.812195ms)","trace[313025360] 'applied index is now lower than readState.Index' (duration: 234.364723ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:08.112077Z","caller":"traceutil/trace.go:171","msg":"trace[924419917] transaction","detail":"{read_only:false; response_revision:24949; number_of_response:1; }","duration":"385.333274ms","start":"2026-05-25T11:01:07.726722Z","end":"2026-05-25T11:01:08.112055Z","steps":["trace[924419917] 'process raft request' (duration: 385.219512ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:08.112094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.491115Z","time spent":"620.931003ms","remote":"127.0.0.1:42754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9630,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:01:08.112143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.48466Z","time spent":"627.388412ms","remote":"127.0.0.1:42468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":885,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:01:08.112165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.726706Z","time spent":"385.410737ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T11:01:08.112203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.973134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-25T11:01:08.112219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.632952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-05-25T11:01:08.112232Z","caller":"traceutil/trace.go:171","msg":"trace[1551799889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24949; }","duration":"608.031936ms","start":"2026-05-25T11:01:07.504188Z","end":"2026-05-25T11:01:08.11222Z","steps":["trace[1551799889] 'agreement among raft nodes before linearized reading' (duration: 607.921643ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:08.112245Z","caller":"traceutil/trace.go:171","msg":"trace[826175226] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24949; }","duration":"603.692763ms","start":"2026-05-25T11:01:07.508544Z","end":"2026-05-25T11:01:08.112236Z","steps":["trace[826175226] 'agreement among raft nodes before linearized reading' (duration: 603.592971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:08.112253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.504177Z","time spent":"608.070676ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-25T11:01:08.112264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.508523Z","time spent":"603.736765ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-05-25T11:01:08.112265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.177945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-25T11:01:08.112323Z","caller":"traceutil/trace.go:171","msg":"trace[2063064374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24949; }","duration":"606.251008ms","start":"2026-05-25T11:01:07.506055Z","end":"2026-05-25T11:01:08.112306Z","steps":["trace[2063064374] 'agreement among raft nodes before linearized reading' (duration: 606.045793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:08.112322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.007096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-05-25T11:01:08.112362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.353961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-05-25T11:01:08.112368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.506049Z","time spent":"606.307349ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-25T11:01:08.11239Z","caller":"traceutil/trace.go:171","msg":"trace[2098898392] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24949; }","duration":"613.402711ms","start":"2026-05-25T11:01:07.498981Z","end":"2026-05-25T11:01:08.112384Z","steps":["trace[2098898392] 'agreement among raft nodes before linearized reading' (duration: 613.291549ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:08.112406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.498973Z","time spent":"613.430573ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-25T11:01:08.112402Z","caller":"traceutil/trace.go:171","msg":"trace[1159554368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24949; }","duration":"609.104488ms","start":"2026-05-25T11:01:07.503278Z","end":"2026-05-25T11:01:08.112382Z","steps":["trace[1159554368] 'agreement among raft nodes before linearized reading' (duration: 608.894824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:08.112443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:07.503271Z","time spent":"609.163299ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-25T11:01:08.263752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.93295ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-25T11:01:08.263977Z","caller":"traceutil/trace.go:171","msg":"trace[1899162088] linearizableReadLoop","detail":"{readStateIndex:25750; appliedIndex:25749; }","duration":"151.867171ms","start":"2026-05-25T11:01:08.112091Z","end":"2026-05-25T11:01:08.263958Z","steps":["trace[1899162088] 'read index received' (duration: 7.915ms)","trace[1899162088] 'applied index is now lower than readState.Index' (duration: 143.950821ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:01:08.264103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.281764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:01:08.264134Z","caller":"traceutil/trace.go:171","msg":"trace[819902209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24949; }","duration":"217.356966ms","start":"2026-05-25T11:01:08.046767Z","end":"2026-05-25T11:01:08.264124Z","steps":["trace[819902209] 'agreement among raft nodes before linearized reading' (duration: 217.292575ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:08.26426Z","caller":"traceutil/trace.go:171","msg":"trace[498278531] transaction","detail":"{read_only:false; response_revision:24950; number_of_response:1; }","duration":"146.640159ms","start":"2026-05-25T11:01:08.117594Z","end":"2026-05-25T11:01:08.264234Z","steps":["trace[498278531] 'process raft request' (duration: 146.267181ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:08.408636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.35143ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-25T11:01:08.40888Z","caller":"traceutil/trace.go:171","msg":"trace[536110000] transaction","detail":"{read_only:false; response_revision:24951; number_of_response:1; }","duration":"290.990698ms","start":"2026-05-25T11:01:08.117857Z","end":"2026-05-25T11:01:08.408848Z","steps":["trace[536110000] 'process raft request' (duration: 146.349332ms)","trace[536110000] 'compare' (duration: 144.153686ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:08.408934Z","caller":"traceutil/trace.go:171","msg":"trace[2102373424] linearizableReadLoop","detail":"{readStateIndex:25755; appliedIndex:25750; }","duration":"144.905382ms","start":"2026-05-25T11:01:08.264013Z","end":"2026-05-25T11:01:08.408918Z","steps":["trace[2102373424] 'read index received' (duration: 52.691µs)","trace[2102373424] 'applied index is now lower than readState.Index' (duration: 144.851931ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:08.409101Z","caller":"traceutil/trace.go:171","msg":"trace[339789851] transaction","detail":"{read_only:false; response_revision:24952; number_of_response:1; }","duration":"290.315904ms","start":"2026-05-25T11:01:08.118775Z","end":"2026-05-25T11:01:08.409091Z","steps":["trace[339789851] 'process raft request' (duration: 289.992628ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:08.409213Z","caller":"traceutil/trace.go:171","msg":"trace[795283508] transaction","detail":"{read_only:false; response_revision:24953; number_of_response:1; }","duration":"290.359575ms","start":"2026-05-25T11:01:08.118845Z","end":"2026-05-25T11:01:08.409205Z","steps":["trace[795283508] 'process raft request' (duration: 290.002537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:08.409312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.736156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:01:08.409337Z","caller":"traceutil/trace.go:171","msg":"trace[863578086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24954; }","duration":"143.793737ms","start":"2026-05-25T11:01:08.265535Z","end":"2026-05-25T11:01:08.409329Z","steps":["trace[863578086] 'agreement among raft nodes before linearized reading' (duration: 143.745956ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:08.409363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.411804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3236"} {"level":"info","ts":"2026-05-25T11:01:08.409383Z","caller":"traceutil/trace.go:171","msg":"trace[1510646756] transaction","detail":"{read_only:false; response_revision:24954; number_of_response:1; }","duration":"290.380176ms","start":"2026-05-25T11:01:08.118886Z","end":"2026-05-25T11:01:08.409266Z","steps":["trace[1510646756] 'process raft request' (duration: 289.996658ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:08.409443Z","caller":"traceutil/trace.go:171","msg":"trace[1503045340] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:24954; }","duration":"288.514805ms","start":"2026-05-25T11:01:08.12089Z","end":"2026-05-25T11:01:08.409405Z","steps":["trace[1503045340] 'agreement among raft nodes before linearized reading' (duration: 288.331701ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:08.548784Z","caller":"traceutil/trace.go:171","msg":"trace[997228383] transaction","detail":"{read_only:false; response_revision:24955; number_of_response:1; }","duration":"126.604268ms","start":"2026-05-25T11:01:08.422152Z","end":"2026-05-25T11:01:08.548757Z","steps":["trace[997228383] 'process raft request' (duration: 126.430845ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:08.776284Z","caller":"traceutil/trace.go:171","msg":"trace[2014885596] linearizableReadLoop","detail":"{readStateIndex:25757; appliedIndex:25756; }","duration":"227.537756ms","start":"2026-05-25T11:01:08.54872Z","end":"2026-05-25T11:01:08.776258Z","steps":["trace[2014885596] 'read index received' (duration: 212.650927ms)","trace[2014885596] 'applied index is now lower than readState.Index' (duration: 14.885879ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:01:08.776481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.167121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-25T11:01:08.776543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.484377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1155"} {"level":"info","ts":"2026-05-25T11:01:08.776578Z","caller":"traceutil/trace.go:171","msg":"trace[1338008995] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:24956; }","duration":"222.575809ms","start":"2026-05-25T11:01:08.553991Z","end":"2026-05-25T11:01:08.776567Z","steps":["trace[1338008995] 'agreement among raft nodes before linearized reading' (duration: 222.423506ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:08.776628Z","caller":"traceutil/trace.go:171","msg":"trace[1093777997] transaction","detail":"{read_only:false; response_revision:24956; number_of_response:1; }","duration":"251.503541ms","start":"2026-05-25T11:01:08.525107Z","end":"2026-05-25T11:01:08.776611Z","steps":["trace[1093777997] 'process raft request' (duration: 236.312755ms)","trace[1093777997] 'compare' (duration: 14.720956ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:01:08.7767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.108706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:01:08.776572Z","caller":"traceutil/trace.go:171","msg":"trace[1649915673] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:24956; }","duration":"304.272203ms","start":"2026-05-25T11:01:08.472277Z","end":"2026-05-25T11:01:08.776549Z","steps":["trace[1649915673] 'agreement among raft nodes before linearized reading' (duration: 304.11892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:08.776844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T11:01:08.472242Z","time spent":"304.5832ms","remote":"127.0.0.1:58648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-05-25T11:01:08.776882Z","caller":"traceutil/trace.go:171","msg":"trace[625814402] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:24956; }","duration":"199.278859ms","start":"2026-05-25T11:01:08.577512Z","end":"2026-05-25T11:01:08.77679Z","steps":["trace[625814402] 'agreement among raft nodes before linearized reading' (duration: 199.050905ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:09.041754Z","caller":"traceutil/trace.go:171","msg":"trace[1586173435] linearizableReadLoop","detail":"{readStateIndex:25759; appliedIndex:25758; }","duration":"198.741058ms","start":"2026-05-25T11:01:08.84299Z","end":"2026-05-25T11:01:09.041731Z","steps":["trace[1586173435] 'read index received' (duration: 124.102275ms)","trace[1586173435] 'applied index is now lower than readState.Index' (duration: 74.637923ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:09.041783Z","caller":"traceutil/trace.go:171","msg":"trace[1398818898] transaction","detail":"{read_only:false; response_revision:24957; number_of_response:1; }","duration":"202.367425ms","start":"2026-05-25T11:01:08.839385Z","end":"2026-05-25T11:01:09.041752Z","steps":["trace[1398818898] 'process raft request' (duration: 127.711962ms)","trace[1398818898] 'compare' (duration: 74.398568ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:01:09.041996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.996243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-05-25T11:01:09.042068Z","caller":"traceutil/trace.go:171","msg":"trace[301539566] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24957; }","duration":"199.075085ms","start":"2026-05-25T11:01:08.842976Z","end":"2026-05-25T11:01:09.042051Z","steps":["trace[301539566] 'agreement among raft nodes before linearized reading' (duration: 198.87193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:09.041993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.637914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-05-25T11:01:09.042195Z","caller":"traceutil/trace.go:171","msg":"trace[2000619757] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24957; }","duration":"190.889179ms","start":"2026-05-25T11:01:08.85129Z","end":"2026-05-25T11:01:09.042179Z","steps":["trace[2000619757] 'agreement among raft nodes before linearized reading' (duration: 190.576893ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:11.857038Z","caller":"traceutil/trace.go:171","msg":"trace[358431002] transaction","detail":"{read_only:false; response_revision:24978; number_of_response:1; }","duration":"117.741898ms","start":"2026-05-25T11:01:11.739269Z","end":"2026-05-25T11:01:11.857011Z","steps":["trace[358431002] 'process raft request' (duration: 117.655347ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:11.857064Z","caller":"traceutil/trace.go:171","msg":"trace[1885460033] transaction","detail":"{read_only:false; response_revision:24977; number_of_response:1; }","duration":"117.778649ms","start":"2026-05-25T11:01:11.739245Z","end":"2026-05-25T11:01:11.857024Z","steps":["trace[1885460033] 'process raft request' (duration: 117.216867ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:11.85737Z","caller":"traceutil/trace.go:171","msg":"trace[127070464] transaction","detail":"{read_only:false; response_revision:24979; number_of_response:1; }","duration":"117.931773ms","start":"2026-05-25T11:01:11.739414Z","end":"2026-05-25T11:01:11.857346Z","steps":["trace[127070464] 'process raft request' (duration: 117.552905ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:11.857492Z","caller":"traceutil/trace.go:171","msg":"trace[50922151] transaction","detail":"{read_only:false; response_revision:24980; number_of_response:1; }","duration":"118.055214ms","start":"2026-05-25T11:01:11.739425Z","end":"2026-05-25T11:01:11.85748Z","steps":["trace[50922151] 'process raft request' (duration: 117.805189ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:11.857538Z","caller":"traceutil/trace.go:171","msg":"trace[427982897] transaction","detail":"{read_only:false; response_revision:24981; number_of_response:1; }","duration":"115.444359ms","start":"2026-05-25T11:01:11.742056Z","end":"2026-05-25T11:01:11.8575Z","steps":["trace[427982897] 'process raft request' (duration: 115.365197ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:14.31154Z","caller":"traceutil/trace.go:171","msg":"trace[696617220] transaction","detail":"{read_only:false; response_revision:24999; number_of_response:1; }","duration":"145.535235ms","start":"2026-05-25T11:01:14.16598Z","end":"2026-05-25T11:01:14.311515Z","steps":["trace[696617220] 'process raft request' (duration: 145.090065ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:14.467332Z","caller":"traceutil/trace.go:171","msg":"trace[303073145] linearizableReadLoop","detail":"{readStateIndex:25803; appliedIndex:25802; }","duration":"149.167574ms","start":"2026-05-25T11:01:14.318135Z","end":"2026-05-25T11:01:14.467303Z","steps":["trace[303073145] 'read index received' (duration: 122.44706ms)","trace[303073145] 'applied index is now lower than readState.Index' (duration: 26.719233ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:14.467499Z","caller":"traceutil/trace.go:171","msg":"trace[356455150] transaction","detail":"{read_only:false; response_revision:25000; number_of_response:1; }","duration":"151.810611ms","start":"2026-05-25T11:01:14.31567Z","end":"2026-05-25T11:01:14.467481Z","steps":["trace[356455150] 'process raft request' (duration: 125.060006ms)","trace[356455150] 'compare' (duration: 26.319465ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:01:14.467769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.613653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-05-25T11:01:14.467859Z","caller":"traceutil/trace.go:171","msg":"trace[406217717] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25000; }","duration":"149.741085ms","start":"2026-05-25T11:01:14.318099Z","end":"2026-05-25T11:01:14.46784Z","steps":["trace[406217717] 'agreement among raft nodes before linearized reading' (duration: 149.526561ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:15.838916Z","caller":"traceutil/trace.go:171","msg":"trace[632183149] transaction","detail":"{read_only:false; response_revision:25009; number_of_response:1; }","duration":"181.972868ms","start":"2026-05-25T11:01:15.656905Z","end":"2026-05-25T11:01:15.838878Z","steps":["trace[632183149] 'process raft request' (duration: 180.602559ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:18.58056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.417747ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-25T11:01:18.580728Z","caller":"traceutil/trace.go:171","msg":"trace[197822306] linearizableReadLoop","detail":"{readStateIndex:25835; appliedIndex:25834; }","duration":"254.666618ms","start":"2026-05-25T11:01:18.326031Z","end":"2026-05-25T11:01:18.580697Z","steps":["trace[197822306] 'read index received' (duration: 93.752µs)","trace[197822306] 'applied index is now lower than readState.Index' (duration: 254.570576ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:01:18.581061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.008415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-05-25T11:01:18.581097Z","caller":"traceutil/trace.go:171","msg":"trace[192714919] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25031; }","duration":"255.121289ms","start":"2026-05-25T11:01:18.325961Z","end":"2026-05-25T11:01:18.581082Z","steps":["trace[192714919] 'agreement among raft nodes before linearized reading' (duration: 254.885764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:18.581259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.255002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-25T11:01:18.58142Z","caller":"traceutil/trace.go:171","msg":"trace[430721441] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:25031; }","duration":"181.482827ms","start":"2026-05-25T11:01:18.399905Z","end":"2026-05-25T11:01:18.581388Z","steps":["trace[430721441] 'agreement among raft nodes before linearized reading' (duration: 181.13957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:18.581908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.117772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-25T11:01:18.581989Z","caller":"traceutil/trace.go:171","msg":"trace[1715478807] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25031; }","duration":"102.243345ms","start":"2026-05-25T11:01:18.479727Z","end":"2026-05-25T11:01:18.58197Z","steps":["trace[1715478807] 'agreement among raft nodes before linearized reading' (duration: 102.091042ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:20.075336Z","caller":"traceutil/trace.go:171","msg":"trace[214536167] transaction","detail":"{read_only:false; response_revision:25040; number_of_response:1; }","duration":"190.446949ms","start":"2026-05-25T11:01:19.884859Z","end":"2026-05-25T11:01:20.075306Z","steps":["trace[214536167] 'process raft request' (duration: 150.703476ms)","trace[214536167] 'compare' (duration: 39.56633ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:20.075703Z","caller":"traceutil/trace.go:171","msg":"trace[1335599218] transaction","detail":"{read_only:false; response_revision:25041; number_of_response:1; }","duration":"189.644573ms","start":"2026-05-25T11:01:19.886008Z","end":"2026-05-25T11:01:20.075653Z","steps":["trace[1335599218] 'process raft request' (duration: 189.259824ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:20.076053Z","caller":"traceutil/trace.go:171","msg":"trace[1077819754] transaction","detail":"{read_only:false; response_revision:25044; number_of_response:1; }","duration":"188.824535ms","start":"2026-05-25T11:01:19.887216Z","end":"2026-05-25T11:01:20.076041Z","steps":["trace[1077819754] 'process raft request' (duration: 188.699762ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:20.076178Z","caller":"traceutil/trace.go:171","msg":"trace[2115117046] transaction","detail":"{read_only:false; response_revision:25043; number_of_response:1; }","duration":"189.362127ms","start":"2026-05-25T11:01:19.886807Z","end":"2026-05-25T11:01:20.076169Z","steps":["trace[2115117046] 'process raft request' (duration: 188.965718ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:20.076457Z","caller":"traceutil/trace.go:171","msg":"trace[752406825] transaction","detail":"{read_only:false; response_revision:25042; number_of_response:1; }","duration":"189.759294ms","start":"2026-05-25T11:01:19.886113Z","end":"2026-05-25T11:01:20.075873Z","steps":["trace[752406825] 'process raft request' (duration: 189.466137ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:23.736684Z","caller":"traceutil/trace.go:171","msg":"trace[2020139616] transaction","detail":"{read_only:false; response_revision:25070; number_of_response:1; }","duration":"176.927729ms","start":"2026-05-25T11:01:23.559733Z","end":"2026-05-25T11:01:23.736661Z","steps":["trace[2020139616] 'process raft request' (duration: 176.768085ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:23.782711Z","caller":"traceutil/trace.go:171","msg":"trace[1273351563] transaction","detail":"{read_only:false; response_revision:25071; number_of_response:1; }","duration":"192.745619ms","start":"2026-05-25T11:01:23.589928Z","end":"2026-05-25T11:01:23.782674Z","steps":["trace[1273351563] 'process raft request' (duration: 178.680507ms)","trace[1273351563] 'compare' (duration: 13.919939ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:33.934239Z","caller":"traceutil/trace.go:171","msg":"trace[297827030] transaction","detail":"{read_only:false; response_revision:25142; number_of_response:1; }","duration":"136.386779ms","start":"2026-05-25T11:01:33.797765Z","end":"2026-05-25T11:01:33.934152Z","steps":["trace[297827030] 'process raft request' (duration: 135.737895ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:34.128529Z","caller":"traceutil/trace.go:171","msg":"trace[1082962300] linearizableReadLoop","detail":"{readStateIndex:25950; appliedIndex:25949; }","duration":"103.253867ms","start":"2026-05-25T11:01:34.025245Z","end":"2026-05-25T11:01:34.128499Z","steps":["trace[1082962300] 'read index received' (duration: 56.492323ms)","trace[1082962300] 'applied index is now lower than readState.Index' (duration: 46.757994ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:01:34.128722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.456072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:01:34.128767Z","caller":"traceutil/trace.go:171","msg":"trace[1602331969] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:25144; }","duration":"103.568623ms","start":"2026-05-25T11:01:34.025187Z","end":"2026-05-25T11:01:34.128756Z","steps":["trace[1602331969] 'agreement among raft nodes before linearized reading' (duration: 103.448501ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:34.128558Z","caller":"traceutil/trace.go:171","msg":"trace[68124098] transaction","detail":"{read_only:false; response_revision:25143; number_of_response:1; }","duration":"167.603799ms","start":"2026-05-25T11:01:33.960892Z","end":"2026-05-25T11:01:34.128496Z","steps":["trace[68124098] 'process raft request' (duration: 120.881616ms)","trace[68124098] 'compare' (duration: 46.448197ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:40.254452Z","caller":"traceutil/trace.go:171","msg":"trace[1593273587] transaction","detail":"{read_only:false; response_revision:25198; number_of_response:1; }","duration":"104.688329ms","start":"2026-05-25T11:01:40.149734Z","end":"2026-05-25T11:01:40.254423Z","steps":["trace[1593273587] 'process raft request' (duration: 104.527365ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:40.427998Z","caller":"traceutil/trace.go:171","msg":"trace[167535650] transaction","detail":"{read_only:false; response_revision:25199; number_of_response:1; }","duration":"273.215797ms","start":"2026-05-25T11:01:40.154755Z","end":"2026-05-25T11:01:40.427971Z","steps":["trace[167535650] 'process raft request' (duration: 206.30495ms)","trace[167535650] 'compare' (duration: 66.720783ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:40.428312Z","caller":"traceutil/trace.go:171","msg":"trace[112846262] transaction","detail":"{read_only:false; response_revision:25200; number_of_response:1; }","duration":"270.578891ms","start":"2026-05-25T11:01:40.157687Z","end":"2026-05-25T11:01:40.428265Z","steps":["trace[112846262] 'process raft request' (duration: 270.238833ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:40.428891Z","caller":"traceutil/trace.go:171","msg":"trace[243132366] transaction","detail":"{read_only:false; response_revision:25202; number_of_response:1; }","duration":"270.430147ms","start":"2026-05-25T11:01:40.158446Z","end":"2026-05-25T11:01:40.428876Z","steps":["trace[243132366] 'process raft request' (duration: 270.154252ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:40.428831Z","caller":"traceutil/trace.go:171","msg":"trace[445739963] transaction","detail":"{read_only:false; response_revision:25201; number_of_response:1; }","duration":"271.02721ms","start":"2026-05-25T11:01:40.157745Z","end":"2026-05-25T11:01:40.428772Z","steps":["trace[445739963] 'process raft request' (duration: 270.635612ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:40.429484Z","caller":"traceutil/trace.go:171","msg":"trace[349695247] linearizableReadLoop","detail":"{readStateIndex:26009; appliedIndex:26005; }","duration":"271.066671ms","start":"2026-05-25T11:01:40.158394Z","end":"2026-05-25T11:01:40.429461Z","steps":["trace[349695247] 'read index received' (duration: 95.811868ms)","trace[349695247] 'applied index is now lower than readState.Index' (duration: 175.253173ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:40.429614Z","caller":"traceutil/trace.go:171","msg":"trace[231276851] transaction","detail":"{read_only:false; response_revision:25203; number_of_response:1; }","duration":"270.907107ms","start":"2026-05-25T11:01:40.158696Z","end":"2026-05-25T11:01:40.429603Z","steps":["trace[231276851] 'process raft request' (duration: 269.958677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T11:01:40.430125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.693224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-05-25T11:01:40.430203Z","caller":"traceutil/trace.go:171","msg":"trace[1310895012] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25203; }","duration":"271.824567ms","start":"2026-05-25T11:01:40.158357Z","end":"2026-05-25T11:01:40.430182Z","steps":["trace[1310895012] 'agreement among raft nodes before linearized reading' (duration: 271.568242ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:40.92274Z","caller":"traceutil/trace.go:171","msg":"trace[2113048923] transaction","detail":"{read_only:false; response_revision:25207; number_of_response:1; }","duration":"137.186836ms","start":"2026-05-25T11:01:40.785526Z","end":"2026-05-25T11:01:40.922713Z","steps":["trace[2113048923] 'process raft request' (duration: 137.077564ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:40.922761Z","caller":"traceutil/trace.go:171","msg":"trace[577768459] transaction","detail":"{read_only:false; response_revision:25206; number_of_response:1; }","duration":"137.354889ms","start":"2026-05-25T11:01:40.785352Z","end":"2026-05-25T11:01:40.922707Z","steps":["trace[577768459] 'process raft request' (duration: 105.964665ms)","trace[577768459] 'compare' (duration: 31.119238ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T11:01:40.923241Z","caller":"traceutil/trace.go:171","msg":"trace[1022847856] linearizableReadLoop","detail":"{readStateIndex:26017; appliedIndex:26013; }","duration":"129.565432ms","start":"2026-05-25T11:01:40.793637Z","end":"2026-05-25T11:01:40.923202Z","steps":["trace[1022847856] 'read index received' (duration: 97.623537ms)","trace[1022847856] 'applied index is now lower than readState.Index' (duration: 31.940605ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T11:01:40.923532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.844129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-25T11:01:40.923495Z","caller":"traceutil/trace.go:171","msg":"trace[2051558559] transaction","detail":"{read_only:false; response_revision:25209; number_of_response:1; }","duration":"137.368599ms","start":"2026-05-25T11:01:40.786038Z","end":"2026-05-25T11:01:40.923407Z","steps":["trace[2051558559] 'process raft request' (duration: 136.966711ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:40.923579Z","caller":"traceutil/trace.go:171","msg":"trace[149455039] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:25209; }","duration":"129.945631ms","start":"2026-05-25T11:01:40.793618Z","end":"2026-05-25T11:01:40.923563Z","steps":["trace[149455039] 'agreement among raft nodes before linearized reading' (duration: 129.786286ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:01:40.923619Z","caller":"traceutil/trace.go:171","msg":"trace[1524675737] transaction","detail":"{read_only:false; response_revision:25208; number_of_response:1; }","duration":"137.942822ms","start":"2026-05-25T11:01:40.785654Z","end":"2026-05-25T11:01:40.923596Z","steps":["trace[1524675737] 'process raft request' (duration: 137.002672ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T11:02:54.964496Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068b8.wal"} {"level":"info","ts":"2026-05-25T11:03:29.757591Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23321} {"level":"info","ts":"2026-05-25T11:03:29.896442Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23321,"took":"132.858809ms","hash":1610791473,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":36868096,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-05-25T11:03:29.8965Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1610791473,"revision":23321,"compact-revision":20074} {"level":"info","ts":"2026-05-25T11:08:29.762979Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26300} {"level":"info","ts":"2026-05-25T11:08:29.906931Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26300,"took":"139.793748ms","hash":2384540885,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":33566720,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-25T11:08:29.907003Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2384540885,"revision":26300,"compact-revision":23321} {"level":"info","ts":"2026-05-25T11:08:55.05641Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"21b354698260dd82","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-25T11:08:55.062119Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-05-25T11:08:55.062218Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-05-25T11:13:29.769172Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28906} {"level":"info","ts":"2026-05-25T11:13:29.915695Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28906,"took":"140.281004ms","hash":2460649098,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":30208000,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-25T11:13:29.915782Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2460649098,"revision":28906,"compact-revision":26300} {"level":"info","ts":"2026-05-25T11:18:29.77637Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31129} {"level":"info","ts":"2026-05-25T11:18:29.904394Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31129,"took":"123.19971ms","hash":3922592891,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":30367744,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-25T11:18:29.904452Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3922592891,"revision":31129,"compact-revision":28906} {"level":"info","ts":"2026-05-25T11:23:29.788118Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33395} {"level":"info","ts":"2026-05-25T11:23:29.944763Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33395,"took":"151.887333ms","hash":3927695839,"current-db-size-bytes":57700352,"current-db-size":"58 MB","current-db-size-in-use-bytes":32051200,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-25T11:23:29.944853Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3927695839,"revision":33395,"compact-revision":31129} {"level":"info","ts":"2026-05-25T11:28:29.797567Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35693} {"level":"info","ts":"2026-05-25T11:28:29.950222Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35693,"took":"148.378473ms","hash":1916710598,"current-db-size-bytes":58175488,"current-db-size":"58 MB","current-db-size-in-use-bytes":31494144,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-25T11:28:29.950289Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1916710598,"revision":35693,"compact-revision":33395} {"level":"info","ts":"2026-05-25T11:30:19.664832Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"21b354698260dd82","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-25T11:30:19.671264Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-05-25T11:30:19.671414Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-05-25T11:33:29.804116Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37921} {"level":"info","ts":"2026-05-25T11:33:29.917812Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37921,"took":"110.489872ms","hash":2475512378,"current-db-size-bytes":58175488,"current-db-size":"58 MB","current-db-size-in-use-bytes":31043584,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-25T11:33:29.917896Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2475512378,"revision":37921,"compact-revision":35693}