{"level":"warn","ts":"2026-04-26T14:45:01.874041Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-26T14:45:01.874119Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-26T14:45:01.874202Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-26T14:45:01.874219Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-26T14:45:01.874301Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-26T14:45:01.874926Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-04-26T14:45:01.875129Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-26T14:45:01.881083Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.610941ms"} {"level":"info","ts":"2026-04-26T14:45:01.888974Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-04-26T14:45:01.889102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-04-26T14:45:01.889136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-04-26T14:45:01.889157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-26T14:45:01.889171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-04-26T14:45:01.889236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-04-26T14:45:01.897228Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-26T14:45:01.900366Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-26T14:45:01.901421Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-26T14:45:01.904251Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-26T14:45:01.905557Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-26T14:45:01.905709Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-26T14:45:01.905787Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-26T14:45:01.905802Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-26T14:45:01.908123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-04-26T14:45:01.908846Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-26T14:45:01.909889Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-26T14:45:01.910188Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-26T14:45:01.910257Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-26T14:45:01.910924Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-26T14:45:01.910951Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-26T14:45:02.491296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-04-26T14:45:02.491365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-26T14:45:02.491402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-04-26T14:45:02.491419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-04-26T14:45:02.491427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-26T14:45:02.491444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-04-26T14:45:02.491453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-26T14:45:02.499437Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T14:45:02.507393Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T14:45:02.507448Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T14:45:02.507385Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-04-26T14:45:02.508156Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-26T14:45:02.508207Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-26T14:45:02.508337Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T14:45:02.508476Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T14:45:02.508524Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T14:45:02.511336Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-26T14:45:02.512405Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-04-26T14:45:26.099418Z","caller":"traceutil/trace.go:171","msg":"trace[2052180402] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"125.043039ms","start":"2026-04-26T14:45:25.974334Z","end":"2026-04-26T14:45:26.099377Z","steps":["trace[2052180402] 'process raft request' (duration: 124.781011ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.099656Z","caller":"traceutil/trace.go:171","msg":"trace[934552584] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"121.569451ms","start":"2026-04-26T14:45:25.978074Z","end":"2026-04-26T14:45:26.099643Z","steps":["trace[934552584] 'process raft request' (duration: 121.272217ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.099946Z","caller":"traceutil/trace.go:171","msg":"trace[1836390023] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"122.635514ms","start":"2026-04-26T14:45:25.977298Z","end":"2026-04-26T14:45:26.099933Z","steps":["trace[1836390023] 'process raft request' (duration: 122.013291ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.100162Z","caller":"traceutil/trace.go:171","msg":"trace[1812474202] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"117.623096ms","start":"2026-04-26T14:45:25.982517Z","end":"2026-04-26T14:45:26.10014Z","steps":["trace[1812474202] 'process raft request' (duration: 116.885211ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.100355Z","caller":"traceutil/trace.go:171","msg":"trace[1736559884] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"115.619105ms","start":"2026-04-26T14:45:25.98469Z","end":"2026-04-26T14:45:26.10031Z","steps":["trace[1736559884] 'process raft request' (duration: 114.756337ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.100468Z","caller":"traceutil/trace.go:171","msg":"trace[884183281] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"112.670371ms","start":"2026-04-26T14:45:25.987789Z","end":"2026-04-26T14:45:26.10046Z","steps":["trace[884183281] 'process raft request' (duration: 111.682111ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.100602Z","caller":"traceutil/trace.go:171","msg":"trace[307553761] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"111.773058ms","start":"2026-04-26T14:45:25.98882Z","end":"2026-04-26T14:45:26.100593Z","steps":["trace[307553761] 'process raft request' (duration: 110.675217ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.100737Z","caller":"traceutil/trace.go:171","msg":"trace[169621454] transaction","detail":"{read_only:false; number_of_response:1; response_revision:509; }","duration":"110.858803ms","start":"2026-04-26T14:45:25.989869Z","end":"2026-04-26T14:45:26.100728Z","steps":["trace[169621454] 'process raft request' (duration: 109.791008ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.100823Z","caller":"traceutil/trace.go:171","msg":"trace[1389898164] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"110.100146ms","start":"2026-04-26T14:45:25.990715Z","end":"2026-04-26T14:45:26.100815Z","steps":["trace[1389898164] 'process raft request' (duration: 108.97218ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.100954Z","caller":"traceutil/trace.go:171","msg":"trace[1844303016] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"103.407094ms","start":"2026-04-26T14:45:25.997539Z","end":"2026-04-26T14:45:26.100946Z","steps":["trace[1844303016] 'process raft request' (duration: 102.214006ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.151516Z","caller":"traceutil/trace.go:171","msg":"trace[778028863] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"120.00854ms","start":"2026-04-26T14:45:26.031478Z","end":"2026-04-26T14:45:26.151486Z","steps":["trace[778028863] 'process raft request' (duration: 119.503299ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.15179Z","caller":"traceutil/trace.go:171","msg":"trace[406226811] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"115.266577ms","start":"2026-04-26T14:45:26.036513Z","end":"2026-04-26T14:45:26.151779Z","steps":["trace[406226811] 'process raft request' (duration: 114.764996ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:26.151598Z","caller":"traceutil/trace.go:171","msg":"trace[829889514] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"112.881003ms","start":"2026-04-26T14:45:26.038694Z","end":"2026-04-26T14:45:26.151575Z","steps":["trace[829889514] 'process raft request' (duration: 112.828893ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:27.116041Z","caller":"traceutil/trace.go:171","msg":"trace[402549958] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"193.881342ms","start":"2026-04-26T14:45:26.922124Z","end":"2026-04-26T14:45:27.116006Z","steps":["trace[402549958] 'process raft request' (duration: 169.531019ms)","trace[402549958] 'compare' (duration: 23.881188ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:45:27.146858Z","caller":"traceutil/trace.go:171","msg":"trace[930848062] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"218.933899ms","start":"2026-04-26T14:45:26.927898Z","end":"2026-04-26T14:45:27.146832Z","steps":["trace[930848062] 'process raft request' (duration: 218.693906ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:45:27.529314Z","caller":"traceutil/trace.go:171","msg":"trace[1210356333] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:583; }","duration":"336.624016ms","start":"2026-04-26T14:45:27.192616Z","end":"2026-04-26T14:45:27.52924Z","steps":["trace[1210356333] 'read index received' (duration: 292.849742ms)","trace[1210356333] 'applied index is now lower than readState.Index' (duration: 43.773034ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:45:27.529461Z","caller":"traceutil/trace.go:171","msg":"trace[935524354] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"362.847131ms","start":"2026-04-26T14:45:27.166499Z","end":"2026-04-26T14:45:27.529346Z","steps":["trace[935524354] 'process raft request' (duration: 319.047761ms)","trace[935524354] 'compare' (duration: 43.543953ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:45:27.529483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.839336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:45:27.529561Z","caller":"traceutil/trace.go:171","msg":"trace[670918383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"336.982282ms","start":"2026-04-26T14:45:27.192566Z","end":"2026-04-26T14:45:27.529549Z","steps":["trace[670918383] 'agreement among raft nodes before linearized reading' (duration: 336.851608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:45:27.529598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:45:27.192545Z","time spent":"337.044253ms","remote":"127.0.0.1:40466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-26T14:45:27.530295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:45:27.166466Z","time spent":"363.087455ms","remote":"127.0.0.1:40500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20851,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T14:45:27.530413Z","caller":"traceutil/trace.go:171","msg":"trace[1273595271] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"312.381593ms","start":"2026-04-26T14:45:27.217993Z","end":"2026-04-26T14:45:27.530374Z","steps":["trace[1273595271] 'process raft request' (duration: 311.951844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:45:27.530616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:45:27.217961Z","time spent":"312.521137ms","remote":"127.0.0.1:40500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-26T14:45:27.530763Z","caller":"traceutil/trace.go:171","msg":"trace[1746211848] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"214.608424ms","start":"2026-04-26T14:45:27.316121Z","end":"2026-04-26T14:45:27.53073Z","steps":["trace[1746211848] 'process raft request' (duration: 214.154321ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:47:44.394772Z","caller":"traceutil/trace.go:171","msg":"trace[891951132] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"160.279626ms","start":"2026-04-26T14:47:44.234469Z","end":"2026-04-26T14:47:44.394749Z","steps":["trace[891951132] 'process raft request' (duration: 160.124386ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:47:44.402292Z","caller":"traceutil/trace.go:171","msg":"trace[84163042] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"159.200696ms","start":"2026-04-26T14:47:44.243074Z","end":"2026-04-26T14:47:44.402275Z","steps":["trace[84163042] 'process raft request' (duration: 158.916083ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:47:44.402324Z","caller":"traceutil/trace.go:171","msg":"trace[495496818] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"106.016438ms","start":"2026-04-26T14:47:44.296297Z","end":"2026-04-26T14:47:44.402313Z","steps":["trace[495496818] 'process raft request' (duration: 105.801951ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:47:44.585947Z","caller":"traceutil/trace.go:171","msg":"trace[388420779] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"105.059909ms","start":"2026-04-26T14:47:44.480863Z","end":"2026-04-26T14:47:44.585923Z","steps":["trace[388420779] 'process raft request' (duration: 53.409663ms)","trace[388420779] 'compare' (duration: 51.516975ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:47:46.253562Z","caller":"traceutil/trace.go:171","msg":"trace[1801432576] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"100.929254ms","start":"2026-04-26T14:47:46.152602Z","end":"2026-04-26T14:47:46.253532Z","steps":["trace[1801432576] 'process raft request' (duration: 100.662971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:47:53.480792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.855911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-26T14:47:53.480897Z","caller":"traceutil/trace.go:171","msg":"trace[1519475469] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1553; }","duration":"145.026612ms","start":"2026-04-26T14:47:53.33585Z","end":"2026-04-26T14:47:53.480876Z","steps":["trace[1519475469] 'range keys from in-memory index tree' (duration: 144.625901ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:47:57.240525Z","caller":"traceutil/trace.go:171","msg":"trace[1979233474] transaction","detail":"{read_only:false; response_revision:1670; number_of_response:1; }","duration":"165.228027ms","start":"2026-04-26T14:47:57.075279Z","end":"2026-04-26T14:47:57.240507Z","steps":["trace[1979233474] 'process raft request' (duration: 85.325116ms)","trace[1979233474] 'compare' (duration: 79.766847ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:47:57.240718Z","caller":"traceutil/trace.go:171","msg":"trace[1327635751] transaction","detail":"{read_only:false; response_revision:1671; number_of_response:1; }","duration":"163.635907ms","start":"2026-04-26T14:47:57.077076Z","end":"2026-04-26T14:47:57.240712Z","steps":["trace[1327635751] 'process raft request' (duration: 163.396038ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:47:57.240783Z","caller":"traceutil/trace.go:171","msg":"trace[725334355] linearizableReadLoop","detail":"{readStateIndex:1721; appliedIndex:1719; }","duration":"151.78896ms","start":"2026-04-26T14:47:57.088963Z","end":"2026-04-26T14:47:57.240752Z","steps":["trace[725334355] 'read index received' (duration: 71.62316ms)","trace[725334355] 'applied index is now lower than readState.Index' (duration: 80.16283ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:47:57.241103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.116166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-26T14:47:57.241091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.930028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T14:47:57.241113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.085131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-26T14:47:57.241154Z","caller":"traceutil/trace.go:171","msg":"trace[1420535561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1671; }","duration":"152.228901ms","start":"2026-04-26T14:47:57.088911Z","end":"2026-04-26T14:47:57.24114Z","steps":["trace[1420535561] 'agreement among raft nodes before linearized reading' (duration: 152.008511ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:47:57.241186Z","caller":"traceutil/trace.go:171","msg":"trace[62099914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1671; }","duration":"151.204586ms","start":"2026-04-26T14:47:57.089966Z","end":"2026-04-26T14:47:57.241171Z","steps":["trace[62099914] 'agreement among raft nodes before linearized reading' (duration: 150.977186ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:47:57.241183Z","caller":"traceutil/trace.go:171","msg":"trace[893778629] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1671; }","duration":"151.033273ms","start":"2026-04-26T14:47:57.090127Z","end":"2026-04-26T14:47:57.241161Z","steps":["trace[893778629] 'agreement among raft nodes before linearized reading' (duration: 150.89017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:47:57.480584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.570258ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:47:57.48073Z","caller":"traceutil/trace.go:171","msg":"trace[787254074] transaction","detail":"{read_only:false; response_revision:1674; number_of_response:1; }","duration":"201.490361ms","start":"2026-04-26T14:47:57.279215Z","end":"2026-04-26T14:47:57.480705Z","steps":["trace[787254074] 'process raft request' (duration: 66.53082ms)","trace[787254074] 'compare' (duration: 134.463553ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:48:17.786445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.608812ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:48:17.78655Z","caller":"traceutil/trace.go:171","msg":"trace[1254670780] linearizableReadLoop","detail":"{readStateIndex:2231; appliedIndex:2230; }","duration":"154.344829ms","start":"2026-04-26T14:48:17.632188Z","end":"2026-04-26T14:48:17.786533Z","steps":["trace[1254670780] 'read index received' (duration: 49.581151ms)","trace[1254670780] 'applied index is now lower than readState.Index' (duration: 104.762228ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:48:17.786754Z","caller":"traceutil/trace.go:171","msg":"trace[2131446952] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"156.213325ms","start":"2026-04-26T14:48:17.630525Z","end":"2026-04-26T14:48:17.786738Z","steps":["trace[2131446952] 'process raft request' (duration: 51.224449ms)","trace[2131446952] 'compare' (duration: 104.277561ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:48:17.787118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.905688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:9 size:387444"} {"level":"info","ts":"2026-04-26T14:48:17.787216Z","caller":"traceutil/trace.go:171","msg":"trace[831208601] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:9; response_revision:2145; }","duration":"155.044973ms","start":"2026-04-26T14:48:17.632151Z","end":"2026-04-26T14:48:17.787196Z","steps":["trace[831208601] 'agreement among raft nodes before linearized reading' (duration: 154.620688ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:48:17.791466Z","caller":"traceutil/trace.go:171","msg":"trace[83104801] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"150.883996ms","start":"2026-04-26T14:48:17.640562Z","end":"2026-04-26T14:48:17.791445Z","steps":["trace[83104801] 'process raft request' (duration: 150.789233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:48:17.791476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.33115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-11e448ea-2eba-4e5f-a716-7ab07d8fd195\" ","response":"range_response_count:1 size:3616"} {"level":"info","ts":"2026-04-26T14:48:17.791552Z","caller":"traceutil/trace.go:171","msg":"trace[1395986551] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-11e448ea-2eba-4e5f-a716-7ab07d8fd195; range_end:; response_count:1; response_revision:2147; }","duration":"158.448175ms","start":"2026-04-26T14:48:17.633085Z","end":"2026-04-26T14:48:17.791533Z","steps":["trace[1395986551] 'agreement among raft nodes before linearized reading' (duration: 158.31263ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:48:17.791624Z","caller":"traceutil/trace.go:171","msg":"trace[1824606641] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"158.443095ms","start":"2026-04-26T14:48:17.633168Z","end":"2026-04-26T14:48:17.791611Z","steps":["trace[1824606641] 'process raft request' (duration: 158.0111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:48:17.791875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.90456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-26T14:48:17.791918Z","caller":"traceutil/trace.go:171","msg":"trace[1525459578] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2147; }","duration":"116.974102ms","start":"2026-04-26T14:48:17.674933Z","end":"2026-04-26T14:48:17.791908Z","steps":["trace[1525459578] 'agreement among raft nodes before linearized reading' (duration: 116.831627ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:48:18.14451Z","caller":"traceutil/trace.go:171","msg":"trace[2016440660] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"130.33036ms","start":"2026-04-26T14:48:18.014149Z","end":"2026-04-26T14:48:18.14448Z","steps":["trace[2016440660] 'process raft request' (duration: 30.813108ms)","trace[2016440660] 'compare' (duration: 99.194181ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:48:18.144905Z","caller":"traceutil/trace.go:171","msg":"trace[835104662] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"130.61306ms","start":"2026-04-26T14:48:18.014267Z","end":"2026-04-26T14:48:18.14488Z","steps":["trace[835104662] 'process raft request' (duration: 130.02658ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:48:18.145095Z","caller":"traceutil/trace.go:171","msg":"trace[1280590621] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"126.274167ms","start":"2026-04-26T14:48:18.018811Z","end":"2026-04-26T14:48:18.145085Z","steps":["trace[1280590621] 'process raft request' (duration: 125.646176ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:48:18.145119Z","caller":"traceutil/trace.go:171","msg":"trace[47429598] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"130.825337ms","start":"2026-04-26T14:48:18.014278Z","end":"2026-04-26T14:48:18.145104Z","steps":["trace[47429598] 'process raft request' (duration: 130.062681ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:48:18.145528Z","caller":"traceutil/trace.go:171","msg":"trace[820870908] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"129.939816ms","start":"2026-04-26T14:48:18.015572Z","end":"2026-04-26T14:48:18.145512Z","steps":["trace[820870908] 'process raft request' (duration: 128.806807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:48:21.717359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.395728ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:48:21.717459Z","caller":"traceutil/trace.go:171","msg":"trace[788208332] transaction","detail":"{read_only:false; response_revision:2243; number_of_response:1; }","duration":"137.119812ms","start":"2026-04-26T14:48:21.580321Z","end":"2026-04-26T14:48:21.71744Z","steps":["trace[788208332] 'process raft request' (duration: 14.567729ms)","trace[788208332] 'compare' (duration: 122.282064ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:48:21.754199Z","caller":"traceutil/trace.go:171","msg":"trace[468477571] transaction","detail":"{read_only:false; response_revision:2244; number_of_response:1; }","duration":"172.90181ms","start":"2026-04-26T14:48:21.581266Z","end":"2026-04-26T14:48:21.754168Z","steps":["trace[468477571] 'process raft request' (duration: 172.672842ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:48:21.754285Z","caller":"traceutil/trace.go:171","msg":"trace[993370280] transaction","detail":"{read_only:false; response_revision:2247; number_of_response:1; }","duration":"166.970952ms","start":"2026-04-26T14:48:21.587286Z","end":"2026-04-26T14:48:21.754257Z","steps":["trace[993370280] 'process raft request' (duration: 166.902229ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:48:21.75463Z","caller":"traceutil/trace.go:171","msg":"trace[1930931614] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"172.28913ms","start":"2026-04-26T14:48:21.582312Z","end":"2026-04-26T14:48:21.754601Z","steps":["trace[1930931614] 'process raft request' (duration: 171.830504ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:48:21.754851Z","caller":"traceutil/trace.go:171","msg":"trace[848093449] transaction","detail":"{read_only:false; response_revision:2245; number_of_response:1; }","duration":"173.099627ms","start":"2026-04-26T14:48:21.58174Z","end":"2026-04-26T14:48:21.754839Z","steps":["trace[848093449] 'process raft request' (duration: 172.356492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:48:22.380406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.140177ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:48:22.380553Z","caller":"traceutil/trace.go:171","msg":"trace[1258552152] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2247; }","duration":"340.310823ms","start":"2026-04-26T14:48:22.040222Z","end":"2026-04-26T14:48:22.380533Z","steps":["trace[1258552152] 'range keys from in-memory index tree' (duration: 340.118866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:48:22.380912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.071658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-26T14:48:22.380995Z","caller":"traceutil/trace.go:171","msg":"trace[1107113512] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2247; }","duration":"532.191952ms","start":"2026-04-26T14:48:21.848782Z","end":"2026-04-26T14:48:22.380974Z","steps":["trace[1107113512] 'range keys from in-memory index tree' (duration: 531.81295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:48:22.381037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:48:21.848768Z","time spent":"532.257015ms","remote":"127.0.0.1:40756","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":"info","ts":"2026-04-26T14:48:22.381136Z","caller":"traceutil/trace.go:171","msg":"trace[1718842211] linearizableReadLoop","detail":"{readStateIndex:2336; appliedIndex:2335; }","duration":"203.813347ms","start":"2026-04-26T14:48:22.17731Z","end":"2026-04-26T14:48:22.381123Z","steps":["trace[1718842211] 'read index received' (duration: 120.509177ms)","trace[1718842211] 'applied index is now lower than readState.Index' (duration: 83.3031ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:48:22.381558Z","caller":"traceutil/trace.go:171","msg":"trace[2074518761] transaction","detail":"{read_only:false; response_revision:2248; number_of_response:1; }","duration":"360.570991ms","start":"2026-04-26T14:48:22.020753Z","end":"2026-04-26T14:48:22.381324Z","steps":["trace[2074518761] 'process raft request' (duration: 277.128077ms)","trace[2074518761] 'compare' (duration: 83.041511ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:48:22.381685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:48:22.020729Z","time spent":"360.890402ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:48:22.381871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.489563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:48:22.381948Z","caller":"traceutil/trace.go:171","msg":"trace[1023632714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2248; }","duration":"195.590057ms","start":"2026-04-26T14:48:22.186332Z","end":"2026-04-26T14:48:22.381922Z","steps":["trace[1023632714] 'agreement among raft nodes before linearized reading' (duration: 195.477803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:48:22.381974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.78174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-46686300-3991-46a7-b840-8785d8a2b363\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-26T14:48:22.382055Z","caller":"traceutil/trace.go:171","msg":"trace[956305478] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-46686300-3991-46a7-b840-8785d8a2b363; range_end:; response_count:1; response_revision:2248; }","duration":"174.887024ms","start":"2026-04-26T14:48:22.20715Z","end":"2026-04-26T14:48:22.382037Z","steps":["trace[956305478] 'agreement among raft nodes before linearized reading' (duration: 174.702688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:48:22.382004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.671826ms","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-04-26T14:48:22.382119Z","caller":"traceutil/trace.go:171","msg":"trace[483588474] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2248; }","duration":"204.851622ms","start":"2026-04-26T14:48:22.177251Z","end":"2026-04-26T14:48:22.382103Z","steps":["trace[483588474] 'agreement among raft nodes before linearized reading' (duration: 204.595463ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:48:37.697521Z","caller":"traceutil/trace.go:171","msg":"trace[590842055] transaction","detail":"{read_only:false; response_revision:2386; number_of_response:1; }","duration":"100.480105ms","start":"2026-04-26T14:48:37.597015Z","end":"2026-04-26T14:48:37.697496Z","steps":["trace[590842055] 'process raft request' (duration: 100.334141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:48:40.63917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.170292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-26T14:48:40.639288Z","caller":"traceutil/trace.go:171","msg":"trace[557084142] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2408; }","duration":"110.334846ms","start":"2026-04-26T14:48:40.528933Z","end":"2026-04-26T14:48:40.639268Z","steps":["trace[557084142] 'range keys from in-memory index tree' (duration: 109.999957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:48:44.681781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.42917ms","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-04-26T14:48:44.681854Z","caller":"traceutil/trace.go:171","msg":"trace[2061487004] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2449; }","duration":"138.549493ms","start":"2026-04-26T14:48:44.54329Z","end":"2026-04-26T14:48:44.68184Z","steps":["trace[2061487004] 'range keys from in-memory index tree' (duration: 138.262616ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:48:45.176413Z","caller":"traceutil/trace.go:171","msg":"trace[1397435914] linearizableReadLoop","detail":"{readStateIndex:2546; appliedIndex:2545; }","duration":"189.026861ms","start":"2026-04-26T14:48:44.987371Z","end":"2026-04-26T14:48:45.176398Z","steps":["trace[1397435914] 'read index received' (duration: 188.879367ms)","trace[1397435914] 'applied index is now lower than readState.Index' (duration: 147.114µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:48:45.176497Z","caller":"traceutil/trace.go:171","msg":"trace[545550328] transaction","detail":"{read_only:false; response_revision:2453; number_of_response:1; }","duration":"216.957905ms","start":"2026-04-26T14:48:44.959506Z","end":"2026-04-26T14:48:45.176464Z","steps":["trace[545550328] 'process raft request' (duration: 216.794891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:48:45.176555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.172994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-26T14:48:45.176576Z","caller":"traceutil/trace.go:171","msg":"trace[293797158] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2453; }","duration":"189.231736ms","start":"2026-04-26T14:48:44.987337Z","end":"2026-04-26T14:48:45.176569Z","steps":["trace[293797158] 'agreement among raft nodes before linearized reading' (duration: 189.125523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:49:05.983758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.40512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-26T14:49:05.983826Z","caller":"traceutil/trace.go:171","msg":"trace[348786681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2574; }","duration":"123.514961ms","start":"2026-04-26T14:49:05.860297Z","end":"2026-04-26T14:49:05.983812Z","steps":["trace[348786681] 'range keys from in-memory index tree' (duration: 123.204336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:49:05.983748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.985904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-26T14:49:05.983768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.987289ms","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-04-26T14:49:05.983927Z","caller":"traceutil/trace.go:171","msg":"trace[573386898] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:2574; }","duration":"304.206858ms","start":"2026-04-26T14:49:05.679692Z","end":"2026-04-26T14:49:05.983899Z","steps":["trace[573386898] 'range keys from in-memory index tree' (duration: 303.77638ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:49:05.984016Z","caller":"traceutil/trace.go:171","msg":"trace[1898211974] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2574; }","duration":"156.221873ms","start":"2026-04-26T14:49:05.82773Z","end":"2026-04-26T14:49:05.983952Z","steps":["trace[1898211974] 'range keys from in-memory index tree' (duration: 155.830736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:49:05.984017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:49:05.679666Z","time spent":"304.3212ms","remote":"127.0.0.1:40482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.25\" "} {"level":"info","ts":"2026-04-26T14:49:06.132298Z","caller":"traceutil/trace.go:171","msg":"trace[751475624] transaction","detail":"{read_only:false; response_revision:2575; number_of_response:1; }","duration":"145.962156ms","start":"2026-04-26T14:49:05.986315Z","end":"2026-04-26T14:49:06.132277Z","steps":["trace[751475624] 'process raft request' (duration: 145.61372ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:49:06.132758Z","caller":"traceutil/trace.go:171","msg":"trace[1615794156] transaction","detail":"{read_only:false; response_revision:2576; number_of_response:1; }","duration":"144.929119ms","start":"2026-04-26T14:49:05.987816Z","end":"2026-04-26T14:49:06.132746Z","steps":["trace[1615794156] 'process raft request' (duration: 144.271697ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:49:06.132881Z","caller":"traceutil/trace.go:171","msg":"trace[35365817] transaction","detail":"{read_only:false; response_revision:2577; number_of_response:1; }","duration":"144.735794ms","start":"2026-04-26T14:49:05.988136Z","end":"2026-04-26T14:49:06.132872Z","steps":["trace[35365817] 'process raft request' (duration: 144.575891ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:49:06.178554Z","caller":"traceutil/trace.go:171","msg":"trace[682993615] transaction","detail":"{read_only:false; response_revision:2578; number_of_response:1; }","duration":"110.905537ms","start":"2026-04-26T14:49:06.067624Z","end":"2026-04-26T14:49:06.178529Z","steps":["trace[682993615] 'process raft request' (duration: 110.777724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:49:07.231887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.470492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-26T14:49:07.232Z","caller":"traceutil/trace.go:171","msg":"trace[239245932] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2583; }","duration":"211.895081ms","start":"2026-04-26T14:49:07.02008Z","end":"2026-04-26T14:49:07.231975Z","steps":["trace[239245932] 'count revisions from in-memory index tree' (duration: 211.400991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:49:07.7534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.329972ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:49:07.753502Z","caller":"traceutil/trace.go:171","msg":"trace[1638104117] linearizableReadLoop","detail":"{readStateIndex:2684; appliedIndex:2683; }","duration":"272.133458ms","start":"2026-04-26T14:49:07.481351Z","end":"2026-04-26T14:49:07.753484Z","steps":["trace[1638104117] 'read index received' (duration: 7.570343ms)","trace[1638104117] 'applied index is now lower than readState.Index' (duration: 264.562075ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:49:07.753768Z","caller":"traceutil/trace.go:171","msg":"trace[1900515155] transaction","detail":"{read_only:false; response_revision:2585; number_of_response:1; }","duration":"337.936057ms","start":"2026-04-26T14:49:07.415817Z","end":"2026-04-26T14:49:07.753753Z","steps":["trace[1900515155] 'process raft request' (duration: 73.155217ms)","trace[1900515155] 'compare' (duration: 264.144459ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:49:07.753831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.117018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-26T14:49:07.753855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:49:07.415791Z","time spent":"338.015438ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T14:49:07.753893Z","caller":"traceutil/trace.go:171","msg":"trace[1000682647] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2585; }","duration":"110.180239ms","start":"2026-04-26T14:49:07.643699Z","end":"2026-04-26T14:49:07.753879Z","steps":["trace[1000682647] 'agreement among raft nodes before linearized reading' (duration: 110.018406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:49:07.754008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.660737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:49:07.754042Z","caller":"traceutil/trace.go:171","msg":"trace[1138122375] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:2585; }","duration":"272.735168ms","start":"2026-04-26T14:49:07.481297Z","end":"2026-04-26T14:49:07.754032Z","steps":["trace[1138122375] 'agreement among raft nodes before linearized reading' (duration: 272.684198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:28.192263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.006866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-26T14:50:28.192342Z","caller":"traceutil/trace.go:171","msg":"trace[1115770735] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3126; }","duration":"143.161618ms","start":"2026-04-26T14:50:28.049165Z","end":"2026-04-26T14:50:28.192326Z","steps":["trace[1115770735] 'range keys from in-memory index tree' (duration: 142.773005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:28.192376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.945381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:50:28.192417Z","caller":"traceutil/trace.go:171","msg":"trace[865109971] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:3126; }","duration":"379.038471ms","start":"2026-04-26T14:50:27.813369Z","end":"2026-04-26T14:50:28.192407Z","steps":["trace[865109971] 'count revisions from in-memory index tree' (duration: 378.87283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:28.192444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:27.813349Z","time spent":"379.087271ms","remote":"127.0.0.1:37240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-26T14:50:28.19259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.230613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-165e1039-0b87-48ba-bbd7-8a480dd6db3e\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-26T14:50:28.192636Z","caller":"traceutil/trace.go:171","msg":"trace[1206133745] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-165e1039-0b87-48ba-bbd7-8a480dd6db3e; range_end:; response_count:1; response_revision:3126; }","duration":"221.313594ms","start":"2026-04-26T14:50:27.97131Z","end":"2026-04-26T14:50:28.192624Z","steps":["trace[1206133745] 'range keys from in-memory index tree' (duration: 220.74713ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:28.192865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.658086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-165e1039-0b87-48ba-bbd7-8a480dd6db3e\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-26T14:50:28.192894Z","caller":"traceutil/trace.go:171","msg":"trace[1403932451] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-165e1039-0b87-48ba-bbd7-8a480dd6db3e; range_end:; response_count:1; response_revision:3126; }","duration":"138.710266ms","start":"2026-04-26T14:50:28.054176Z","end":"2026-04-26T14:50:28.192886Z","steps":["trace[1403932451] 'range keys from in-memory index tree' (duration: 138.562596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:28.193991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.081757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:50:28.19409Z","caller":"traceutil/trace.go:171","msg":"trace[712723768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3126; }","duration":"359.636258ms","start":"2026-04-26T14:50:27.834433Z","end":"2026-04-26T14:50:28.194069Z","steps":["trace[712723768] 'range keys from in-memory index tree' (duration: 357.980966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:28.194139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:27.834414Z","time spent":"359.712858ms","remote":"127.0.0.1:40466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-26T14:50:28.349248Z","caller":"traceutil/trace.go:171","msg":"trace[21319833] transaction","detail":"{read_only:false; response_revision:3127; number_of_response:1; }","duration":"149.755212ms","start":"2026-04-26T14:50:28.199469Z","end":"2026-04-26T14:50:28.349224Z","steps":["trace[21319833] 'process raft request' (duration: 149.023388ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:28.427165Z","caller":"traceutil/trace.go:171","msg":"trace[509344071] linearizableReadLoop","detail":"{readStateIndex:3244; appliedIndex:3242; }","duration":"224.822745ms","start":"2026-04-26T14:50:28.2023Z","end":"2026-04-26T14:50:28.427123Z","steps":["trace[509344071] 'read index received' (duration: 146.107668ms)","trace[509344071] 'applied index is now lower than readState.Index' (duration: 78.714027ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:28.427225Z","caller":"traceutil/trace.go:171","msg":"trace[1555000013] transaction","detail":"{read_only:false; response_revision:3128; number_of_response:1; }","duration":"225.592061ms","start":"2026-04-26T14:50:28.201585Z","end":"2026-04-26T14:50:28.427177Z","steps":["trace[1555000013] 'process raft request' (duration: 209.701092ms)","trace[1555000013] 'compare' (duration: 15.760608ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:50:28.427366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.050467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1319"} {"level":"info","ts":"2026-04-26T14:50:28.4274Z","caller":"traceutil/trace.go:171","msg":"trace[1674856492] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:3128; }","duration":"225.117377ms","start":"2026-04-26T14:50:28.202275Z","end":"2026-04-26T14:50:28.427393Z","steps":["trace[1674856492] 'agreement among raft nodes before linearized reading' (duration: 224.990436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:28.427366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.582486ms","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-04-26T14:50:28.427501Z","caller":"traceutil/trace.go:171","msg":"trace[579533909] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3128; }","duration":"176.748807ms","start":"2026-04-26T14:50:28.25074Z","end":"2026-04-26T14:50:28.427488Z","steps":["trace[579533909] 'agreement among raft nodes before linearized reading' (duration: 176.553105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.202796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.089846ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:50:40.203021Z","caller":"traceutil/trace.go:171","msg":"trace[2064903368] linearizableReadLoop","detail":"{readStateIndex:3337; appliedIndex:3336; }","duration":"807.006875ms","start":"2026-04-26T14:50:39.395999Z","end":"2026-04-26T14:50:40.203006Z","steps":["trace[2064903368] 'read index received' (duration: 239.584607ms)","trace[2064903368] 'applied index is now lower than readState.Index' (duration: 567.421418ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:40.203502Z","caller":"traceutil/trace.go:171","msg":"trace[1882100048] transaction","detail":"{read_only:false; response_revision:3218; number_of_response:1; }","duration":"899.767717ms","start":"2026-04-26T14:50:39.303714Z","end":"2026-04-26T14:50:40.203482Z","steps":["trace[1882100048] 'process raft request' (duration: 331.891086ms)","trace[1882100048] 'compare' (duration: 561.26272ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:50:40.203794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:39.303688Z","time spent":"899.862507ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T14:50:40.204166Z","caller":"traceutil/trace.go:171","msg":"trace[1718097068] transaction","detail":"{read_only:false; response_revision:3219; number_of_response:1; }","duration":"769.931517ms","start":"2026-04-26T14:50:39.434222Z","end":"2026-04-26T14:50:40.204153Z","steps":["trace[1718097068] 'process raft request' (duration: 768.69911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.204237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:39.434195Z","time spent":"770.009617ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:50:40.204585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.461513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-26T14:50:40.20466Z","caller":"traceutil/trace.go:171","msg":"trace[815098863] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3220; }","duration":"154.565195ms","start":"2026-04-26T14:50:40.050083Z","end":"2026-04-26T14:50:40.204648Z","steps":["trace[815098863] 'agreement among raft nodes before linearized reading' (duration: 154.389284ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:40.204954Z","caller":"traceutil/trace.go:171","msg":"trace[706876500] transaction","detail":"{read_only:false; response_revision:3220; number_of_response:1; }","duration":"369.779499ms","start":"2026-04-26T14:50:39.835141Z","end":"2026-04-26T14:50:40.204921Z","steps":["trace[706876500] 'process raft request' (duration: 368.955324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.205046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:39.835115Z","time spent":"369.88428ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:50:40.205166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.138567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-26T14:50:40.205279Z","caller":"traceutil/trace.go:171","msg":"trace[2082835796] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3220; }","duration":"809.278048ms","start":"2026-04-26T14:50:39.395946Z","end":"2026-04-26T14:50:40.205224Z","steps":["trace[2082835796] 'agreement among raft nodes before linearized reading' (duration: 808.090211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.205395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:39.395926Z","time spent":"809.450689ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-26T14:50:40.508981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.455971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:50:40.509066Z","caller":"traceutil/trace.go:171","msg":"trace[596757968] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:3221; }","duration":"134.552072ms","start":"2026-04-26T14:50:40.374497Z","end":"2026-04-26T14:50:40.509049Z","steps":["trace[596757968] 'count revisions from in-memory index tree' (duration: 134.361171ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:41.030207Z","caller":"traceutil/trace.go:171","msg":"trace[736658553] transaction","detail":"{read_only:false; response_revision:3225; number_of_response:1; }","duration":"186.208857ms","start":"2026-04-26T14:50:40.843978Z","end":"2026-04-26T14:50:41.030186Z","steps":["trace[736658553] 'process raft request' (duration: 186.082716ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:41.225954Z","caller":"traceutil/trace.go:171","msg":"trace[457102748] transaction","detail":"{read_only:false; response_revision:3227; number_of_response:1; }","duration":"144.111873ms","start":"2026-04-26T14:50:41.081816Z","end":"2026-04-26T14:50:41.225928Z","steps":["trace[457102748] 'process raft request' (duration: 88.598877ms)","trace[457102748] 'compare' (duration: 55.298525ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:50:42.182386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.429388ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:50:42.182499Z","caller":"traceutil/trace.go:171","msg":"trace[913121815] linearizableReadLoop","detail":"{readStateIndex:3351; appliedIndex:3350; }","duration":"135.480402ms","start":"2026-04-26T14:50:42.046999Z","end":"2026-04-26T14:50:42.18248Z","steps":["trace[913121815] 'read index received' (duration: 18.816752ms)","trace[913121815] 'applied index is now lower than readState.Index' (duration: 116.66217ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:42.182561Z","caller":"traceutil/trace.go:171","msg":"trace[374872068] transaction","detail":"{read_only:false; response_revision:3231; number_of_response:1; }","duration":"144.652818ms","start":"2026-04-26T14:50:42.037888Z","end":"2026-04-26T14:50:42.182541Z","steps":["trace[374872068] 'process raft request' (duration: 27.977678ms)","trace[374872068] 'compare' (duration: 116.322488ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:50:42.18272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.720595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-04-26T14:50:42.18276Z","caller":"traceutil/trace.go:171","msg":"trace[837484077] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:3231; }","duration":"135.779545ms","start":"2026-04-26T14:50:42.046965Z","end":"2026-04-26T14:50:42.182745Z","steps":["trace[837484077] 'agreement among raft nodes before linearized reading' (duration: 135.607524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:42.183004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.214164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-26T14:50:42.18304Z","caller":"traceutil/trace.go:171","msg":"trace[349770473] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3231; }","duration":"134.263875ms","start":"2026-04-26T14:50:42.048765Z","end":"2026-04-26T14:50:42.183029Z","steps":["trace[349770473] 'agreement among raft nodes before linearized reading' (duration: 134.150155ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:42.365936Z","caller":"traceutil/trace.go:171","msg":"trace[44255038] transaction","detail":"{read_only:false; response_revision:3234; number_of_response:1; }","duration":"152.397955ms","start":"2026-04-26T14:50:42.213486Z","end":"2026-04-26T14:50:42.365884Z","steps":["trace[44255038] 'process raft request' (duration: 80.497263ms)","trace[44255038] 'compare' (duration: 71.720481ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:42.3661Z","caller":"traceutil/trace.go:171","msg":"trace[59878155] linearizableReadLoop","detail":"{readStateIndex:3355; appliedIndex:3353; }","duration":"143.395621ms","start":"2026-04-26T14:50:42.222665Z","end":"2026-04-26T14:50:42.366061Z","steps":["trace[59878155] 'read index received' (duration: 71.244817ms)","trace[59878155] 'applied index is now lower than readState.Index' (duration: 72.149694ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:42.366303Z","caller":"traceutil/trace.go:171","msg":"trace[146108321] transaction","detail":"{read_only:false; response_revision:3235; number_of_response:1; }","duration":"152.043222ms","start":"2026-04-26T14:50:42.214242Z","end":"2026-04-26T14:50:42.366286Z","steps":["trace[146108321] 'process raft request' (duration: 151.60228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:42.366528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.233834ms","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:5"} {"level":"warn","ts":"2026-04-26T14:50:42.36654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.640435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-26T14:50:42.366595Z","caller":"traceutil/trace.go:171","msg":"trace[412939348] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:3235; }","duration":"147.336535ms","start":"2026-04-26T14:50:42.219244Z","end":"2026-04-26T14:50:42.366581Z","steps":["trace[412939348] 'agreement among raft nodes before linearized reading' (duration: 147.204384ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:42.366595Z","caller":"traceutil/trace.go:171","msg":"trace[372308774] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3235; }","duration":"120.739605ms","start":"2026-04-26T14:50:42.245843Z","end":"2026-04-26T14:50:42.366583Z","steps":["trace[372308774] 'agreement among raft nodes before linearized reading' (duration: 120.581054ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:12.502474Z","caller":"traceutil/trace.go:171","msg":"trace[2096260552] transaction","detail":"{read_only:false; response_revision:3468; number_of_response:1; }","duration":"109.098878ms","start":"2026-04-26T14:51:12.393352Z","end":"2026-04-26T14:51:12.502451Z","steps":["trace[2096260552] 'process raft request' (duration: 16.427188ms)","trace[2096260552] 'compare' (duration: 92.184908ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:12.502745Z","caller":"traceutil/trace.go:171","msg":"trace[330822453] transaction","detail":"{read_only:false; response_revision:3469; number_of_response:1; }","duration":"109.030407ms","start":"2026-04-26T14:51:12.393701Z","end":"2026-04-26T14:51:12.502731Z","steps":["trace[330822453] 'process raft request' (duration: 108.384065ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:12.503037Z","caller":"traceutil/trace.go:171","msg":"trace[1221921472] transaction","detail":"{read_only:false; response_revision:3470; number_of_response:1; }","duration":"108.979278ms","start":"2026-04-26T14:51:12.394047Z","end":"2026-04-26T14:51:12.503026Z","steps":["trace[1221921472] 'process raft request' (duration: 108.070014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:17.133052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.406982ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:51:17.133159Z","caller":"traceutil/trace.go:171","msg":"trace[839394218] linearizableReadLoop","detail":"{readStateIndex:3658; appliedIndex:3657; }","duration":"122.456841ms","start":"2026-04-26T14:51:17.010686Z","end":"2026-04-26T14:51:17.133143Z","steps":["trace[839394218] 'read index received' (duration: 1.803088ms)","trace[839394218] 'applied index is now lower than readState.Index' (duration: 120.652223ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:17.133244Z","caller":"traceutil/trace.go:171","msg":"trace[646320650] transaction","detail":"{read_only:false; response_revision:3529; number_of_response:1; }","duration":"283.273204ms","start":"2026-04-26T14:51:16.849945Z","end":"2026-04-26T14:51:17.133218Z","steps":["trace[646320650] 'process raft request' (duration: 162.600431ms)","trace[646320650] 'compare' (duration: 120.11226ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:51:17.133321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.636132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-26T14:51:17.133362Z","caller":"traceutil/trace.go:171","msg":"trace[1370316704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3529; }","duration":"122.701462ms","start":"2026-04-26T14:51:17.010648Z","end":"2026-04-26T14:51:17.13335Z","steps":["trace[1370316704] 'agreement among raft nodes before linearized reading' (duration: 122.538312ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:23.404407Z","caller":"traceutil/trace.go:171","msg":"trace[974085846] transaction","detail":"{read_only:false; response_revision:3564; number_of_response:1; }","duration":"110.208715ms","start":"2026-04-26T14:51:23.294174Z","end":"2026-04-26T14:51:23.404383Z","steps":["trace[974085846] 'process raft request' (duration: 100.813234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:29.18308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.141997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-26T14:51:29.183193Z","caller":"traceutil/trace.go:171","msg":"trace[266300344] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3598; }","duration":"262.328597ms","start":"2026-04-26T14:51:28.920845Z","end":"2026-04-26T14:51:29.183174Z","steps":["trace[266300344] 'range keys from in-memory index tree' (duration: 261.918315ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:29.405813Z","caller":"traceutil/trace.go:171","msg":"trace[1018624223] linearizableReadLoop","detail":"{readStateIndex:3731; appliedIndex:3730; }","duration":"107.156866ms","start":"2026-04-26T14:51:29.298629Z","end":"2026-04-26T14:51:29.405786Z","steps":["trace[1018624223] 'read index received' (duration: 16.49108ms)","trace[1018624223] 'applied index is now lower than readState.Index' (duration: 90.664826ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:29.405872Z","caller":"traceutil/trace.go:171","msg":"trace[1490551410] transaction","detail":"{read_only:false; response_revision:3600; number_of_response:1; }","duration":"121.315977ms","start":"2026-04-26T14:51:29.28453Z","end":"2026-04-26T14:51:29.405846Z","steps":["trace[1490551410] 'process raft request' (duration: 30.67539ms)","trace[1490551410] 'compare' (duration: 90.473736ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:51:29.405996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.359317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-26T14:51:29.406028Z","caller":"traceutil/trace.go:171","msg":"trace[2140189946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3600; }","duration":"107.443347ms","start":"2026-04-26T14:51:29.298574Z","end":"2026-04-26T14:51:29.406018Z","steps":["trace[2140189946] 'agreement among raft nodes before linearized reading' (duration: 107.306957ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:29.867911Z","caller":"traceutil/trace.go:171","msg":"trace[1155945562] transaction","detail":"{read_only:false; response_revision:3601; number_of_response:1; }","duration":"456.20337ms","start":"2026-04-26T14:51:29.411692Z","end":"2026-04-26T14:51:29.867896Z","steps":["trace[1155945562] 'process raft request' (duration: 455.875589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:29.868178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:29.411673Z","time spent":"456.369341ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:51:29.868298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.609272ms","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-04-26T14:51:29.86836Z","caller":"traceutil/trace.go:171","msg":"trace[1306699587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3601; }","duration":"428.719313ms","start":"2026-04-26T14:51:29.439625Z","end":"2026-04-26T14:51:29.868345Z","steps":["trace[1306699587] 'agreement among raft nodes before linearized reading' (duration: 428.536642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:29.868392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:29.439607Z","time spent":"428.779233ms","remote":"127.0.0.1:40756","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":"info","ts":"2026-04-26T14:51:29.867847Z","caller":"traceutil/trace.go:171","msg":"trace[24098515] linearizableReadLoop","detail":"{readStateIndex:3732; appliedIndex:3731; }","duration":"428.153011ms","start":"2026-04-26T14:51:29.439669Z","end":"2026-04-26T14:51:29.867822Z","steps":["trace[24098515] 'read index received' (duration: 427.92234ms)","trace[24098515] 'applied index is now lower than readState.Index' (duration: 229.661µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:29.943495Z","caller":"traceutil/trace.go:171","msg":"trace[115166813] transaction","detail":"{read_only:false; response_revision:3602; number_of_response:1; }","duration":"434.362038ms","start":"2026-04-26T14:51:29.509107Z","end":"2026-04-26T14:51:29.943469Z","steps":["trace[115166813] 'process raft request' (duration: 434.110927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:29.943657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:29.509083Z","time spent":"434.491628ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:51:30.168342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.75715ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:51:30.168931Z","caller":"traceutil/trace.go:171","msg":"trace[835277118] linearizableReadLoop","detail":"{readStateIndex:3734; appliedIndex:3733; }","duration":"292.166109ms","start":"2026-04-26T14:51:29.876744Z","end":"2026-04-26T14:51:30.16891Z","steps":["trace[835277118] 'read index received' (duration: 66.694654ms)","trace[835277118] 'applied index is now lower than readState.Index' (duration: 225.469965ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:30.169129Z","caller":"traceutil/trace.go:171","msg":"trace[842666916] transaction","detail":"{read_only:false; response_revision:3603; number_of_response:1; }","duration":"294.070137ms","start":"2026-04-26T14:51:29.874938Z","end":"2026-04-26T14:51:30.169008Z","steps":["trace[842666916] 'process raft request' (duration: 125.425274ms)","trace[842666916] 'compare' (duration: 167.625809ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:51:30.16934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.5931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:51:30.169447Z","caller":"traceutil/trace.go:171","msg":"trace[422154461] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:3603; }","duration":"292.742211ms","start":"2026-04-26T14:51:29.87669Z","end":"2026-04-26T14:51:30.169432Z","steps":["trace[422154461] 'agreement among raft nodes before linearized reading' (duration: 292.46739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:30.169566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.097887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-26T14:51:30.169654Z","caller":"traceutil/trace.go:171","msg":"trace[313276639] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3603; }","duration":"120.242887ms","start":"2026-04-26T14:51:30.049388Z","end":"2026-04-26T14:51:30.169631Z","steps":["trace[313276639] 'agreement among raft nodes before linearized reading' (duration: 120.019657ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:30.872156Z","caller":"traceutil/trace.go:171","msg":"trace[389532952] transaction","detail":"{read_only:false; response_revision:3605; number_of_response:1; }","duration":"220.561643ms","start":"2026-04-26T14:51:30.651568Z","end":"2026-04-26T14:51:30.872129Z","steps":["trace[389532952] 'process raft request' (duration: 209.338776ms)","trace[389532952] 'compare' (duration: 10.980116ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:30.872347Z","caller":"traceutil/trace.go:171","msg":"trace[142212705] transaction","detail":"{read_only:false; response_revision:3606; number_of_response:1; }","duration":"181.636558ms","start":"2026-04-26T14:51:30.690699Z","end":"2026-04-26T14:51:30.872336Z","steps":["trace[142212705] 'process raft request' (duration: 181.322727ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:30.872726Z","caller":"traceutil/trace.go:171","msg":"trace[181227119] linearizableReadLoop","detail":"{readStateIndex:3737; appliedIndex:3735; }","duration":"142.785374ms","start":"2026-04-26T14:51:30.729923Z","end":"2026-04-26T14:51:30.872708Z","steps":["trace[181227119] 'read index received' (duration: 130.967315ms)","trace[181227119] 'applied index is now lower than readState.Index' (duration: 11.816049ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:51:30.873057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.124027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-04-26T14:51:30.873104Z","caller":"traceutil/trace.go:171","msg":"trace[367802234] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:3606; }","duration":"143.206107ms","start":"2026-04-26T14:51:30.729885Z","end":"2026-04-26T14:51:30.873091Z","steps":["trace[367802234] 'agreement among raft nodes before linearized reading' (duration: 143.030295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:30.920151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.722263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-26T14:51:30.920235Z","caller":"traceutil/trace.go:171","msg":"trace[1671948786] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3606; }","duration":"161.817543ms","start":"2026-04-26T14:51:30.75837Z","end":"2026-04-26T14:51:30.920188Z","steps":["trace[1671948786] 'agreement among raft nodes before linearized reading' (duration: 161.680383ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:35.609087Z","caller":"traceutil/trace.go:171","msg":"trace[1951453112] transaction","detail":"{read_only:false; response_revision:3639; number_of_response:1; }","duration":"109.45055ms","start":"2026-04-26T14:51:35.499612Z","end":"2026-04-26T14:51:35.609063Z","steps":["trace[1951453112] 'process raft request' (duration: 109.285649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:44.786974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.270414ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:51:44.787175Z","caller":"traceutil/trace.go:171","msg":"trace[1137252892] transaction","detail":"{read_only:false; response_revision:3707; number_of_response:1; }","duration":"224.066568ms","start":"2026-04-26T14:51:44.563078Z","end":"2026-04-26T14:51:44.787144Z","steps":["trace[1137252892] 'process raft request' (duration: 64.532743ms)","trace[1137252892] 'compare' (duration: 159.063823ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:44.885935Z","caller":"traceutil/trace.go:171","msg":"trace[115929891] transaction","detail":"{read_only:false; response_revision:3708; number_of_response:1; }","duration":"132.45426ms","start":"2026-04-26T14:51:44.753452Z","end":"2026-04-26T14:51:44.885907Z","steps":["trace[115929891] 'process raft request' (duration: 132.309909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:45.261737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.080091ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:51:45.261887Z","caller":"traceutil/trace.go:171","msg":"trace[1853958513] transaction","detail":"{read_only:false; response_revision:3709; number_of_response:1; }","duration":"312.533839ms","start":"2026-04-26T14:51:44.949335Z","end":"2026-04-26T14:51:45.261869Z","steps":["trace[1853958513] 'process raft request' (duration: 81.254708ms)","trace[1853958513] 'compare' (duration: 230.79182ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:51:45.261945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:44.949314Z","time spent":"312.60356ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T14:51:45.262115Z","caller":"traceutil/trace.go:171","msg":"trace[298782556] linearizableReadLoop","detail":"{readStateIndex:3844; appliedIndex:3842; }","duration":"181.885149ms","start":"2026-04-26T14:51:45.080168Z","end":"2026-04-26T14:51:45.262053Z","steps":["trace[298782556] 'read index received' (duration: 95.449702ms)","trace[298782556] 'applied index is now lower than readState.Index' (duration: 86.434237ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:45.262216Z","caller":"traceutil/trace.go:171","msg":"trace[1482770043] transaction","detail":"{read_only:false; response_revision:3710; number_of_response:1; }","duration":"305.968034ms","start":"2026-04-26T14:51:44.956236Z","end":"2026-04-26T14:51:45.262204Z","steps":["trace[1482770043] 'process raft request' (duration: 305.591262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:45.26247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.296771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-26T14:51:45.262512Z","caller":"traceutil/trace.go:171","msg":"trace[909200162] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3710; }","duration":"182.376291ms","start":"2026-04-26T14:51:45.080126Z","end":"2026-04-26T14:51:45.262502Z","steps":["trace[909200162] 'agreement among raft nodes before linearized reading' (duration: 182.24147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:45.262513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:44.956211Z","time spent":"306.210154ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:51:45.86008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.02978ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:51:45.860382Z","caller":"traceutil/trace.go:171","msg":"trace[1467131024] transaction","detail":"{read_only:false; response_revision:3711; number_of_response:1; }","duration":"594.365507ms","start":"2026-04-26T14:51:45.266003Z","end":"2026-04-26T14:51:45.860369Z","steps":["trace[1467131024] 'process raft request' (duration: 208.992535ms)","trace[1467131024] 'compare' (duration: 384.94664ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:51:45.860424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:45.265981Z","time spent":"594.426658ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T14:51:45.860497Z","caller":"traceutil/trace.go:171","msg":"trace[1298429925] linearizableReadLoop","detail":"{readStateIndex:3845; appliedIndex:3844; }","duration":"548.148287ms","start":"2026-04-26T14:51:45.312343Z","end":"2026-04-26T14:51:45.860491Z","steps":["trace[1298429925] 'read index received' (duration: 162.579884ms)","trace[1298429925] 'applied index is now lower than readState.Index' (duration: 385.567853ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:51:45.860643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.300657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-26T14:51:45.860662Z","caller":"traceutil/trace.go:171","msg":"trace[589409080] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3712; }","duration":"548.343497ms","start":"2026-04-26T14:51:45.312314Z","end":"2026-04-26T14:51:45.860657Z","steps":["trace[589409080] 'agreement among raft nodes before linearized reading' (duration: 548.275187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:45.860677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:45.312298Z","time spent":"548.376017ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-26T14:51:45.860837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.927716ms","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-04-26T14:51:45.860913Z","caller":"traceutil/trace.go:171","msg":"trace[381550976] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3712; }","duration":"235.041396ms","start":"2026-04-26T14:51:45.625855Z","end":"2026-04-26T14:51:45.860896Z","steps":["trace[381550976] 'agreement among raft nodes before linearized reading' (duration: 234.821345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:45.861194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.758657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-26T14:51:45.861244Z","caller":"traceutil/trace.go:171","msg":"trace[1503183596] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:3712; }","duration":"173.838657ms","start":"2026-04-26T14:51:45.687393Z","end":"2026-04-26T14:51:45.861232Z","steps":["trace[1503183596] 'agreement among raft nodes before linearized reading' (duration: 173.711517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:46.126073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.101763ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:51:46.126184Z","caller":"traceutil/trace.go:171","msg":"trace[959891990] linearizableReadLoop","detail":"{readStateIndex:3850; appliedIndex:3849; }","duration":"149.926012ms","start":"2026-04-26T14:51:45.976242Z","end":"2026-04-26T14:51:46.126168Z","steps":["trace[959891990] 'read index received' (duration: 17.646898ms)","trace[959891990] 'applied index is now lower than readState.Index' (duration: 132.277984ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:46.126257Z","caller":"traceutil/trace.go:171","msg":"trace[1910616615] transaction","detail":"{read_only:false; response_revision:3715; number_of_response:1; }","duration":"247.746554ms","start":"2026-04-26T14:51:45.878497Z","end":"2026-04-26T14:51:46.126243Z","steps":["trace[1910616615] 'process raft request' (duration: 115.393209ms)","trace[1910616615] 'compare' (duration: 131.975612ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:51:46.126497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.238864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-26T14:51:46.126627Z","caller":"traceutil/trace.go:171","msg":"trace[1456819308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3715; }","duration":"150.411574ms","start":"2026-04-26T14:51:45.976197Z","end":"2026-04-26T14:51:46.126608Z","steps":["trace[1456819308] 'agreement among raft nodes before linearized reading' (duration: 150.046883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:46.137845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.943131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-26T14:51:46.137889Z","caller":"traceutil/trace.go:171","msg":"trace[1165983460] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:3716; }","duration":"142.029792ms","start":"2026-04-26T14:51:45.995849Z","end":"2026-04-26T14:51:46.137879Z","steps":["trace[1165983460] 'agreement among raft nodes before linearized reading' (duration: 141.948331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:46.138122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.675505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/valkey-node-0\" ","response":"range_response_count:1 size:17064"} {"level":"info","ts":"2026-04-26T14:51:46.138217Z","caller":"traceutil/trace.go:171","msg":"trace[1099152432] range","detail":"{range_begin:/registry/pods/openstack/valkey-node-0; range_end:; response_count:1; response_revision:3716; }","duration":"155.826026ms","start":"2026-04-26T14:51:45.98237Z","end":"2026-04-26T14:51:46.138196Z","steps":["trace[1099152432] 'agreement among raft nodes before linearized reading' (duration: 155.536845ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:46.449179Z","caller":"traceutil/trace.go:171","msg":"trace[1439159209] linearizableReadLoop","detail":"{readStateIndex:3852; appliedIndex:3851; }","duration":"311.412948ms","start":"2026-04-26T14:51:46.137744Z","end":"2026-04-26T14:51:46.449157Z","steps":["trace[1439159209] 'read index received' (duration: 311.027206ms)","trace[1439159209] 'applied index is now lower than readState.Index' (duration: 384.792µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:46.449466Z","caller":"traceutil/trace.go:171","msg":"trace[1569840461] transaction","detail":"{read_only:false; response_revision:3717; number_of_response:1; }","duration":"318.764717ms","start":"2026-04-26T14:51:46.130688Z","end":"2026-04-26T14:51:46.449453Z","steps":["trace[1569840461] 'process raft request' (duration: 318.344045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:46.449611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.130668Z","time spent":"318.870827ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:51:46.449613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.069965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-04-26T14:51:46.449699Z","caller":"traceutil/trace.go:171","msg":"trace[241057058] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:3717; }","duration":"321.191356ms","start":"2026-04-26T14:51:46.128485Z","end":"2026-04-26T14:51:46.449676Z","steps":["trace[241057058] 'agreement among raft nodes before linearized reading' (duration: 320.985845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:46.449748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.128469Z","time spent":"321.270016ms","remote":"127.0.0.1:40644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-04-26T14:51:46.745236Z","caller":"traceutil/trace.go:171","msg":"trace[1051567135] linearizableReadLoop","detail":"{readStateIndex:3853; appliedIndex:3852; }","duration":"295.962097ms","start":"2026-04-26T14:51:46.449246Z","end":"2026-04-26T14:51:46.745208Z","steps":["trace[1051567135] 'read index received' (duration: 283.82373ms)","trace[1051567135] 'applied index is now lower than readState.Index' (duration: 12.137137ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:51:46.745357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.889546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-26T14:51:46.746258Z","caller":"traceutil/trace.go:171","msg":"trace[1030569126] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:3718; }","duration":"551.80865ms","start":"2026-04-26T14:51:46.194428Z","end":"2026-04-26T14:51:46.746236Z","steps":["trace[1030569126] 'agreement among raft nodes before linearized reading' (duration: 550.807885ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:46.7465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.194374Z","time spent":"552.09066ms","remote":"127.0.0.1:38648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":4,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-04-26T14:51:46.745584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.178415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a9efa9fe444423\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-04-26T14:51:46.747937Z","caller":"traceutil/trace.go:171","msg":"trace[993516779] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a9efa9fe444423; range_end:; response_count:1; response_revision:3718; }","duration":"377.574184ms","start":"2026-04-26T14:51:46.370339Z","end":"2026-04-26T14:51:46.747913Z","steps":["trace[993516779] 'agreement among raft nodes before linearized reading' (duration: 374.891173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:46.747998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.370322Z","time spent":"377.657434ms","remote":"127.0.0.1:40528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":804,"request content":"key:\"/registry/events/auth-system/keycloak-0.18a9efa9fe444423\" "} {"level":"warn","ts":"2026-04-26T14:51:46.745476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.54278ms","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-04-26T14:51:46.745664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.349624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1447"} {"level":"info","ts":"2026-04-26T14:51:46.748638Z","caller":"traceutil/trace.go:171","msg":"trace[1504614477] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:3718; }","duration":"607.341855ms","start":"2026-04-26T14:51:46.141281Z","end":"2026-04-26T14:51:46.748623Z","steps":["trace[1504614477] 'agreement among raft nodes before linearized reading' (duration: 604.219503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:46.748686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.141265Z","time spent":"607.406415ms","remote":"127.0.0.1:40674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":1470,"request content":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" "} {"level":"info","ts":"2026-04-26T14:51:46.748075Z","caller":"traceutil/trace.go:171","msg":"trace[897056660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3718; }","duration":"495.189161ms","start":"2026-04-26T14:51:46.252869Z","end":"2026-04-26T14:51:46.748058Z","steps":["trace[897056660] 'agreement among raft nodes before linearized reading' (duration: 492.41167ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:46.745734Z","caller":"traceutil/trace.go:171","msg":"trace[1521049943] transaction","detail":"{read_only:false; response_revision:3718; number_of_response:1; }","duration":"593.930983ms","start":"2026-04-26T14:51:46.151781Z","end":"2026-04-26T14:51:46.745712Z","steps":["trace[1521049943] 'process raft request' (duration: 581.403934ms)","trace[1521049943] 'compare' (duration: 11.898285ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:51:46.748827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.252848Z","time spent":"495.923243ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-26T14:51:46.748897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.151755Z","time spent":"597.089375ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17049,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:51:46.746002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.076243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-11e448ea-2eba-4e5f-a716-7ab07d8fd195\" ","response":"range_response_count:1 size:1293"} {"level":"info","ts":"2026-04-26T14:51:46.749068Z","caller":"traceutil/trace.go:171","msg":"trace[233610831] range","detail":"{range_begin:/registry/persistentvolumes/pvc-11e448ea-2eba-4e5f-a716-7ab07d8fd195; range_end:; response_count:1; response_revision:3718; }","duration":"607.176964ms","start":"2026-04-26T14:51:46.141878Z","end":"2026-04-26T14:51:46.749055Z","steps":["trace[233610831] 'agreement among raft nodes before linearized reading' (duration: 603.3884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:46.749106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.141868Z","time spent":"607.229385ms","remote":"127.0.0.1:40628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1316,"request content":"key:\"/registry/persistentvolumes/pvc-11e448ea-2eba-4e5f-a716-7ab07d8fd195\" "} {"level":"warn","ts":"2026-04-26T14:51:46.74614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.567012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-26T14:51:46.749291Z","caller":"traceutil/trace.go:171","msg":"trace[1650783688] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:3718; }","duration":"297.730454ms","start":"2026-04-26T14:51:46.451551Z","end":"2026-04-26T14:51:46.749281Z","steps":["trace[1650783688] 'agreement among raft nodes before linearized reading' (duration: 294.465412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:47.129629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.743097ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:51:47.129975Z","caller":"traceutil/trace.go:171","msg":"trace[849451229] transaction","detail":"{read_only:false; response_revision:3722; number_of_response:1; }","duration":"238.995985ms","start":"2026-04-26T14:51:46.890958Z","end":"2026-04-26T14:51:47.129954Z","steps":["trace[849451229] 'process raft request' (duration: 238.950174ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:47.130373Z","caller":"traceutil/trace.go:171","msg":"trace[453001150] transaction","detail":"{read_only:false; response_revision:3721; number_of_response:1; }","duration":"256.05367ms","start":"2026-04-26T14:51:46.874305Z","end":"2026-04-26T14:51:47.130359Z","steps":["trace[453001150] 'process raft request' (duration: 255.552488ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:47.130485Z","caller":"traceutil/trace.go:171","msg":"trace[1815174470] linearizableReadLoop","detail":"{readStateIndex:3855; appliedIndex:3854; }","duration":"355.276985ms","start":"2026-04-26T14:51:46.775185Z","end":"2026-04-26T14:51:47.130462Z","steps":["trace[1815174470] 'read index received' (duration: 86.640815ms)","trace[1815174470] 'applied index is now lower than readState.Index' (duration: 268.63358ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:47.130531Z","caller":"traceutil/trace.go:171","msg":"trace[1766965985] transaction","detail":"{read_only:false; response_revision:3720; number_of_response:1; }","duration":"354.250022ms","start":"2026-04-26T14:51:46.776251Z","end":"2026-04-26T14:51:47.130501Z","steps":["trace[1766965985] 'process raft request' (duration: 353.513229ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:47.130531Z","caller":"traceutil/trace.go:171","msg":"trace[2072950408] transaction","detail":"{read_only:false; response_revision:3719; number_of_response:1; }","duration":"375.059693ms","start":"2026-04-26T14:51:46.755448Z","end":"2026-04-26T14:51:47.130508Z","steps":["trace[2072950408] 'process raft request' (duration: 106.363142ms)","trace[2072950408] 'compare' (duration: 267.602357ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:51:47.130684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.262071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/valkey-node-0\" ","response":"range_response_count:1 size:17064"} {"level":"warn","ts":"2026-04-26T14:51:47.130691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.776235Z","time spent":"354.368102ms","remote":"127.0.0.1:40528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:51:47.130706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.755438Z","time spent":"375.204933ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:51:47.130831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.081574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:7458"} {"level":"info","ts":"2026-04-26T14:51:47.130878Z","caller":"traceutil/trace.go:171","msg":"trace[1450004600] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:3722; }","duration":"352.148204ms","start":"2026-04-26T14:51:46.778722Z","end":"2026-04-26T14:51:47.13087Z","steps":["trace[1450004600] 'agreement among raft nodes before linearized reading' (duration: 352.038173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:47.130889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.421712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T14:51:47.130918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.778711Z","time spent":"352.198234ms","remote":"127.0.0.1:40954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":7481,"request content":"key:\"/registry/statefulsets/auth-system/keycloak\" "} {"level":"info","ts":"2026-04-26T14:51:47.130943Z","caller":"traceutil/trace.go:171","msg":"trace[1992629798] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3722; }","duration":"323.510642ms","start":"2026-04-26T14:51:46.807415Z","end":"2026-04-26T14:51:47.130926Z","steps":["trace[1992629798] 'agreement among raft nodes before linearized reading' (duration: 323.425012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:47.131004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.807394Z","time spent":"323.598242ms","remote":"127.0.0.1:40952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-04-26T14:51:47.130724Z","caller":"traceutil/trace.go:171","msg":"trace[1581273056] range","detail":"{range_begin:/registry/pods/openstack/valkey-node-0; range_end:; response_count:1; response_revision:3722; }","duration":"377.319041ms","start":"2026-04-26T14:51:46.753395Z","end":"2026-04-26T14:51:47.130714Z","steps":["trace[1581273056] 'agreement among raft nodes before linearized reading' (duration: 377.178521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:47.131167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:46.753389Z","time spent":"377.763493ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":17087,"request content":"key:\"/registry/pods/openstack/valkey-node-0\" "} {"level":"warn","ts":"2026-04-26T14:51:47.547198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.713905ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:51:47.547383Z","caller":"traceutil/trace.go:171","msg":"trace[1783473282] transaction","detail":"{read_only:false; response_revision:3723; number_of_response:1; }","duration":"401.313568ms","start":"2026-04-26T14:51:47.146037Z","end":"2026-04-26T14:51:47.54735Z","steps":["trace[1783473282] 'process raft request' (duration: 109.369772ms)","trace[1783473282] 'compare' (duration: 290.5377ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:47.547483Z","caller":"traceutil/trace.go:171","msg":"trace[1759980989] linearizableReadLoop","detail":"{readStateIndex:3859; appliedIndex:3858; }","duration":"398.85219ms","start":"2026-04-26T14:51:47.148621Z","end":"2026-04-26T14:51:47.547473Z","steps":["trace[1759980989] 'read index received' (duration: 106.742193ms)","trace[1759980989] 'applied index is now lower than readState.Index' (duration: 292.108947ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:51:47.547447Z","caller":"traceutil/trace.go:171","msg":"trace[1164264762] transaction","detail":"{read_only:false; response_revision:3724; number_of_response:1; }","duration":"280.358833ms","start":"2026-04-26T14:51:47.26707Z","end":"2026-04-26T14:51:47.547429Z","steps":["trace[1164264762] 'process raft request' (duration: 280.283082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:47.547866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:47.146017Z","time spent":"401.477299ms","remote":"127.0.0.1:40668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17035,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:51:47.548636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.989114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-04-26T14:51:47.548762Z","caller":"traceutil/trace.go:171","msg":"trace[1530475704] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:3724; }","duration":"400.144184ms","start":"2026-04-26T14:51:47.148592Z","end":"2026-04-26T14:51:47.548736Z","steps":["trace[1530475704] 'agreement among raft nodes before linearized reading' (duration: 398.96709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:47.549644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:47.148579Z","time spent":"401.034488ms","remote":"127.0.0.1:44140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5674,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-26T14:51:47.643901Z","caller":"traceutil/trace.go:171","msg":"trace[52578046] transaction","detail":"{read_only:false; response_revision:3725; number_of_response:1; }","duration":"376.040861ms","start":"2026-04-26T14:51:47.267829Z","end":"2026-04-26T14:51:47.64387Z","steps":["trace[52578046] 'process raft request' (duration: 375.866171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:47.643949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.431375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T14:51:47.644015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.407687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-26T14:51:47.644059Z","caller":"traceutil/trace.go:171","msg":"trace[480461624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3725; }","duration":"457.568006ms","start":"2026-04-26T14:51:47.186446Z","end":"2026-04-26T14:51:47.644014Z","steps":["trace[480461624] 'agreement among raft nodes before linearized reading' (duration: 457.397425ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:51:47.644109Z","caller":"traceutil/trace.go:171","msg":"trace[814680801] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:3725; }","duration":"175.550107ms","start":"2026-04-26T14:51:47.468512Z","end":"2026-04-26T14:51:47.644062Z","steps":["trace[814680801] 'agreement among raft nodes before linearized reading' (duration: 175.353106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:51:47.644159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:47.186421Z","time spent":"457.724976ms","remote":"127.0.0.1:40466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-26T14:51:47.644341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:51:47.267815Z","time spent":"376.164252ms","remote":"127.0.0.1:40756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:51:47.931677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.905938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-26T14:51:47.932384Z","caller":"traceutil/trace.go:171","msg":"trace[1168777265] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:3725; }","duration":"220.653421ms","start":"2026-04-26T14:51:47.711704Z","end":"2026-04-26T14:51:47.932357Z","steps":["trace[1168777265] 'count revisions from in-memory index tree' (duration: 219.814658ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:52:09.988212Z","caller":"traceutil/trace.go:171","msg":"trace[1134794506] transaction","detail":"{read_only:false; response_revision:3916; number_of_response:1; }","duration":"164.468077ms","start":"2026-04-26T14:52:09.823703Z","end":"2026-04-26T14:52:09.988171Z","steps":["trace[1134794506] 'process raft request' (duration: 100.433962ms)","trace[1134794506] 'compare' (duration: 63.830184ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:52:56.661303Z","caller":"traceutil/trace.go:171","msg":"trace[1857428842] transaction","detail":"{read_only:false; response_revision:4208; number_of_response:1; }","duration":"100.596782ms","start":"2026-04-26T14:52:56.560677Z","end":"2026-04-26T14:52:56.661273Z","steps":["trace[1857428842] 'process raft request' (duration: 40.55564ms)","trace[1857428842] 'compare' (duration: 59.93906ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:55:02.767214Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2891} {"level":"info","ts":"2026-04-26T14:55:02.851635Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2891,"took":"83.00177ms","hash":3750799772,"current-db-size-bytes":37093376,"current-db-size":"37 MB","current-db-size-in-use-bytes":14004224,"current-db-size-in-use":"14 MB"} {"level":"info","ts":"2026-04-26T14:55:02.85172Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3750799772,"revision":2891,"compact-revision":-1} {"level":"info","ts":"2026-04-26T14:58:16.640058Z","caller":"traceutil/trace.go:171","msg":"trace[2083031414] transaction","detail":"{read_only:false; response_revision:6267; number_of_response:1; }","duration":"128.401884ms","start":"2026-04-26T14:58:16.511636Z","end":"2026-04-26T14:58:16.640038Z","steps":["trace[2083031414] 'process raft request' (duration: 127.980294ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:59:09.822256Z","caller":"traceutil/trace.go:171","msg":"trace[2108600482] transaction","detail":"{read_only:false; response_revision:7110; number_of_response:1; }","duration":"100.069883ms","start":"2026-04-26T14:59:09.722157Z","end":"2026-04-26T14:59:09.822227Z","steps":["trace[2108600482] 'process raft request' (duration: 99.860634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:59:15.320192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.01208ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:59:15.320466Z","caller":"traceutil/trace.go:171","msg":"trace[934620813] linearizableReadLoop","detail":"{readStateIndex:7457; appliedIndex:7456; }","duration":"134.068999ms","start":"2026-04-26T14:59:15.186377Z","end":"2026-04-26T14:59:15.320446Z","steps":["trace[934620813] 'read index received' (duration: 3.62204ms)","trace[934620813] 'applied index is now lower than readState.Index' (duration: 130.444428ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:59:15.320844Z","caller":"traceutil/trace.go:171","msg":"trace[2126830271] transaction","detail":"{read_only:false; response_revision:7193; number_of_response:1; }","duration":"297.262713ms","start":"2026-04-26T14:59:15.023563Z","end":"2026-04-26T14:59:15.320826Z","steps":["trace[2126830271] 'process raft request' (duration: 166.497102ms)","trace[2126830271] 'compare' (duration: 129.500439ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:59:15.321453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.068009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:59:15.321534Z","caller":"traceutil/trace.go:171","msg":"trace[1201349290] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7193; }","duration":"135.189474ms","start":"2026-04-26T14:59:15.186326Z","end":"2026-04-26T14:59:15.321516Z","steps":["trace[1201349290] 'agreement among raft nodes before linearized reading' (duration: 135.08191ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:59:15.610948Z","caller":"traceutil/trace.go:171","msg":"trace[4244690] transaction","detail":"{read_only:false; response_revision:7203; number_of_response:1; }","duration":"112.524534ms","start":"2026-04-26T14:59:15.498398Z","end":"2026-04-26T14:59:15.610923Z","steps":["trace[4244690] 'process raft request' (duration: 64.962052ms)","trace[4244690] 'compare' (duration: 47.378105ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:59:15.611491Z","caller":"traceutil/trace.go:171","msg":"trace[830774374] transaction","detail":"{read_only:false; response_revision:7204; number_of_response:1; }","duration":"105.566397ms","start":"2026-04-26T14:59:15.50591Z","end":"2026-04-26T14:59:15.611476Z","steps":["trace[830774374] 'process raft request' (duration: 104.961862ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:59:15.66315Z","caller":"traceutil/trace.go:171","msg":"trace[604999667] transaction","detail":"{read_only:false; response_revision:7206; number_of_response:1; }","duration":"115.623363ms","start":"2026-04-26T14:59:15.547502Z","end":"2026-04-26T14:59:15.663125Z","steps":["trace[604999667] 'process raft request' (duration: 115.32708ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:59:15.6632Z","caller":"traceutil/trace.go:171","msg":"trace[1755226392] transaction","detail":"{read_only:false; response_revision:7205; number_of_response:1; }","duration":"143.614673ms","start":"2026-04-26T14:59:15.519557Z","end":"2026-04-26T14:59:15.663171Z","steps":["trace[1755226392] 'process raft request' (duration: 143.114493ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:59:31.116521Z","caller":"traceutil/trace.go:171","msg":"trace[290708526] transaction","detail":"{read_only:false; response_revision:7371; number_of_response:1; }","duration":"110.2882ms","start":"2026-04-26T14:59:31.006214Z","end":"2026-04-26T14:59:31.116502Z","steps":["trace[290708526] 'process raft request' (duration: 110.099863ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:59:31.116528Z","caller":"traceutil/trace.go:171","msg":"trace[745536511] transaction","detail":"{read_only:false; response_revision:7370; number_of_response:1; }","duration":"110.489748ms","start":"2026-04-26T14:59:31.006006Z","end":"2026-04-26T14:59:31.116496Z","steps":["trace[745536511] 'process raft request' (duration: 58.343704ms)","trace[745536511] 'compare' (duration: 51.658794ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:59:36.453211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.670471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/auth-system/\" range_end:\"/registry/secrets/auth-system0\" ","response":"range_response_count:4 size:81044"} {"level":"info","ts":"2026-04-26T14:59:36.453552Z","caller":"traceutil/trace.go:171","msg":"trace[295050345] range","detail":"{range_begin:/registry/secrets/auth-system/; range_end:/registry/secrets/auth-system0; response_count:4; response_revision:7400; }","duration":"155.056326ms","start":"2026-04-26T14:59:36.298475Z","end":"2026-04-26T14:59:36.453531Z","steps":["trace[295050345] 'range keys from in-memory index tree' (duration: 154.441522ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T15:00:02.774655Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4892} {"level":"info","ts":"2026-04-26T15:00:02.826902Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4892,"took":"51.097979ms","hash":3609131900,"current-db-size-bytes":37093376,"current-db-size":"37 MB","current-db-size-in-use-bytes":29392896,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-26T15:00:02.826963Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3609131900,"revision":4892,"compact-revision":2891}