{"level":"warn","ts":"2026-08-19T09:01:46.912189Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-19T09:01:46.912678Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.235:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.235:2380","--initial-cluster=instance=https://199.19.213.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.235: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-08-19T09:01:46.912825Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-19T09:01:46.91284Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.235:2380"]} {"level":"info","ts":"2026-08-19T09:01:46.9129Z","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-08-19T09:01:46.913788Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"]} {"level":"info","ts":"2026-08-19T09:01:46.913941Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.235:2380"],"listen-peer-urls":["https://199.19.213.235:2380"],"advertise-client-urls":["https://199.19.213.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.235: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-08-19T09:01:46.918239Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.021507ms"} {"level":"info","ts":"2026-08-19T09:01:46.932576Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"61a3fe3fc9dc5d35","cluster-id":"e13fd0e1d9ce1168"} {"level":"info","ts":"2026-08-19T09:01:46.932965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=()"} {"level":"info","ts":"2026-08-19T09:01:46.93302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became follower at term 0"} {"level":"info","ts":"2026-08-19T09:01:46.933043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 61a3fe3fc9dc5d35 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-19T09:01:46.933068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became follower at term 1"} {"level":"info","ts":"2026-08-19T09:01:46.933237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=(7035746592805903669)"} {"level":"warn","ts":"2026-08-19T09:01:46.940122Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-19T09:01:46.942288Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-19T09:01:46.945573Z","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-08-19T09:01:46.9475Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"61a3fe3fc9dc5d35","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-19T09:01:46.947834Z","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-08-19T09:01:46.948084Z","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-08-19T09:01:46.948095Z","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-08-19T09:01:46.948877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=(7035746592805903669)"} {"level":"info","ts":"2026-08-19T09:01:46.948071Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"61a3fe3fc9dc5d35","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-19T09:01:46.949136Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e13fd0e1d9ce1168","local-member-id":"61a3fe3fc9dc5d35","added-peer-id":"61a3fe3fc9dc5d35","added-peer-peer-urls":["https://199.19.213.235:2380"]} {"level":"info","ts":"2026-08-19T09:01:46.954799Z","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-08-19T09:01:46.955055Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"61a3fe3fc9dc5d35","initial-advertise-peer-urls":["https://199.19.213.235:2380"],"listen-peer-urls":["https://199.19.213.235:2380"],"advertise-client-urls":["https://199.19.213.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-19T09:01:46.955099Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-19T09:01:46.955587Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.235:2380"} {"level":"info","ts":"2026-08-19T09:01:46.955627Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.235:2380"} {"level":"info","ts":"2026-08-19T09:01:47.933976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 is starting a new election at term 1"} {"level":"info","ts":"2026-08-19T09:01:47.934041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-19T09:01:47.934065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 received MsgPreVoteResp from 61a3fe3fc9dc5d35 at term 1"} {"level":"info","ts":"2026-08-19T09:01:47.934104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became candidate at term 2"} {"level":"info","ts":"2026-08-19T09:01:47.934116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 received MsgVoteResp from 61a3fe3fc9dc5d35 at term 2"} {"level":"info","ts":"2026-08-19T09:01:47.934132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became leader at term 2"} {"level":"info","ts":"2026-08-19T09:01:47.934145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 61a3fe3fc9dc5d35 elected leader 61a3fe3fc9dc5d35 at term 2"} {"level":"info","ts":"2026-08-19T09:01:47.941542Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-19T09:01:47.941577Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-19T09:01:47.941546Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"61a3fe3fc9dc5d35","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.235:2379]}","request-path":"/0/members/61a3fe3fc9dc5d35/attributes","cluster-id":"e13fd0e1d9ce1168","publish-timeout":"7s"} {"level":"info","ts":"2026-08-19T09:01:47.941563Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T09:01:47.942265Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-19T09:01:47.942301Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-19T09:01:47.946328Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-19T09:01:47.946998Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.235:2379"} {"level":"info","ts":"2026-08-19T09:01:47.963739Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e13fd0e1d9ce1168","local-member-id":"61a3fe3fc9dc5d35","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T09:01:47.96393Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T09:01:47.964045Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-19T09:02:27.083651Z","caller":"traceutil/trace.go:171","msg":"trace[2108720179] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"102.205986ms","start":"2026-08-19T09:02:26.981406Z","end":"2026-08-19T09:02:27.083612Z","steps":["trace[2108720179] 'compare' (duration: 93.591747ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:02:33.747073Z","caller":"traceutil/trace.go:171","msg":"trace[1301733692] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"168.223185ms","start":"2026-08-19T09:02:33.578828Z","end":"2026-08-19T09:02:33.747051Z","steps":["trace[1301733692] 'process raft request' (duration: 92.755661ms)","trace[1301733692] 'compare' (duration: 75.022072ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:02:49.225878Z","caller":"traceutil/trace.go:171","msg":"trace[918707920] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"129.21726ms","start":"2026-08-19T09:02:49.09662Z","end":"2026-08-19T09:02:49.225837Z","steps":["trace[918707920] 'process raft request' (duration: 112.919581ms)","trace[918707920] 'compare' (duration: 16.116556ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:02:49.414309Z","caller":"traceutil/trace.go:171","msg":"trace[1238977201] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"149.863454ms","start":"2026-08-19T09:02:49.264406Z","end":"2026-08-19T09:02:49.414269Z","steps":["trace[1238977201] 'process raft request' (duration: 96.988029ms)","trace[1238977201] 'compare' (duration: 52.588203ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:03:44.345358Z","caller":"traceutil/trace.go:171","msg":"trace[2035147722] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"160.295263ms","start":"2026-08-19T09:03:44.184983Z","end":"2026-08-19T09:03:44.345278Z","steps":["trace[2035147722] 'process raft request' (duration: 141.385334ms)","trace[2035147722] 'compare' (duration: 18.641347ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T09:04:08.179925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.750096ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-19T09:04:08.180148Z","caller":"traceutil/trace.go:171","msg":"trace[1974905608] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1921; }","duration":"243.67381ms","start":"2026-08-19T09:04:07.936456Z","end":"2026-08-19T09:04:08.18013Z","steps":["trace[1974905608] 'read index received' (duration: 31.727713ms)","trace[1974905608] 'applied index is now lower than readState.Index' (duration: 211.944757ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T09:04:08.180293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.837803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ee44031a-b859-4c62-b946-fa942c319685\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-19T09:04:08.180167Z","caller":"traceutil/trace.go:171","msg":"trace[1143746312] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"351.837966ms","start":"2026-08-19T09:04:07.828314Z","end":"2026-08-19T09:04:08.180152Z","steps":["trace[1143746312] 'process raft request' (duration: 139.983277ms)","trace[1143746312] 'compare' (duration: 210.542798ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:04:08.180322Z","caller":"traceutil/trace.go:171","msg":"trace[1558607799] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ee44031a-b859-4c62-b946-fa942c319685; range_end:; response_count:1; response_revision:1844; }","duration":"243.908809ms","start":"2026-08-19T09:04:07.936405Z","end":"2026-08-19T09:04:08.180314Z","steps":["trace[1558607799] 'agreement among raft nodes before linearized reading' (duration: 243.80272ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:04:08.180489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.920995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-19T09:04:08.180612Z","caller":"traceutil/trace.go:171","msg":"trace[2147339413] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1844; }","duration":"171.059636ms","start":"2026-08-19T09:04:08.009532Z","end":"2026-08-19T09:04:08.180591Z","steps":["trace[2147339413] 'agreement among raft nodes before linearized reading' (duration: 170.86112ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:04:08.180536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:04:07.828291Z","time spent":"352.083026ms","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-19T09:04:08.390734Z","caller":"traceutil/trace.go:171","msg":"trace[1950812894] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"132.986749ms","start":"2026-08-19T09:04:08.25772Z","end":"2026-08-19T09:04:08.390707Z","steps":["trace[1950812894] 'process raft request' (duration: 126.744387ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:04:20.409062Z","caller":"traceutil/trace.go:171","msg":"trace[43503478] linearizableReadLoop","detail":"{readStateIndex:2026; appliedIndex:2025; }","duration":"144.443444ms","start":"2026-08-19T09:04:20.264589Z","end":"2026-08-19T09:04:20.409032Z","steps":["trace[43503478] 'read index received' (duration: 144.346806ms)","trace[43503478] 'applied index is now lower than readState.Index' (duration: 95.178µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:04:20.409187Z","caller":"traceutil/trace.go:171","msg":"trace[2007751671] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"165.587277ms","start":"2026-08-19T09:04:20.243586Z","end":"2026-08-19T09:04:20.409173Z","steps":["trace[2007751671] 'process raft request' (duration: 165.289002ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:04:20.409604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.997731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-19T09:04:20.409664Z","caller":"traceutil/trace.go:171","msg":"trace[1665043785] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1946; }","duration":"145.111351ms","start":"2026-08-19T09:04:20.264536Z","end":"2026-08-19T09:04:20.409648Z","steps":["trace[1665043785] 'agreement among raft nodes before linearized reading' (duration: 144.902673ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:04:20.43371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.890238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T09:04:20.43377Z","caller":"traceutil/trace.go:171","msg":"trace[1655682441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1947; }","duration":"112.015059ms","start":"2026-08-19T09:04:20.321741Z","end":"2026-08-19T09:04:20.433756Z","steps":["trace[1655682441] 'agreement among raft nodes before linearized reading' (duration: 111.861636ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:04:20.433764Z","caller":"traceutil/trace.go:171","msg":"trace[859199630] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"117.677447ms","start":"2026-08-19T09:04:20.316063Z","end":"2026-08-19T09:04:20.43374Z","steps":["trace[859199630] 'process raft request' (duration: 117.418115ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:04:51.545663Z","caller":"traceutil/trace.go:171","msg":"trace[590227205] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"129.366365ms","start":"2026-08-19T09:04:51.416273Z","end":"2026-08-19T09:04:51.545639Z","steps":["trace[590227205] 'process raft request' (duration: 129.15153ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:04:51.608463Z","caller":"traceutil/trace.go:171","msg":"trace[980748695] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"119.859843ms","start":"2026-08-19T09:04:51.488572Z","end":"2026-08-19T09:04:51.608432Z","steps":["trace[980748695] 'process raft request' (duration: 119.664858ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:04:51.812953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.265853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-19T09:04:51.813524Z","caller":"traceutil/trace.go:171","msg":"trace[367793830] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2129; }","duration":"180.859949ms","start":"2026-08-19T09:04:51.632624Z","end":"2026-08-19T09:04:51.813484Z","steps":["trace[367793830] 'range keys from in-memory index tree' (duration: 180.098318ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:04:52.109424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.31888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-08-19T09:04:52.110179Z","caller":"traceutil/trace.go:171","msg":"trace[1708347496] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2130; }","duration":"112.141691ms","start":"2026-08-19T09:04:51.997993Z","end":"2026-08-19T09:04:52.110135Z","steps":["trace[1708347496] 'range keys from in-memory index tree' (duration: 110.93826ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:06:11.175491Z","caller":"traceutil/trace.go:171","msg":"trace[1618590308] linearizableReadLoop","detail":"{readStateIndex:2776; appliedIndex:2775; }","duration":"118.205585ms","start":"2026-08-19T09:06:11.05726Z","end":"2026-08-19T09:06:11.175466Z","steps":["trace[1618590308] 'read index received' (duration: 114.538263ms)","trace[1618590308] 'applied index is now lower than readState.Index' (duration: 3.666062ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:06:11.175528Z","caller":"traceutil/trace.go:171","msg":"trace[1603337223] transaction","detail":"{read_only:false; response_revision:2671; number_of_response:1; }","duration":"118.423079ms","start":"2026-08-19T09:06:11.057072Z","end":"2026-08-19T09:06:11.175495Z","steps":["trace[1603337223] 'process raft request' (duration: 114.758156ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:06:11.175808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.528281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-19T09:06:11.175857Z","caller":"traceutil/trace.go:171","msg":"trace[1212631395] range","detail":"{range_begin:/registry/masterleases/199.19.213.235; range_end:; response_count:1; response_revision:2671; }","duration":"118.608173ms","start":"2026-08-19T09:06:11.057237Z","end":"2026-08-19T09:06:11.175845Z","steps":["trace[1212631395] 'agreement among raft nodes before linearized reading' (duration: 118.361878ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:06:11.541852Z","caller":"traceutil/trace.go:171","msg":"trace[1018456988] linearizableReadLoop","detail":"{readStateIndex:2779; appliedIndex:2778; }","duration":"218.35721ms","start":"2026-08-19T09:06:11.323473Z","end":"2026-08-19T09:06:11.54183Z","steps":["trace[1018456988] 'read index received' (duration: 218.167977ms)","trace[1018456988] 'applied index is now lower than readState.Index' (duration: 188.363µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:06:11.541956Z","caller":"traceutil/trace.go:171","msg":"trace[1450069731] transaction","detail":"{read_only:false; response_revision:2673; number_of_response:1; }","duration":"277.609651ms","start":"2026-08-19T09:06:11.264279Z","end":"2026-08-19T09:06:11.541889Z","steps":["trace[1450069731] 'process raft request' (duration: 277.410127ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:06:11.542179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.502613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-19T09:06:11.542373Z","caller":"traceutil/trace.go:171","msg":"trace[599893362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2673; }","duration":"218.838409ms","start":"2026-08-19T09:06:11.323445Z","end":"2026-08-19T09:06:11.542283Z","steps":["trace[599893362] 'agreement among raft nodes before linearized reading' (duration: 218.475322ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:10:00.376351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.235616ms","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-08-19T09:10:00.376462Z","caller":"traceutil/trace.go:171","msg":"trace[1504775661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4571; }","duration":"109.381896ms","start":"2026-08-19T09:10:00.267061Z","end":"2026-08-19T09:10:00.376443Z","steps":["trace[1504775661] 'range keys from in-memory index tree' (duration: 109.016522ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:10:00.376642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.959237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-08-19T09:10:00.376749Z","caller":"traceutil/trace.go:171","msg":"trace[1278422067] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4571; }","duration":"139.083455ms","start":"2026-08-19T09:10:00.237645Z","end":"2026-08-19T09:10:00.376728Z","steps":["trace[1278422067] 'range keys from in-memory index tree' (duration: 138.06422ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:10:00.643298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.796384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-08-19T09:10:00.643376Z","caller":"traceutil/trace.go:171","msg":"trace[1540986619] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4574; }","duration":"150.908742ms","start":"2026-08-19T09:10:00.49245Z","end":"2026-08-19T09:10:00.643359Z","steps":["trace[1540986619] 'range keys from in-memory index tree' (duration: 150.655155ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:10:00.78642Z","caller":"traceutil/trace.go:171","msg":"trace[1198694978] linearizableReadLoop","detail":"{readStateIndex:4751; appliedIndex:4750; }","duration":"117.043757ms","start":"2026-08-19T09:10:00.669352Z","end":"2026-08-19T09:10:00.786396Z","steps":["trace[1198694978] 'read index received' (duration: 116.987993ms)","trace[1198694978] 'applied index is now lower than readState.Index' (duration: 54.734µs)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:10:00.786534Z","caller":"traceutil/trace.go:171","msg":"trace[1565279852] transaction","detail":"{read_only:false; response_revision:4575; number_of_response:1; }","duration":"118.228262ms","start":"2026-08-19T09:10:00.668273Z","end":"2026-08-19T09:10:00.786501Z","steps":["trace[1565279852] 'process raft request' (duration: 117.988997ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:10:00.786691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.298693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-08-19T09:10:00.786731Z","caller":"traceutil/trace.go:171","msg":"trace[583580601] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4575; }","duration":"117.386168ms","start":"2026-08-19T09:10:00.669334Z","end":"2026-08-19T09:10:00.78672Z","steps":["trace[583580601] 'agreement among raft nodes before linearized reading' (duration: 117.174785ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:10:00.788017Z","caller":"traceutil/trace.go:171","msg":"trace[1732203214] transaction","detail":"{read_only:false; response_revision:4576; number_of_response:1; }","duration":"118.109984ms","start":"2026-08-19T09:10:00.669886Z","end":"2026-08-19T09:10:00.787996Z","steps":["trace[1732203214] 'process raft request' (duration: 117.766593ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:10:06.269063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.703304ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-19T09:10:06.269178Z","caller":"traceutil/trace.go:171","msg":"trace[677852238] linearizableReadLoop","detail":"{readStateIndex:4841; appliedIndex:4839; }","duration":"267.896963ms","start":"2026-08-19T09:10:06.001264Z","end":"2026-08-19T09:10:06.269161Z","steps":["trace[677852238] 'read index received' (duration: 4.439436ms)","trace[677852238] 'applied index is now lower than readState.Index' (duration: 263.455537ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:10:06.26945Z","caller":"traceutil/trace.go:171","msg":"trace[1769352022] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"268.812352ms","start":"2026-08-19T09:10:06.000549Z","end":"2026-08-19T09:10:06.269361Z","steps":["trace[1769352022] 'process raft request' (duration: 130.706302ms)","trace[1769352022] 'compare' (duration: 137.311868ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T09:10:06.269669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.415967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9316"} {"level":"info","ts":"2026-08-19T09:10:06.269744Z","caller":"traceutil/trace.go:171","msg":"trace[1441121447] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4663; }","duration":"266.500753ms","start":"2026-08-19T09:10:06.003207Z","end":"2026-08-19T09:10:06.269708Z","steps":["trace[1441121447] 'agreement among raft nodes before linearized reading' (duration: 266.271008ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:10:06.269755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.320114ms","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-08-19T09:10:06.269771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.749983ms","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-08-19T09:10:06.269831Z","caller":"traceutil/trace.go:171","msg":"trace[464544908] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4663; }","duration":"120.456414ms","start":"2026-08-19T09:10:06.149357Z","end":"2026-08-19T09:10:06.269813Z","steps":["trace[464544908] 'agreement among raft nodes before linearized reading' (duration: 120.202987ms)"],"step_count":1} {"level":"warn","ts":"2026-08-19T09:10:06.26967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.363752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"warn","ts":"2026-08-19T09:10:06.269922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.731803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3223"} {"level":"info","ts":"2026-08-19T09:10:06.270014Z","caller":"traceutil/trace.go:171","msg":"trace[828320335] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4663; }","duration":"265.849171ms","start":"2026-08-19T09:10:06.004146Z","end":"2026-08-19T09:10:06.269995Z","steps":["trace[828320335] 'agreement among raft nodes before linearized reading' (duration: 265.595575ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:10:06.269887Z","caller":"traceutil/trace.go:171","msg":"trace[1031290816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4663; }","duration":"104.916774ms","start":"2026-08-19T09:10:06.164947Z","end":"2026-08-19T09:10:06.269864Z","steps":["trace[1031290816] 'agreement among raft nodes before linearized reading' (duration: 104.603464ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:10:06.269986Z","caller":"traceutil/trace.go:171","msg":"trace[1375924694] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4663; }","duration":"268.696354ms","start":"2026-08-19T09:10:06.001249Z","end":"2026-08-19T09:10:06.269945Z","steps":["trace[1375924694] 'agreement among raft nodes before linearized reading' (duration: 268.153259ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:10:06.60223Z","caller":"traceutil/trace.go:171","msg":"trace[1458801979] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"139.874373ms","start":"2026-08-19T09:10:06.462318Z","end":"2026-08-19T09:10:06.602192Z","steps":["trace[1458801979] 'process raft request' (duration: 75.468327ms)","trace[1458801979] 'compare' (duration: 64.131168ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:10:06.602279Z","caller":"traceutil/trace.go:171","msg":"trace[898068856] linearizableReadLoop","detail":"{readStateIndex:4859; appliedIndex:4858; }","duration":"122.1146ms","start":"2026-08-19T09:10:06.480122Z","end":"2026-08-19T09:10:06.602236Z","steps":["trace[898068856] 'read index received' (duration: 57.598357ms)","trace[898068856] 'applied index is now lower than readState.Index' (duration: 64.513413ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T09:10:06.645536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.885275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"warn","ts":"2026-08-19T09:10:06.64561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.030737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4849"} {"level":"info","ts":"2026-08-19T09:10:06.645628Z","caller":"traceutil/trace.go:171","msg":"trace[2104799596] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4681; }","duration":"177.048895ms","start":"2026-08-19T09:10:06.468552Z","end":"2026-08-19T09:10:06.645601Z","steps":["trace[2104799596] 'agreement among raft nodes before linearized reading' (duration: 133.896129ms)","trace[2104799596] 'range keys from in-memory index tree' (duration: 42.848717ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:10:06.645753Z","caller":"traceutil/trace.go:171","msg":"trace[2128313251] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4681; }","duration":"180.23023ms","start":"2026-08-19T09:10:06.465481Z","end":"2026-08-19T09:10:06.645711Z","steps":["trace[2128313251] 'agreement among raft nodes before linearized reading' (duration: 136.997228ms)","trace[2128313251] 'range keys from in-memory index tree' (duration: 42.865368ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T09:10:06.645819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.486314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-08-19T09:10:06.646003Z","caller":"traceutil/trace.go:171","msg":"trace[2018338298] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4681; }","duration":"184.72976ms","start":"2026-08-19T09:10:06.461215Z","end":"2026-08-19T09:10:06.645945Z","steps":["trace[2018338298] 'agreement among raft nodes before linearized reading' (duration: 141.288915ms)","trace[2018338298] 'range keys from in-memory index tree' (duration: 42.858908ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T09:10:06.646361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.306817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"warn","ts":"2026-08-19T09:10:06.646475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.78032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-19T09:10:06.647319Z","caller":"traceutil/trace.go:171","msg":"trace[786357991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4681; }","duration":"183.392374ms","start":"2026-08-19T09:10:06.463897Z","end":"2026-08-19T09:10:06.64729Z","steps":["trace[786357991] 'agreement among raft nodes before linearized reading' (duration: 138.593271ms)","trace[786357991] 'range keys from in-memory index tree' (duration: 42.966675ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:10:06.646692Z","caller":"traceutil/trace.go:171","msg":"trace[1459799067] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4682; }","duration":"160.420134ms","start":"2026-08-19T09:10:06.485977Z","end":"2026-08-19T09:10:06.646398Z","steps":["trace[1459799067] 'agreement among raft nodes before linearized reading' (duration: 159.629784ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:10:18.245746Z","caller":"traceutil/trace.go:171","msg":"trace[267491039] linearizableReadLoop","detail":"{readStateIndex:5036; appliedIndex:5035; }","duration":"180.041864ms","start":"2026-08-19T09:10:18.065685Z","end":"2026-08-19T09:10:18.245727Z","steps":["trace[267491039] 'read index received' (duration: 179.891354ms)","trace[267491039] 'applied index is now lower than readState.Index' (duration: 149.76µs)"],"step_count":2} {"level":"warn","ts":"2026-08-19T09:10:18.245887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.184873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-19T09:10:18.245928Z","caller":"traceutil/trace.go:171","msg":"trace[1129881159] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:4852; }","duration":"180.28849ms","start":"2026-08-19T09:10:18.065629Z","end":"2026-08-19T09:10:18.245918Z","steps":["trace[1129881159] 'agreement among raft nodes before linearized reading' (duration: 180.178183ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:10:18.245791Z","caller":"traceutil/trace.go:171","msg":"trace[1992433416] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"251.54517ms","start":"2026-08-19T09:10:17.994226Z","end":"2026-08-19T09:10:18.245771Z","steps":["trace[1992433416] 'process raft request' (duration: 251.39917ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:10:18.654533Z","caller":"traceutil/trace.go:171","msg":"trace[1940924876] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"146.365831ms","start":"2026-08-19T09:10:18.508142Z","end":"2026-08-19T09:10:18.654507Z","steps":["trace[1940924876] 'process raft request' (duration: 80.646832ms)","trace[1940924876] 'compare' (duration: 65.403329ms)"],"step_count":2} {"level":"info","ts":"2026-08-19T09:10:18.654578Z","caller":"traceutil/trace.go:171","msg":"trace[1140219808] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"145.866058ms","start":"2026-08-19T09:10:18.508686Z","end":"2026-08-19T09:10:18.654552Z","steps":["trace[1140219808] 'process raft request' (duration: 145.692667ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:10:18.65462Z","caller":"traceutil/trace.go:171","msg":"trace[682054954] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"144.742115ms","start":"2026-08-19T09:10:18.509858Z","end":"2026-08-19T09:10:18.6546Z","steps":["trace[682054954] 'process raft request' (duration: 144.630378ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:10:18.654551Z","caller":"traceutil/trace.go:171","msg":"trace[1452509302] linearizableReadLoop","detail":"{readStateIndex:5044; appliedIndex:5040; }","duration":"144.634628ms","start":"2026-08-19T09:10:18.509898Z","end":"2026-08-19T09:10:18.654533Z","steps":["trace[1452509302] 'read index received' (duration: 78.990843ms)","trace[1452509302] 'applied index is now lower than readState.Index' (duration: 65.642235ms)"],"step_count":2} {"level":"warn","ts":"2026-08-19T09:10:18.654722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.456312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-e6bed3f5-8a4f-444d-879f-ed3d59f5d786\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-08-19T09:10:18.654766Z","caller":"traceutil/trace.go:171","msg":"trace[1410026538] range","detail":"{range_begin:/registry/persistentvolumes/pvc-e6bed3f5-8a4f-444d-879f-ed3d59f5d786; range_end:; response_count:1; response_revision:4860; }","duration":"145.532396ms","start":"2026-08-19T09:10:18.509221Z","end":"2026-08-19T09:10:18.654754Z","steps":["trace[1410026538] 'agreement among raft nodes before linearized reading' (duration: 145.365335ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:10:18.654702Z","caller":"traceutil/trace.go:171","msg":"trace[257937116] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"145.247737ms","start":"2026-08-19T09:10:18.509354Z","end":"2026-08-19T09:10:18.654601Z","steps":["trace[257937116] 'process raft request' (duration: 145.100868ms)"],"step_count":1} {"level":"info","ts":"2026-08-19T09:11:47.974206Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2862} {"level":"info","ts":"2026-08-19T09:11:48.062192Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2862,"took":"86.318252ms","hash":538052906,"current-db-size-bytes":53338112,"current-db-size":"53 MB","current-db-size-in-use-bytes":29696000,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-19T09:11:48.062258Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":538052906,"revision":2862,"compact-revision":-1} {"level":"info","ts":"2026-08-19T09:16:47.983866Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5588} {"level":"info","ts":"2026-08-19T09:16:48.058117Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5588,"took":"72.368295ms","hash":106216293,"current-db-size-bytes":53338112,"current-db-size":"53 MB","current-db-size-in-use-bytes":18378752,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-19T09:16:48.058187Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":106216293,"revision":5588,"compact-revision":2862}