{"level":"warn","ts":"2026-08-20T16:50:52.683843Z","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-20T16:50:52.684001Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-20T16:50:52.684127Z","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-20T16:50:52.684149Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-08-20T16:50:52.684204Z","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-20T16:50:52.685241Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-08-20T16:50:52.685388Z","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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-20T16:50:52.691846Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.055022ms"} {"level":"info","ts":"2026-08-20T16:50:52.703233Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-08-20T16:50:52.703307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-08-20T16:50:52.703326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-08-20T16:50:52.703339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-20T16:50:52.70335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-08-20T16:50:52.703391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-08-20T16:50:52.709177Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-20T16:50:52.712336Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-20T16:50:52.713182Z","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-20T16:50:52.715271Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-20T16:50:52.715434Z","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-20T16:50:52.715506Z","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-20T16:50:52.715515Z","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-20T16:50:52.716071Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-20T16:50:52.71636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-08-20T16:50:52.717069Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-08-20T16:50:52.722394Z","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-20T16:50:52.722652Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-20T16:50:52.722682Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-20T16:50:52.722773Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-08-20T16:50:52.722784Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-08-20T16:50:52.804163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-08-20T16:50:52.804355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-20T16:50:52.804447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-08-20T16:50:52.804516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-08-20T16:50:52.804567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-08-20T16:50:52.804595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-08-20T16:50:52.804623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-08-20T16:50:52.80583Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-08-20T16:50:52.805925Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T16:50:52.806053Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T16:50:52.806035Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T16:50:52.807051Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T16:50:52.807166Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T16:50:52.807204Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T16:50:52.810358Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-08-20T16:50:52.810395Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-20T16:50:52.81169Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-20T16:50:52.811763Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-20T16:51:08.72728Z","caller":"traceutil/trace.go:171","msg":"trace[835672529] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"200.591812ms","start":"2026-08-20T16:51:08.526663Z","end":"2026-08-20T16:51:08.727255Z","steps":["trace[835672529] 'process raft request' (duration: 200.440748ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:08.871661Z","caller":"traceutil/trace.go:171","msg":"trace[1039687668] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:384; }","duration":"140.595587ms","start":"2026-08-20T16:51:08.73104Z","end":"2026-08-20T16:51:08.871635Z","steps":["trace[1039687668] 'read index received' (duration: 119.252861ms)","trace[1039687668] 'applied index is now lower than readState.Index' (duration: 21.341596ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:51:08.872038Z","caller":"traceutil/trace.go:171","msg":"trace[26255939] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"167.06066ms","start":"2026-08-20T16:51:08.70495Z","end":"2026-08-20T16:51:08.872011Z","steps":["trace[26255939] 'process raft request' (duration: 145.395288ms)","trace[26255939] 'compare' (duration: 21.165322ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:51:08.872129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.017076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6887"} {"level":"warn","ts":"2026-08-20T16:51:08.872135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.878498ms","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-08-20T16:51:08.872221Z","caller":"traceutil/trace.go:171","msg":"trace[268178621] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:374; }","duration":"141.204081ms","start":"2026-08-20T16:51:08.730999Z","end":"2026-08-20T16:51:08.872203Z","steps":["trace[268178621] 'agreement among raft nodes before linearized reading' (duration: 140.984216ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:08.872249Z","caller":"traceutil/trace.go:171","msg":"trace[426596333] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:374; }","duration":"101.076412ms","start":"2026-08-20T16:51:08.771149Z","end":"2026-08-20T16:51:08.872225Z","steps":["trace[426596333] 'agreement among raft nodes before linearized reading' (duration: 100.837567ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:31.216848Z","caller":"traceutil/trace.go:171","msg":"trace[601854973] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"128.396063ms","start":"2026-08-20T16:51:31.088431Z","end":"2026-08-20T16:51:31.216827Z","steps":["trace[601854973] 'process raft request' (duration: 128.258841ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:31.217197Z","caller":"traceutil/trace.go:171","msg":"trace[1488796066] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"129.056496ms","start":"2026-08-20T16:51:31.088134Z","end":"2026-08-20T16:51:31.21719Z","steps":["trace[1488796066] 'process raft request' (duration: 126.900333ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:31.226287Z","caller":"traceutil/trace.go:171","msg":"trace[22968931] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"132.984285ms","start":"2026-08-20T16:51:31.093268Z","end":"2026-08-20T16:51:31.226252Z","steps":["trace[22968931] 'process raft request' (duration: 132.425663ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:31.226599Z","caller":"traceutil/trace.go:171","msg":"trace[831421821] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"130.347103ms","start":"2026-08-20T16:51:31.096224Z","end":"2026-08-20T16:51:31.226571Z","steps":["trace[831421821] 'process raft request' (duration: 129.684449ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:31.226866Z","caller":"traceutil/trace.go:171","msg":"trace[1186356753] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"127.495675ms","start":"2026-08-20T16:51:31.099343Z","end":"2026-08-20T16:51:31.226838Z","steps":["trace[1186356753] 'process raft request' (duration: 126.937204ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:31.227007Z","caller":"traceutil/trace.go:171","msg":"trace[1538085860] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"127.501565ms","start":"2026-08-20T16:51:31.099485Z","end":"2026-08-20T16:51:31.226987Z","steps":["trace[1538085860] 'process raft request' (duration: 127.284101ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:31.227426Z","caller":"traceutil/trace.go:171","msg":"trace[1078607902] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"126.869903ms","start":"2026-08-20T16:51:31.100542Z","end":"2026-08-20T16:51:31.227412Z","steps":["trace[1078607902] 'process raft request' (duration: 126.345954ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:31.227968Z","caller":"traceutil/trace.go:171","msg":"trace[456339555] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"115.70892ms","start":"2026-08-20T16:51:31.112245Z","end":"2026-08-20T16:51:31.227954Z","steps":["trace[456339555] 'process raft request' (duration: 115.450915ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:31.228067Z","caller":"traceutil/trace.go:171","msg":"trace[1068842062] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"105.822365ms","start":"2026-08-20T16:51:31.122171Z","end":"2026-08-20T16:51:31.227993Z","steps":["trace[1068842062] 'process raft request' (duration: 105.780753ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:31.228333Z","caller":"traceutil/trace.go:171","msg":"trace[2099978234] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"113.719441ms","start":"2026-08-20T16:51:31.114606Z","end":"2026-08-20T16:51:31.228325Z","steps":["trace[2099978234] 'process raft request' (duration: 113.288703ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:31.231075Z","caller":"traceutil/trace.go:171","msg":"trace[489743151] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"129.506156ms","start":"2026-08-20T16:51:31.096849Z","end":"2026-08-20T16:51:31.226355Z","steps":["trace[489743151] 'process raft request' (duration: 129.119918ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:39.822266Z","caller":"traceutil/trace.go:171","msg":"trace[70170649] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"159.58653ms","start":"2026-08-20T16:51:39.662661Z","end":"2026-08-20T16:51:39.822247Z","steps":["trace[70170649] 'process raft request' (duration: 159.451598ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:39.828132Z","caller":"traceutil/trace.go:171","msg":"trace[1373642008] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"157.146684ms","start":"2026-08-20T16:51:39.670953Z","end":"2026-08-20T16:51:39.8281Z","steps":["trace[1373642008] 'process raft request' (duration: 156.98536ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:39.945472Z","caller":"traceutil/trace.go:171","msg":"trace[1389164910] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"114.268932ms","start":"2026-08-20T16:51:39.831133Z","end":"2026-08-20T16:51:39.945402Z","steps":["trace[1389164910] 'process raft request' (duration: 54.655322ms)","trace[1389164910] 'compare' (duration: 59.487227ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:51:40.49223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.116716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T16:51:40.492309Z","caller":"traceutil/trace.go:171","msg":"trace[75605388] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"256.235488ms","start":"2026-08-20T16:51:40.236057Z","end":"2026-08-20T16:51:40.492292Z","steps":["trace[75605388] 'range keys from in-memory index tree' (duration: 255.984344ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:56.520222Z","caller":"traceutil/trace.go:171","msg":"trace[614877252] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:796; }","duration":"108.71271ms","start":"2026-08-20T16:51:56.411488Z","end":"2026-08-20T16:51:56.5202Z","steps":["trace[614877252] 'read index received' (duration: 108.67739ms)","trace[614877252] 'applied index is now lower than readState.Index' (duration: 33.83µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:51:56.52035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.851612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T16:51:56.520386Z","caller":"traceutil/trace.go:171","msg":"trace[431563793] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:775; }","duration":"108.906844ms","start":"2026-08-20T16:51:56.411468Z","end":"2026-08-20T16:51:56.520375Z","steps":["trace[431563793] 'agreement among raft nodes before linearized reading' (duration: 108.825942ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:51:56.520341Z","caller":"traceutil/trace.go:171","msg":"trace[83365298] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"269.205502ms","start":"2026-08-20T16:51:56.25109Z","end":"2026-08-20T16:51:56.520295Z","steps":["trace[83365298] 'process raft request' (duration: 268.965468ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:52:48.210081Z","caller":"traceutil/trace.go:171","msg":"trace[1034159123] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"167.825307ms","start":"2026-08-20T16:52:48.042239Z","end":"2026-08-20T16:52:48.210065Z","steps":["trace[1034159123] 'process raft request' (duration: 167.728325ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:05.812917Z","caller":"traceutil/trace.go:171","msg":"trace[2104672999] transaction","detail":"{read_only:false; response_revision:1748; number_of_response:1; }","duration":"267.865591ms","start":"2026-08-20T16:53:05.545018Z","end":"2026-08-20T16:53:05.812883Z","steps":["trace[2104672999] 'process raft request' (duration: 267.733958ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:05.87529Z","caller":"traceutil/trace.go:171","msg":"trace[2078202932] transaction","detail":"{read_only:false; response_revision:1749; number_of_response:1; }","duration":"197.089199ms","start":"2026-08-20T16:53:05.678177Z","end":"2026-08-20T16:53:05.875266Z","steps":["trace[2078202932] 'process raft request' (duration: 196.805634ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:13.102212Z","caller":"traceutil/trace.go:171","msg":"trace[1318315255] linearizableReadLoop","detail":"{readStateIndex:1926; appliedIndex:1925; }","duration":"135.196461ms","start":"2026-08-20T16:53:12.966991Z","end":"2026-08-20T16:53:13.102187Z","steps":["trace[1318315255] 'read index received' (duration: 134.974506ms)","trace[1318315255] 'applied index is now lower than readState.Index' (duration: 221.125µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:13.102448Z","caller":"traceutil/trace.go:171","msg":"trace[2085264190] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"154.01771ms","start":"2026-08-20T16:53:12.948409Z","end":"2026-08-20T16:53:13.102427Z","steps":["trace[2085264190] 'process raft request' (duration: 153.622253ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:13.102753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.71946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-20T16:53:13.102835Z","caller":"traceutil/trace.go:171","msg":"trace[1979326149] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1859; }","duration":"135.869172ms","start":"2026-08-20T16:53:12.966947Z","end":"2026-08-20T16:53:13.102816Z","steps":["trace[1979326149] 'agreement among raft nodes before linearized reading' (duration: 135.530936ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:13.545043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.030754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:53:13.54517Z","caller":"traceutil/trace.go:171","msg":"trace[416743887] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"416.633559ms","start":"2026-08-20T16:53:13.128503Z","end":"2026-08-20T16:53:13.545137Z","steps":["trace[416743887] 'process raft request' (duration: 305.054644ms)","trace[416743887] 'compare' (duration: 110.670968ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:13.545313Z","caller":"traceutil/trace.go:171","msg":"trace[1009773253] linearizableReadLoop","detail":"{readStateIndex:1928; appliedIndex:1927; }","duration":"309.554736ms","start":"2026-08-20T16:53:13.235733Z","end":"2026-08-20T16:53:13.545288Z","steps":["trace[1009773253] 'read index received' (duration: 197.83995ms)","trace[1009773253] 'applied index is now lower than readState.Index' (duration: 111.712816ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:13.545343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:13.128469Z","time spent":"416.787122ms","remote":"127.0.0.1:46962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:53:13.545511Z","caller":"traceutil/trace.go:171","msg":"trace[836285649] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"165.201451ms","start":"2026-08-20T16:53:13.3803Z","end":"2026-08-20T16:53:13.545501Z","steps":["trace[836285649] 'process raft request' (duration: 165.039438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:13.545618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.882653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T16:53:13.545936Z","caller":"traceutil/trace.go:171","msg":"trace[1970951330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1862; }","duration":"310.228159ms","start":"2026-08-20T16:53:13.235693Z","end":"2026-08-20T16:53:13.545921Z","steps":["trace[1970951330] 'agreement among raft nodes before linearized reading' (duration: 309.831681ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:13.546021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:13.235677Z","time spent":"310.331951ms","remote":"127.0.0.1:46788","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-08-20T16:53:18.695741Z","caller":"traceutil/trace.go:171","msg":"trace[161715369] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"100.717154ms","start":"2026-08-20T16:53:18.595003Z","end":"2026-08-20T16:53:18.69572Z","steps":["trace[161715369] 'process raft request' (duration: 100.594022ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:26.757428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.673571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:53:26.757572Z","caller":"traceutil/trace.go:171","msg":"trace[1311671217] linearizableReadLoop","detail":"{readStateIndex:2038; appliedIndex:2037; }","duration":"122.114233ms","start":"2026-08-20T16:53:26.635444Z","end":"2026-08-20T16:53:26.757558Z","steps":["trace[1311671217] 'read index received' (duration: 43.54µs)","trace[1311671217] 'applied index is now lower than readState.Index' (duration: 122.069183ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:26.757658Z","caller":"traceutil/trace.go:171","msg":"trace[992846407] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"251.179791ms","start":"2026-08-20T16:53:26.506467Z","end":"2026-08-20T16:53:26.757647Z","steps":["trace[992846407] 'process raft request' (duration: 59.192314ms)","trace[992846407] 'compare' (duration: 191.478479ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:26.757873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.417708ms","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-08-20T16:53:26.757961Z","caller":"traceutil/trace.go:171","msg":"trace[453331784] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1968; }","duration":"122.545741ms","start":"2026-08-20T16:53:26.635398Z","end":"2026-08-20T16:53:26.757943Z","steps":["trace[453331784] 'agreement among raft nodes before linearized reading' (duration: 122.407278ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:27.485144Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305498208767094458,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-20T16:53:27.559491Z","caller":"traceutil/trace.go:171","msg":"trace[862882538] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"782.727456ms","start":"2026-08-20T16:53:26.776742Z","end":"2026-08-20T16:53:27.559469Z","steps":["trace[862882538] 'process raft request' (duration: 782.584794ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:27.559647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:26.776717Z","time spent":"782.840228ms","remote":"127.0.0.1:47018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:53:27.628802Z","caller":"traceutil/trace.go:171","msg":"trace[1193751665] linearizableReadLoop","detail":"{readStateIndex:2042; appliedIndex:2039; }","duration":"643.943503ms","start":"2026-08-20T16:53:26.984836Z","end":"2026-08-20T16:53:27.628779Z","steps":["trace[1193751665] 'read index received' (duration: 574.572207ms)","trace[1193751665] 'applied index is now lower than readState.Index' (duration: 69.370276ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:27.628873Z","caller":"traceutil/trace.go:171","msg":"trace[1984101448] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"838.65169ms","start":"2026-08-20T16:53:26.790195Z","end":"2026-08-20T16:53:27.628847Z","steps":["trace[1984101448] 'process raft request' (duration: 838.430596ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:27.628933Z","caller":"traceutil/trace.go:171","msg":"trace[550520348] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"473.347369ms","start":"2026-08-20T16:53:27.155525Z","end":"2026-08-20T16:53:27.628872Z","steps":["trace[550520348] 'process raft request' (duration: 473.211457ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:27.629051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.206028ms","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-08-20T16:53:27.629112Z","caller":"traceutil/trace.go:171","msg":"trace[1525730790] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1971; }","duration":"644.293219ms","start":"2026-08-20T16:53:26.984785Z","end":"2026-08-20T16:53:27.629078Z","steps":["trace[1525730790] 'agreement among raft nodes before linearized reading' (duration: 644.113626ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:27.629153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:26.984765Z","time spent":"644.379691ms","remote":"127.0.0.1:35502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-20T16:53:27.629367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:26.790178Z","time spent":"838.756291ms","remote":"127.0.0.1:46818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T16:53:27.6294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:27.155501Z","time spent":"473.540633ms","remote":"127.0.0.1:47018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T16:53:27.629627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.28266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-08-20T16:53:27.629821Z","caller":"traceutil/trace.go:171","msg":"trace[1809690094] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1971; }","duration":"448.536234ms","start":"2026-08-20T16:53:27.181265Z","end":"2026-08-20T16:53:27.629801Z","steps":["trace[1809690094] 'agreement among raft nodes before linearized reading' (duration: 448.010584ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:27.62994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:27.181242Z","time spent":"448.680607ms","remote":"127.0.0.1:47018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-20T16:53:27.767461Z","caller":"traceutil/trace.go:171","msg":"trace[275437837] linearizableReadLoop","detail":"{readStateIndex:2044; appliedIndex:2042; }","duration":"132.246085ms","start":"2026-08-20T16:53:27.635178Z","end":"2026-08-20T16:53:27.767425Z","steps":["trace[275437837] 'read index received' (duration: 19.512361ms)","trace[275437837] 'applied index is now lower than readState.Index' (duration: 112.732764ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:27.767694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.497039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T16:53:27.767734Z","caller":"traceutil/trace.go:171","msg":"trace[1635743748] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1973; }","duration":"132.569131ms","start":"2026-08-20T16:53:27.635156Z","end":"2026-08-20T16:53:27.767725Z","steps":["trace[1635743748] 'agreement among raft nodes before linearized reading' (duration: 132.371017ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:27.767906Z","caller":"traceutil/trace.go:171","msg":"trace[1521702266] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"133.312844ms","start":"2026-08-20T16:53:27.634549Z","end":"2026-08-20T16:53:27.767862Z","steps":["trace[1521702266] 'process raft request' (duration: 39.204694ms)","trace[1521702266] 'compare' (duration: 93.434198ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:28.158252Z","caller":"traceutil/trace.go:171","msg":"trace[854035334] linearizableReadLoop","detail":"{readStateIndex:2045; appliedIndex:2044; }","duration":"139.668357ms","start":"2026-08-20T16:53:28.018567Z","end":"2026-08-20T16:53:28.158236Z","steps":["trace[854035334] 'read index received' (duration: 131.459119ms)","trace[854035334] 'applied index is now lower than readState.Index' (duration: 8.208568ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:28.158499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.915412ms","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-08-20T16:53:28.158578Z","caller":"traceutil/trace.go:171","msg":"trace[2044474974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1974; }","duration":"140.050145ms","start":"2026-08-20T16:53:28.018511Z","end":"2026-08-20T16:53:28.158561Z","steps":["trace[2044474974] 'agreement among raft nodes before linearized reading' (duration: 139.826871ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:28.158314Z","caller":"traceutil/trace.go:171","msg":"trace[215860659] transaction","detail":"{read_only:false; response_revision:1974; number_of_response:1; }","duration":"361.563981ms","start":"2026-08-20T16:53:27.796716Z","end":"2026-08-20T16:53:28.15828Z","steps":["trace[215860659] 'process raft request' (duration: 353.300682ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:28.159199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:27.79667Z","time spent":"362.249345ms","remote":"127.0.0.1:46962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5620,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:53:28.164046Z","caller":"traceutil/trace.go:171","msg":"trace[43879379] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"105.480703ms","start":"2026-08-20T16:53:28.058539Z","end":"2026-08-20T16:53:28.16402Z","steps":["trace[43879379] 'process raft request' (duration: 105.362361ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:48.962816Z","caller":"traceutil/trace.go:171","msg":"trace[1278802846] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"112.5987ms","start":"2026-08-20T16:53:48.850189Z","end":"2026-08-20T16:53:48.962787Z","steps":["trace[1278802846] 'process raft request' (duration: 112.448498ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:54.376324Z","caller":"traceutil/trace.go:171","msg":"trace[1754128222] linearizableReadLoop","detail":"{readStateIndex:2208; appliedIndex:2207; }","duration":"132.642535ms","start":"2026-08-20T16:53:54.24366Z","end":"2026-08-20T16:53:54.376302Z","steps":["trace[1754128222] 'read index received' (duration: 132.37294ms)","trace[1754128222] 'applied index is now lower than readState.Index' (duration: 268.525µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:54.376472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.796207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-20T16:53:54.376508Z","caller":"traceutil/trace.go:171","msg":"trace[2031683708] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2132; }","duration":"132.893779ms","start":"2026-08-20T16:53:54.243605Z","end":"2026-08-20T16:53:54.376499Z","steps":["trace[2031683708] 'agreement among raft nodes before linearized reading' (duration: 132.810957ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:54.376373Z","caller":"traceutil/trace.go:171","msg":"trace[2040607438] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"134.478116ms","start":"2026-08-20T16:53:54.241874Z","end":"2026-08-20T16:53:54.376352Z","steps":["trace[2040607438] 'process raft request' (duration: 134.281323ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:54.730345Z","caller":"traceutil/trace.go:171","msg":"trace[802674970] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"187.37046ms","start":"2026-08-20T16:53:54.542954Z","end":"2026-08-20T16:53:54.730324Z","steps":["trace[802674970] 'process raft request' (duration: 187.242068ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:55.208122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.01073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-08-20T16:53:55.208191Z","caller":"traceutil/trace.go:171","msg":"trace[1558321989] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2135; }","duration":"184.136032ms","start":"2026-08-20T16:53:55.024033Z","end":"2026-08-20T16:53:55.208169Z","steps":["trace[1558321989] 'range keys from in-memory index tree' (duration: 183.925747ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:55.208268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.92309ms","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-20T16:53:55.208123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.005317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:122444"} {"level":"info","ts":"2026-08-20T16:53:55.208335Z","caller":"traceutil/trace.go:171","msg":"trace[597264830] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2135; }","duration":"225.037941ms","start":"2026-08-20T16:53:54.983279Z","end":"2026-08-20T16:53:55.208317Z","steps":["trace[597264830] 'range keys from in-memory index tree' (duration: 224.739626ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:55.20834Z","caller":"traceutil/trace.go:171","msg":"trace[1503813525] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2135; }","duration":"186.25107ms","start":"2026-08-20T16:53:55.022074Z","end":"2026-08-20T16:53:55.208325Z","steps":["trace[1503813525] 'range keys from in-memory index tree' (duration: 185.791051ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:56.121475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.444482ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:53:56.121738Z","caller":"traceutil/trace.go:171","msg":"trace[2025058829] linearizableReadLoop","detail":"{readStateIndex:2214; appliedIndex:2213; }","duration":"353.056673ms","start":"2026-08-20T16:53:55.768509Z","end":"2026-08-20T16:53:56.121566Z","steps":["trace[2025058829] 'read index received' (duration: 184.411447ms)","trace[2025058829] 'applied index is now lower than readState.Index' (duration: 168.643886ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:56.121945Z","caller":"traceutil/trace.go:171","msg":"trace[397452221] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"408.639123ms","start":"2026-08-20T16:53:55.712991Z","end":"2026-08-20T16:53:56.12163Z","steps":["trace[397452221] 'process raft request' (duration: 239.900606ms)","trace[397452221] 'compare' (duration: 168.355511ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:56.122272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:55.712976Z","time spent":"409.248414ms","remote":"127.0.0.1:47018","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-08-20T16:53:56.122449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.326694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-20T16:53:56.122508Z","caller":"traceutil/trace.go:171","msg":"trace[1552254785] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2138; }","duration":"221.420596ms","start":"2026-08-20T16:53:55.901073Z","end":"2026-08-20T16:53:56.122494Z","steps":["trace[1552254785] 'agreement among raft nodes before linearized reading' (duration: 221.271713ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:56.121967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.45289ms","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-08-20T16:53:56.122801Z","caller":"traceutil/trace.go:171","msg":"trace[2091278896] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2138; }","duration":"354.324355ms","start":"2026-08-20T16:53:55.768452Z","end":"2026-08-20T16:53:56.122777Z","steps":["trace[2091278896] 'agreement among raft nodes before linearized reading' (duration: 353.398818ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:56.1229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:55.768433Z","time spent":"354.436157ms","remote":"127.0.0.1:47018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T16:53:56.123119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.379023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18cd91b206b790bd\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-08-20T16:53:56.123181Z","caller":"traceutil/trace.go:171","msg":"trace[220448479] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18cd91b206b790bd; range_end:; response_count:1; response_revision:2138; }","duration":"191.257737ms","start":"2026-08-20T16:53:55.931907Z","end":"2026-08-20T16:53:56.123165Z","steps":["trace[220448479] 'agreement among raft nodes before linearized reading' (duration: 190.316641ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:56.123037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.035801ms","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-08-20T16:53:56.123452Z","caller":"traceutil/trace.go:171","msg":"trace[586199638] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2138; }","duration":"312.4921ms","start":"2026-08-20T16:53:55.81094Z","end":"2026-08-20T16:53:56.123432Z","steps":["trace[586199638] 'agreement among raft nodes before linearized reading' (duration: 311.106635ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:56.123501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:55.810927Z","time spent":"312.55892ms","remote":"127.0.0.1:35502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-08-20T16:53:56.300145Z","caller":"traceutil/trace.go:171","msg":"trace[1098065803] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"174.199135ms","start":"2026-08-20T16:53:56.125921Z","end":"2026-08-20T16:53:56.30012Z","steps":["trace[1098065803] 'process raft request' (duration: 170.57229ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:56.354666Z","caller":"traceutil/trace.go:171","msg":"trace[859958240] linearizableReadLoop","detail":"{readStateIndex:2217; appliedIndex:2214; }","duration":"221.871524ms","start":"2026-08-20T16:53:56.132772Z","end":"2026-08-20T16:53:56.354644Z","steps":["trace[859958240] 'read index received' (duration: 163.734438ms)","trace[859958240] 'applied index is now lower than readState.Index' (duration: 58.135946ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:56.354688Z","caller":"traceutil/trace.go:171","msg":"trace[846485495] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"227.692047ms","start":"2026-08-20T16:53:56.12698Z","end":"2026-08-20T16:53:56.354672Z","steps":["trace[846485495] 'process raft request' (duration: 227.498974ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:56.354848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.0047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T16:53:56.354916Z","caller":"traceutil/trace.go:171","msg":"trace[287027344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2141; }","duration":"120.11528ms","start":"2026-08-20T16:53:56.234793Z","end":"2026-08-20T16:53:56.354908Z","steps":["trace[287027344] 'agreement among raft nodes before linearized reading' (duration: 120.016398ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:56.354889Z","caller":"traceutil/trace.go:171","msg":"trace[1975465107] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"227.551725ms","start":"2026-08-20T16:53:56.12717Z","end":"2026-08-20T16:53:56.354721Z","steps":["trace[1975465107] 'process raft request' (duration: 227.439093ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:56.355224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.456024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T16:53:56.355291Z","caller":"traceutil/trace.go:171","msg":"trace[774389553] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2141; }","duration":"222.518476ms","start":"2026-08-20T16:53:56.132731Z","end":"2026-08-20T16:53:56.355249Z","steps":["trace[774389553] 'agreement among raft nodes before linearized reading' (duration: 222.009837ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:56.665773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.148466ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:53:56.665983Z","caller":"traceutil/trace.go:171","msg":"trace[2138936027] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2217; }","duration":"250.954753ms","start":"2026-08-20T16:53:56.415006Z","end":"2026-08-20T16:53:56.66596Z","steps":["trace[2138936027] 'read index received' (duration: 36.45068ms)","trace[2138936027] 'applied index is now lower than readState.Index' (duration: 214.501653ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:56.666133Z","caller":"traceutil/trace.go:171","msg":"trace[2000718845] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"285.328794ms","start":"2026-08-20T16:53:56.380773Z","end":"2026-08-20T16:53:56.666102Z","steps":["trace[2000718845] 'process raft request' (duration: 70.74888ms)","trace[2000718845] 'compare' (duration: 213.995234ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:56.666298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.275499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-20T16:53:56.666444Z","caller":"traceutil/trace.go:171","msg":"trace[1937807647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2142; }","duration":"251.462331ms","start":"2026-08-20T16:53:56.41497Z","end":"2026-08-20T16:53:56.666433Z","steps":["trace[1937807647] 'agreement among raft nodes before linearized reading' (duration: 251.130495ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:56.666502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.757749ms","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-20T16:53:56.666546Z","caller":"traceutil/trace.go:171","msg":"trace[138612484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2142; }","duration":"213.842371ms","start":"2026-08-20T16:53:56.452694Z","end":"2026-08-20T16:53:56.666536Z","steps":["trace[138612484] 'agreement among raft nodes before linearized reading' (duration: 213.729069ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:54:51.601002Z","caller":"traceutil/trace.go:171","msg":"trace[1879806017] transaction","detail":"{read_only:false; response_revision:2545; number_of_response:1; }","duration":"126.236727ms","start":"2026-08-20T16:54:51.474731Z","end":"2026-08-20T16:54:51.600968Z","steps":["trace[1879806017] 'process raft request' (duration: 126.039391ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:54:52.09916Z","caller":"traceutil/trace.go:171","msg":"trace[1499676285] transaction","detail":"{read_only:false; response_revision:2546; number_of_response:1; }","duration":"207.852602ms","start":"2026-08-20T16:54:51.891273Z","end":"2026-08-20T16:54:52.099126Z","steps":["trace[1499676285] 'process raft request' (duration: 207.726688ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:55:25.029855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.619391ms","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-08-20T16:55:25.029995Z","caller":"traceutil/trace.go:171","msg":"trace[1328267658] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2724; }","duration":"222.769996ms","start":"2026-08-20T16:55:24.807212Z","end":"2026-08-20T16:55:25.029982Z","steps":["trace[1328267658] 'range keys from in-memory index tree' (duration: 222.60604ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:55:25.0302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.356299ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:55:25.031552Z","caller":"traceutil/trace.go:171","msg":"trace[533194048] linearizableReadLoop","detail":"{readStateIndex:2822; appliedIndex:2821; }","duration":"196.219311ms","start":"2026-08-20T16:55:24.835319Z","end":"2026-08-20T16:55:25.031538Z","steps":["trace[533194048] 'read index received' (duration: 33.511µs)","trace[533194048] 'applied index is now lower than readState.Index' (duration: 196.184249ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:55:25.031691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.373336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-20T16:55:25.031722Z","caller":"traceutil/trace.go:171","msg":"trace[2064180908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2725; }","duration":"196.457408ms","start":"2026-08-20T16:55:24.835256Z","end":"2026-08-20T16:55:25.031714Z","steps":["trace[2064180908] 'agreement among raft nodes before linearized reading' (duration: 196.327654ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:55:25.031888Z","caller":"traceutil/trace.go:171","msg":"trace[736863551] transaction","detail":"{read_only:false; response_revision:2725; number_of_response:1; }","duration":"244.178259ms","start":"2026-08-20T16:55:24.787697Z","end":"2026-08-20T16:55:25.031875Z","steps":["trace[736863551] 'process raft request' (duration: 40.077819ms)","trace[736863551] 'compare' (duration: 201.991739ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:55:25.490535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.919581ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:55:25.49065Z","caller":"traceutil/trace.go:171","msg":"trace[1407811584] transaction","detail":"{read_only:false; response_revision:2731; number_of_response:1; }","duration":"315.698064ms","start":"2026-08-20T16:55:25.174931Z","end":"2026-08-20T16:55:25.490629Z","steps":["trace[1407811584] 'process raft request' (duration: 154.599217ms)","trace[1407811584] 'compare' (duration: 160.785148ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:55:25.490711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:55:25.174909Z","time spent":"315.775626ms","remote":"127.0.0.1:47018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T16:57:44.286386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.227208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-20T16:57:44.286487Z","caller":"traceutil/trace.go:171","msg":"trace[58605329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3549; }","duration":"135.40042ms","start":"2026-08-20T16:57:44.151063Z","end":"2026-08-20T16:57:44.286463Z","steps":["trace[58605329] 'range keys from in-memory index tree' (duration: 135.021852ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:12.15452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.674837ms","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-20T16:59:12.154686Z","caller":"traceutil/trace.go:171","msg":"trace[1036452339] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4615; }","duration":"107.896223ms","start":"2026-08-20T16:59:12.04677Z","end":"2026-08-20T16:59:12.154667Z","steps":["trace[1036452339] 'range keys from in-memory index tree' (duration: 106.807869ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:13.36764Z","caller":"traceutil/trace.go:171","msg":"trace[289112600] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"122.873773ms","start":"2026-08-20T16:59:13.244739Z","end":"2026-08-20T16:59:13.367613Z","steps":["trace[289112600] 'process raft request' (duration: 122.656238ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:19.021293Z","caller":"traceutil/trace.go:171","msg":"trace[696254339] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"380.436446ms","start":"2026-08-20T16:59:18.640831Z","end":"2026-08-20T16:59:19.021268Z","steps":["trace[696254339] 'process raft request' (duration: 380.282183ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:19.021428Z","caller":"traceutil/trace.go:171","msg":"trace[313897905] linearizableReadLoop","detail":"{readStateIndex:4899; appliedIndex:4899; }","duration":"292.870727ms","start":"2026-08-20T16:59:18.728536Z","end":"2026-08-20T16:59:19.021407Z","steps":["trace[313897905] 'read index received' (duration: 292.859767ms)","trace[313897905] 'applied index is now lower than readState.Index' (duration: 9.02µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:59:19.021495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:18.640809Z","time spent":"380.566479ms","remote":"127.0.0.1:47018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T16:59:19.021713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.172232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c1f98d40-6a2e-429c-a4f4-74402197bb4b\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-20T16:59:19.021776Z","caller":"traceutil/trace.go:171","msg":"trace[1143312209] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c1f98d40-6a2e-429c-a4f4-74402197bb4b; range_end:; response_count:1; response_revision:4726; }","duration":"293.278434ms","start":"2026-08-20T16:59:18.728481Z","end":"2026-08-20T16:59:19.021759Z","steps":["trace[1143312209] 'agreement among raft nodes before linearized reading' (duration: 293.06397ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:19.179756Z","caller":"traceutil/trace.go:171","msg":"trace[1465825402] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"349.28536ms","start":"2026-08-20T16:59:18.830442Z","end":"2026-08-20T16:59:19.179727Z","steps":["trace[1465825402] 'process raft request' (duration: 341.895042ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:19.179778Z","caller":"traceutil/trace.go:171","msg":"trace[2115474087] linearizableReadLoop","detail":"{readStateIndex:4900; appliedIndex:4899; }","duration":"158.227548ms","start":"2026-08-20T16:59:19.021512Z","end":"2026-08-20T16:59:19.17974Z","steps":["trace[2115474087] 'read index received' (duration: 150.897282ms)","trace[2115474087] 'applied index is now lower than readState.Index' (duration: 7.328336ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:59:19.17989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:18.830426Z","time spent":"349.403482ms","remote":"127.0.0.1:46862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T16:59:19.180347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.516326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c1f98d40-6a2e-429c-a4f4-74402197bb4b\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-20T16:59:19.180392Z","caller":"traceutil/trace.go:171","msg":"trace[749017369] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c1f98d40-6a2e-429c-a4f4-74402197bb4b; range_end:; response_count:1; response_revision:4727; }","duration":"350.594578ms","start":"2026-08-20T16:59:18.829787Z","end":"2026-08-20T16:59:19.180381Z","steps":["trace[749017369] 'agreement among raft nodes before linearized reading' (duration: 350.452715ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:19.180423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:18.829772Z","time spent":"350.643819ms","remote":"127.0.0.1:46962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c1f98d40-6a2e-429c-a4f4-74402197bb4b\" "} {"level":"warn","ts":"2026-08-20T16:59:19.180695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.635146ms","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-20T16:59:19.180742Z","caller":"traceutil/trace.go:171","msg":"trace[605209174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4727; }","duration":"377.731946ms","start":"2026-08-20T16:59:18.802999Z","end":"2026-08-20T16:59:19.18073Z","steps":["trace[605209174] 'agreement among raft nodes before linearized reading' (duration: 376.855628ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:19.180776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:18.80298Z","time spent":"377.788149ms","remote":"127.0.0.1:47018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-20T16:59:19.181094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.634123ms","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-08-20T16:59:19.181167Z","caller":"traceutil/trace.go:171","msg":"trace[1653408842] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4727; }","duration":"185.748346ms","start":"2026-08-20T16:59:18.995402Z","end":"2026-08-20T16:59:19.18115Z","steps":["trace[1653408842] 'agreement among raft nodes before linearized reading' (duration: 184.808046ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:19.189394Z","caller":"traceutil/trace.go:171","msg":"trace[1207177272] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"166.899943ms","start":"2026-08-20T16:59:19.022477Z","end":"2026-08-20T16:59:19.189377Z","steps":["trace[1207177272] 'process raft request' (duration: 166.77585ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:24.012661Z","caller":"traceutil/trace.go:171","msg":"trace[1248946849] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"103.199219ms","start":"2026-08-20T16:59:23.909412Z","end":"2026-08-20T16:59:24.012611Z","steps":["trace[1248946849] 'process raft request' (duration: 102.998154ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:24.129951Z","caller":"traceutil/trace.go:171","msg":"trace[570688363] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"106.058869ms","start":"2026-08-20T16:59:24.023873Z","end":"2026-08-20T16:59:24.129932Z","steps":["trace[570688363] 'process raft request' (duration: 105.875284ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:36.123344Z","caller":"traceutil/trace.go:171","msg":"trace[1694818318] linearizableReadLoop","detail":"{readStateIndex:5091; appliedIndex:5090; }","duration":"125.789443ms","start":"2026-08-20T16:59:35.99753Z","end":"2026-08-20T16:59:36.123319Z","steps":["trace[1694818318] 'read index received' (duration: 125.60202ms)","trace[1694818318] 'applied index is now lower than readState.Index' (duration: 186.443µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:59:36.123555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.008408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-20T16:59:36.12361Z","caller":"traceutil/trace.go:171","msg":"trace[273872065] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4912; }","duration":"126.115509ms","start":"2026-08-20T16:59:35.997482Z","end":"2026-08-20T16:59:36.123597Z","steps":["trace[273872065] 'agreement among raft nodes before linearized reading' (duration: 125.940015ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:36.123909Z","caller":"traceutil/trace.go:171","msg":"trace[1212759960] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"155.255286ms","start":"2026-08-20T16:59:35.968585Z","end":"2026-08-20T16:59:36.12384Z","steps":["trace[1212759960] 'process raft request' (duration: 154.532062ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:36.648304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.497976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:59:36.649105Z","caller":"traceutil/trace.go:171","msg":"trace[597495390] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"518.051705ms","start":"2026-08-20T16:59:36.131029Z","end":"2026-08-20T16:59:36.649081Z","steps":["trace[597495390] 'process raft request' (duration: 517.437463ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:36.649163Z","caller":"traceutil/trace.go:171","msg":"trace[2066437562] linearizableReadLoop","detail":"{readStateIndex:5092; appliedIndex:5091; }","duration":"519.794713ms","start":"2026-08-20T16:59:36.129344Z","end":"2026-08-20T16:59:36.649138Z","steps":["trace[2066437562] 'read index received' (duration: 402.377478ms)","trace[2066437562] 'applied index is now lower than readState.Index' (duration: 117.414975ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:59:36.649391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.043358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c1f98d40-6a2e-429c-a4f4-74402197bb4b\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-08-20T16:59:36.649426Z","caller":"traceutil/trace.go:171","msg":"trace[242855051] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c1f98d40-6a2e-429c-a4f4-74402197bb4b; range_end:; response_count:1; response_revision:4915; }","duration":"520.11358ms","start":"2026-08-20T16:59:36.129299Z","end":"2026-08-20T16:59:36.649413Z","steps":["trace[242855051] 'agreement among raft nodes before linearized reading' (duration: 519.952476ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:36.649478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:36.12921Z","time spent":"520.259973ms","remote":"127.0.0.1:46920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1345,"request content":"key:\"/registry/persistentvolumes/pvc-c1f98d40-6a2e-429c-a4f4-74402197bb4b\" "} {"level":"info","ts":"2026-08-20T16:59:36.649501Z","caller":"traceutil/trace.go:171","msg":"trace[1929073310] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"516.923772ms","start":"2026-08-20T16:59:36.132519Z","end":"2026-08-20T16:59:36.649443Z","steps":["trace[1929073310] 'process raft request' (duration: 516.064374ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:36.649703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:36.132497Z","time spent":"517.105335ms","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:59:36.649899Z","caller":"traceutil/trace.go:171","msg":"trace[1554065946] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"516.716108ms","start":"2026-08-20T16:59:36.133171Z","end":"2026-08-20T16:59:36.649887Z","steps":["trace[1554065946] 'process raft request' (duration: 515.459641ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:36.649967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:36.133164Z","time spent":"516.771328ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T16:59:36.650061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:36.131013Z","time spent":"518.160377ms","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:59:36.650263Z","caller":"traceutil/trace.go:171","msg":"trace[2097712109] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"516.781418ms","start":"2026-08-20T16:59:36.133465Z","end":"2026-08-20T16:59:36.650246Z","steps":["trace[2097712109] 'process raft request' (duration: 516.309458ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:36.65035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:36.13344Z","time spent":"516.869912ms","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:59:36.650406Z","caller":"traceutil/trace.go:171","msg":"trace[443083169] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"483.191138ms","start":"2026-08-20T16:59:36.167191Z","end":"2026-08-20T16:59:36.650382Z","steps":["trace[443083169] 'process raft request' (duration: 482.947822ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:36.650517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:36.167182Z","time spent":"483.27931ms","remote":"127.0.0.1:47018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:59:36.648908Z","caller":"traceutil/trace.go:171","msg":"trace[858899067] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"602.190178ms","start":"2026-08-20T16:59:36.046261Z","end":"2026-08-20T16:59:36.648451Z","steps":["trace[858899067] 'process raft request' (duration: 485.426135ms)","trace[858899067] 'compare' (duration: 116.258752ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:59:36.650699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:36.046244Z","time spent":"604.347832ms","remote":"127.0.0.1:47018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:59:36.650937Z","caller":"traceutil/trace.go:171","msg":"trace[1122281841] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"216.801989ms","start":"2026-08-20T16:59:36.434116Z","end":"2026-08-20T16:59:36.650918Z","steps":["trace[1122281841] 'process raft request' (duration: 216.135915ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:36.651452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.256184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-08-20T16:59:36.651455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.085927ms","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-08-20T16:59:36.651495Z","caller":"traceutil/trace.go:171","msg":"trace[1386743751] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4919; }","duration":"179.323106ms","start":"2026-08-20T16:59:36.472158Z","end":"2026-08-20T16:59:36.651482Z","steps":["trace[1386743751] 'agreement among raft nodes before linearized reading' (duration: 178.761874ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:59:36.651518Z","caller":"traceutil/trace.go:171","msg":"trace[2022548639] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4919; }","duration":"339.17731ms","start":"2026-08-20T16:59:36.312323Z","end":"2026-08-20T16:59:36.651501Z","steps":["trace[2022548639] 'agreement among raft nodes before linearized reading' (duration: 338.981406ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:36.651579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:36.312283Z","time spent":"339.282713ms","remote":"127.0.0.1:47018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-20T16:59:36.651665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.366726ms","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-08-20T16:59:36.651694Z","caller":"traceutil/trace.go:171","msg":"trace[245051207] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4919; }","duration":"393.419617ms","start":"2026-08-20T16:59:36.258268Z","end":"2026-08-20T16:59:36.651687Z","steps":["trace[245051207] 'agreement among raft nodes before linearized reading' (duration: 392.61199ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:59:36.651715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:59:36.258255Z","time spent":"393.454219ms","remote":"127.0.0.1:47018","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-08-20T17:00:53.627397Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2879} {"level":"info","ts":"2026-08-20T17:00:53.722916Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2879,"took":"94.396054ms","hash":3300027680,"current-db-size-bytes":54403072,"current-db-size":"54 MB","current-db-size-in-use-bytes":29429760,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-20T17:00:53.722977Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3300027680,"revision":2879,"compact-revision":-1} {"level":"info","ts":"2026-08-20T17:03:03.568721Z","caller":"traceutil/trace.go:171","msg":"trace[1302914930] linearizableReadLoop","detail":"{readStateIndex:6631; appliedIndex:6629; }","duration":"110.449728ms","start":"2026-08-20T17:03:03.458248Z","end":"2026-08-20T17:03:03.568698Z","steps":["trace[1302914930] 'read index received' (duration: 41.164113ms)","trace[1302914930] 'applied index is now lower than readState.Index' (duration: 69.284755ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T17:03:03.568798Z","caller":"traceutil/trace.go:171","msg":"trace[1321486375] transaction","detail":"{read_only:false; response_revision:6402; number_of_response:1; }","duration":"112.732118ms","start":"2026-08-20T17:03:03.456041Z","end":"2026-08-20T17:03:03.568773Z","steps":["trace[1321486375] 'process raft request' (duration: 112.49661ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T17:03:03.568945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.676906ms","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-20T17:03:03.568973Z","caller":"traceutil/trace.go:171","msg":"trace[46287586] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:6403; }","duration":"110.76311ms","start":"2026-08-20T17:03:03.458199Z","end":"2026-08-20T17:03:03.568962Z","steps":["trace[46287586] 'agreement among raft nodes before linearized reading' (duration: 110.612955ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T17:03:03.568965Z","caller":"traceutil/trace.go:171","msg":"trace[1743064917] transaction","detail":"{read_only:false; response_revision:6403; number_of_response:1; }","duration":"112.868433ms","start":"2026-08-20T17:03:03.456057Z","end":"2026-08-20T17:03:03.568925Z","steps":["trace[1743064917] 'process raft request' (duration: 112.607954ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T17:03:20.68682Z","caller":"traceutil/trace.go:171","msg":"trace[128505497] linearizableReadLoop","detail":"{readStateIndex:6777; appliedIndex:6776; }","duration":"117.757013ms","start":"2026-08-20T17:03:20.569034Z","end":"2026-08-20T17:03:20.686791Z","steps":["trace[128505497] 'read index received' (duration: 117.565727ms)","trace[128505497] 'applied index is now lower than readState.Index' (duration: 189.996µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T17:03:20.686902Z","caller":"traceutil/trace.go:171","msg":"trace[1159471752] transaction","detail":"{read_only:false; response_revision:6546; number_of_response:1; }","duration":"164.561443ms","start":"2026-08-20T17:03:20.522318Z","end":"2026-08-20T17:03:20.686879Z","steps":["trace[1159471752] 'process raft request' (duration: 164.280934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T17:03:20.687062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.011303ms","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-08-20T17:03:20.687109Z","caller":"traceutil/trace.go:171","msg":"trace[785088620] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6546; }","duration":"118.119346ms","start":"2026-08-20T17:03:20.568976Z","end":"2026-08-20T17:03:20.687095Z","steps":["trace[785088620] 'agreement among raft nodes before linearized reading' (duration: 117.93733ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T17:04:06.354813Z","caller":"traceutil/trace.go:171","msg":"trace[1053567281] transaction","detail":"{read_only:false; response_revision:6839; number_of_response:1; }","duration":"187.277708ms","start":"2026-08-20T17:04:06.167512Z","end":"2026-08-20T17:04:06.354789Z","steps":["trace[1053567281] 'process raft request' (duration: 174.335407ms)","trace[1053567281] 'compare' (duration: 12.764336ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T17:04:06.35505Z","caller":"traceutil/trace.go:171","msg":"trace[991500478] linearizableReadLoop","detail":"{readStateIndex:7082; appliedIndex:7081; }","duration":"186.170682ms","start":"2026-08-20T17:04:06.168839Z","end":"2026-08-20T17:04:06.355009Z","steps":["trace[991500478] 'read index received' (duration: 173.032404ms)","trace[991500478] 'applied index is now lower than readState.Index' (duration: 13.133828ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T17:04:06.355174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.291156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T17:04:06.355287Z","caller":"traceutil/trace.go:171","msg":"trace[1959859259] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:6839; }","duration":"186.422191ms","start":"2026-08-20T17:04:06.168821Z","end":"2026-08-20T17:04:06.355243Z","steps":["trace[1959859259] 'agreement among raft nodes before linearized reading' (duration: 186.261186ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T17:04:06.355307Z","caller":"traceutil/trace.go:171","msg":"trace[519028856] transaction","detail":"{read_only:false; response_revision:6840; number_of_response:1; }","duration":"105.378467ms","start":"2026-08-20T17:04:06.249917Z","end":"2026-08-20T17:04:06.355295Z","steps":["trace[519028856] 'process raft request' (duration: 104.83098ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T17:05:53.651214Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5550} {"level":"info","ts":"2026-08-20T17:05:53.765867Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5550,"took":"108.157253ms","hash":483836183,"current-db-size-bytes":54403072,"current-db-size":"54 MB","current-db-size-in-use-bytes":18587648,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-20T17:05:53.765922Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":483836183,"revision":5550,"compact-revision":2879}