{"level":"warn","ts":"2026-04-07T05:53:40.475373Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T05:53:40.475507Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-07T05:53:40.475578Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T05:53:40.475593Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-07T05:53:40.475611Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T05:53:40.476278Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-04-07T05:53:40.476354Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-07T05:53:40.480553Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.925879ms"} {"level":"info","ts":"2026-04-07T05:53:40.486187Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-04-07T05:53:40.486311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T05:53:40.486338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-04-07T05:53:40.486348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T05:53:40.486361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-04-07T05:53:40.486404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-04-07T05:53:40.498709Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T05:53:40.50016Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T05:53:40.501287Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-07T05:53:40.503558Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T05:53:40.503854Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T05:53:40.503833Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T05:53:40.503977Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T05:53:40.503994Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T05:53:40.505416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-04-07T05:53:40.505752Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-07T05:53:40.508055Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T05:53:40.508213Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-07T05:53:40.508286Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-07T05:53:40.508384Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T05:53:40.508457Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T05:53:40.786784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T05:53:40.786845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T05:53:40.786876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-04-07T05:53:40.786892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-04-07T05:53:40.786899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-07T05:53:40.786923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-04-07T05:53:40.78694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-07T05:53:40.787775Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T05:53:40.788013Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:53:40.788791Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:53:40.789189Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:53:40.78947Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T05:53:40.78954Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T05:53:40.789472Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:53:40.789661Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:53:40.78971Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:53:40.791987Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-04-07T05:53:40.792082Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-07T05:54:07.895356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.916743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T05:54:07.895428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.154392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T05:54:07.89551Z","caller":"traceutil/trace.go:171","msg":"trace[740588192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:500; }","duration":"109.140717ms","start":"2026-04-07T05:54:07.786343Z","end":"2026-04-07T05:54:07.895484Z","steps":["trace[740588192] 'range keys from in-memory index tree' (duration: 108.821961ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:07.895521Z","caller":"traceutil/trace.go:171","msg":"trace[845455528] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:500; }","duration":"182.318646ms","start":"2026-04-07T05:54:07.713179Z","end":"2026-04-07T05:54:07.895498Z","steps":["trace[845455528] 'range keys from in-memory index tree' (duration: 181.949438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:07.896029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.991307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-04-07T05:54:07.896092Z","caller":"traceutil/trace.go:171","msg":"trace[458071227] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:500; }","duration":"175.059228ms","start":"2026-04-07T05:54:07.721016Z","end":"2026-04-07T05:54:07.896075Z","steps":["trace[458071227] 'range keys from in-memory index tree' (duration: 174.685871ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:09.489613Z","caller":"traceutil/trace.go:171","msg":"trace[1208649338] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"100.564354ms","start":"2026-04-07T05:54:09.389015Z","end":"2026-04-07T05:54:09.489579Z","steps":["trace[1208649338] 'process raft request' (duration: 97.063053ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:09.498736Z","caller":"traceutil/trace.go:171","msg":"trace[1374412227] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"102.095276ms","start":"2026-04-07T05:54:09.396619Z","end":"2026-04-07T05:54:09.498714Z","steps":["trace[1374412227] 'process raft request' (duration: 101.635757ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:10.640203Z","caller":"traceutil/trace.go:171","msg":"trace[734590750] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"131.057154ms","start":"2026-04-07T05:54:10.50911Z","end":"2026-04-07T05:54:10.640167Z","steps":["trace[734590750] 'process raft request' (duration: 130.683067ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:15.59473Z","caller":"traceutil/trace.go:171","msg":"trace[895574272] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"130.258458ms","start":"2026-04-07T05:54:15.464445Z","end":"2026-04-07T05:54:15.594703Z","steps":["trace[895574272] 'read index received' (duration: 129.568975ms)","trace[895574272] 'applied index is now lower than readState.Index' (duration: 688.643µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:54:15.594834Z","caller":"traceutil/trace.go:171","msg":"trace[967472673] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"186.217685ms","start":"2026-04-07T05:54:15.408587Z","end":"2026-04-07T05:54:15.594804Z","steps":["trace[967472673] 'process raft request' (duration: 185.679755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:15.594907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.449142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-q84mj\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-07T05:54:15.594933Z","caller":"traceutil/trace.go:171","msg":"trace[1576804234] range","detail":"{range_begin:/registry/pods/kube-system/cilium-q84mj; range_end:; response_count:1; response_revision:613; }","duration":"130.493713ms","start":"2026-04-07T05:54:15.464431Z","end":"2026-04-07T05:54:15.594925Z","steps":["trace[1576804234] 'agreement among raft nodes before linearized reading' (duration: 130.36369ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:15.722293Z","caller":"traceutil/trace.go:171","msg":"trace[1423106784] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"114.2ms","start":"2026-04-07T05:54:15.608054Z","end":"2026-04-07T05:54:15.722254Z","steps":["trace[1423106784] 'process raft request' (duration: 72.234217ms)","trace[1423106784] 'compare' (duration: 41.666357ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:54:16.356022Z","caller":"traceutil/trace.go:171","msg":"trace[707131544] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"423.895746ms","start":"2026-04-07T05:54:15.932102Z","end":"2026-04-07T05:54:16.355997Z","steps":["trace[707131544] 'process raft request' (duration: 423.750043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:16.356658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:15.932089Z","time spent":"424.006459ms","remote":"127.0.0.1:44656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4542,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:54:16.369162Z","caller":"traceutil/trace.go:171","msg":"trace[807403774] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"434.111894ms","start":"2026-04-07T05:54:15.935033Z","end":"2026-04-07T05:54:16.369145Z","steps":["trace[807403774] 'process raft request' (duration: 433.805408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:16.36929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:15.935011Z","time spent":"434.233006ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:54:16.369789Z","caller":"traceutil/trace.go:171","msg":"trace[671238278] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"164.908362ms","start":"2026-04-07T05:54:16.204853Z","end":"2026-04-07T05:54:16.369761Z","steps":["trace[671238278] 'process raft request' (duration: 164.854261ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:16.369858Z","caller":"traceutil/trace.go:171","msg":"trace[828704099] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"258.485034ms","start":"2026-04-07T05:54:16.111335Z","end":"2026-04-07T05:54:16.36982Z","steps":["trace[828704099] 'process raft request' (duration: 257.854311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:30.990393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.79321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T05:54:30.990501Z","caller":"traceutil/trace.go:171","msg":"trace[1255244132] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:777; }","duration":"158.941462ms","start":"2026-04-07T05:54:30.831538Z","end":"2026-04-07T05:54:30.990479Z","steps":["trace[1255244132] 'range keys from in-memory index tree' (duration: 158.603316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:30.990489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.44627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-07T05:54:30.990516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.234871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:54:30.990578Z","caller":"traceutil/trace.go:171","msg":"trace[672117253] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:777; }","duration":"202.335752ms","start":"2026-04-07T05:54:30.788227Z","end":"2026-04-07T05:54:30.990562Z","steps":["trace[672117253] 'range keys from in-memory index tree' (duration: 202.133048ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:30.990575Z","caller":"traceutil/trace.go:171","msg":"trace[1904350441] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:777; }","duration":"252.599823ms","start":"2026-04-07T05:54:30.737954Z","end":"2026-04-07T05:54:30.990554Z","steps":["trace[1904350441] 'range keys from in-memory index tree' (duration: 252.269857ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:01.516362Z","caller":"traceutil/trace.go:171","msg":"trace[904964857] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"196.598771ms","start":"2026-04-07T05:55:01.319738Z","end":"2026-04-07T05:55:01.516336Z","steps":["trace[904964857] 'process raft request' (duration: 196.403297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:47.460431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.144921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T05:55:47.460533Z","caller":"traceutil/trace.go:171","msg":"trace[249198196] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1853; }","duration":"202.277864ms","start":"2026-04-07T05:55:47.258236Z","end":"2026-04-07T05:55:47.460513Z","steps":["trace[249198196] 'count revisions from in-memory index tree' (duration: 202.011698ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:55.069012Z","caller":"traceutil/trace.go:171","msg":"trace[1551913112] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"140.857704ms","start":"2026-04-07T05:55:54.928117Z","end":"2026-04-07T05:55:55.068975Z","steps":["trace[1551913112] 'process raft request' (duration: 140.613639ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:58.855175Z","caller":"traceutil/trace.go:171","msg":"trace[769767088] transaction","detail":"{read_only:false; response_revision:1951; number_of_response:1; }","duration":"124.597435ms","start":"2026-04-07T05:55:58.730543Z","end":"2026-04-07T05:55:58.85514Z","steps":["trace[769767088] 'process raft request' (duration: 124.423861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:38.087748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.596992ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:56:38.08798Z","caller":"traceutil/trace.go:171","msg":"trace[1770399648] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2257; }","duration":"300.259747ms","start":"2026-04-07T05:56:37.787703Z","end":"2026-04-07T05:56:38.087963Z","steps":["trace[1770399648] 'read index received' (duration: 90.231596ms)","trace[1770399648] 'applied index is now lower than readState.Index' (duration: 210.02709ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:56:38.088032Z","caller":"traceutil/trace.go:171","msg":"trace[804741617] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"327.554051ms","start":"2026-04-07T05:56:37.760445Z","end":"2026-04-07T05:56:38.087999Z","steps":["trace[804741617] 'process raft request' (duration: 327.462888ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:56:38.087998Z","caller":"traceutil/trace.go:171","msg":"trace[789029746] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"328.122683ms","start":"2026-04-07T05:56:37.759841Z","end":"2026-04-07T05:56:38.087963Z","steps":["trace[789029746] 'process raft request' (duration: 118.065702ms)","trace[789029746] 'compare' (duration: 209.463979ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:56:38.088214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:37.759812Z","time spent":"328.341308ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:56:38.088226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.184295ms","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":"warn","ts":"2026-04-07T05:56:38.088237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:37.760422Z","time spent":"327.720865ms","remote":"127.0.0.1:44768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:56:38.08827Z","caller":"traceutil/trace.go:171","msg":"trace[1324294165] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2178; }","duration":"152.276937ms","start":"2026-04-07T05:56:37.93598Z","end":"2026-04-07T05:56:38.088257Z","steps":["trace[1324294165] 'agreement among raft nodes before linearized reading' (duration: 152.130074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:38.088243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.505812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:56:38.088365Z","caller":"traceutil/trace.go:171","msg":"trace[795666242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2178; }","duration":"300.664035ms","start":"2026-04-07T05:56:37.78767Z","end":"2026-04-07T05:56:38.088334Z","steps":["trace[795666242] 'agreement among raft nodes before linearized reading' (duration: 300.42078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:38.088428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:56:37.787657Z","time spent":"300.761328ms","remote":"127.0.0.1:44490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T05:57:55.535599Z","caller":"traceutil/trace.go:171","msg":"trace[2045488853] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"117.078948ms","start":"2026-04-07T05:57:55.418489Z","end":"2026-04-07T05:57:55.535568Z","steps":["trace[2045488853] 'process raft request' (duration: 84.297093ms)","trace[2045488853] 'compare' (duration: 32.646323ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:58:01.611931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.079319ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:58:01.612111Z","caller":"traceutil/trace.go:171","msg":"trace[1658917210] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"218.188877ms","start":"2026-04-07T05:58:01.393892Z","end":"2026-04-07T05:58:01.61208Z","steps":["trace[1658917210] 'process raft request' (duration: 101.846603ms)","trace[1658917210] 'compare' (duration: 115.955217ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:58:07.428011Z","caller":"traceutil/trace.go:171","msg":"trace[1964739190] transaction","detail":"{read_only:false; response_revision:2857; number_of_response:1; }","duration":"102.098878ms","start":"2026-04-07T05:58:07.325885Z","end":"2026-04-07T05:58:07.427984Z","steps":["trace[1964739190] 'process raft request' (duration: 101.948785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:01:52.597116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.862139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T06:01:52.597346Z","caller":"traceutil/trace.go:171","msg":"trace[985672402] transaction","detail":"{read_only:false; response_revision:4961; number_of_response:1; }","duration":"129.756438ms","start":"2026-04-07T06:01:52.467567Z","end":"2026-04-07T06:01:52.597324Z","steps":["trace[985672402] 'process raft request' (duration: 129.652545ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:01:52.597469Z","caller":"traceutil/trace.go:171","msg":"trace[348402014] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"156.290338ms","start":"2026-04-07T06:01:52.441146Z","end":"2026-04-07T06:01:52.597436Z","steps":["trace[348402014] 'process raft request' (duration: 24.02025ms)","trace[348402014] 'compare' (duration: 131.743367ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:02:04.812083Z","caller":"traceutil/trace.go:171","msg":"trace[1702228983] transaction","detail":"{read_only:false; response_revision:5192; number_of_response:1; }","duration":"158.955246ms","start":"2026-04-07T06:02:04.653099Z","end":"2026-04-07T06:02:04.812054Z","steps":["trace[1702228983] 'process raft request' (duration: 158.773653ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:02:04.821965Z","caller":"traceutil/trace.go:171","msg":"trace[1344725166] transaction","detail":"{read_only:false; response_revision:5193; number_of_response:1; }","duration":"168.16988ms","start":"2026-04-07T06:02:04.653773Z","end":"2026-04-07T06:02:04.821943Z","steps":["trace[1344725166] 'process raft request' (duration: 168.015067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:02:12.422416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.699547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T06:02:12.422634Z","caller":"traceutil/trace.go:171","msg":"trace[2115008046] linearizableReadLoop","detail":"{readStateIndex:5566; appliedIndex:5565; }","duration":"214.191591ms","start":"2026-04-07T06:02:12.208423Z","end":"2026-04-07T06:02:12.422615Z","steps":["trace[2115008046] 'read index received' (duration: 238.065µs)","trace[2115008046] 'applied index is now lower than readState.Index' (duration: 213.951716ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:02:12.422755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.333773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-715febef-79f3-4212-8643-f70d4c351c43\" ","response":"range_response_count:1 size:3765"} {"level":"info","ts":"2026-04-07T06:02:12.422831Z","caller":"traceutil/trace.go:171","msg":"trace[617071195] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-715febef-79f3-4212-8643-f70d4c351c43; range_end:; response_count:1; response_revision:5363; }","duration":"214.441226ms","start":"2026-04-07T06:02:12.208376Z","end":"2026-04-07T06:02:12.422817Z","steps":["trace[617071195] 'agreement among raft nodes before linearized reading' (duration: 214.326333ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:02:12.4228Z","caller":"traceutil/trace.go:171","msg":"trace[2132354145] transaction","detail":"{read_only:false; response_revision:5363; number_of_response:1; }","duration":"411.603345ms","start":"2026-04-07T06:02:12.011163Z","end":"2026-04-07T06:02:12.422766Z","steps":["trace[2132354145] 'process raft request' (duration: 70.454388ms)","trace[2132354145] 'compare' (duration: 340.572554ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:02:12.423067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:02:12.011135Z","time spent":"411.804648ms","remote":"127.0.0.1:44672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3750,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T06:03:40.840212Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3040} {"level":"info","ts":"2026-04-07T06:03:40.928133Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3040,"took":"86.32075ms","hash":2762567730,"current-db-size-bytes":58937344,"current-db-size":"59 MB","current-db-size-in-use-bytes":31920128,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-07T06:03:40.928206Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2762567730,"revision":3040,"compact-revision":-1} {"level":"info","ts":"2026-04-07T06:08:39.03892Z","caller":"traceutil/trace.go:171","msg":"trace[1315498796] transaction","detail":"{read_only:false; response_revision:8307; number_of_response:1; }","duration":"163.857061ms","start":"2026-04-07T06:08:38.875036Z","end":"2026-04-07T06:08:39.038893Z","steps":["trace[1315498796] 'process raft request' (duration: 163.606686ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:08:39.06701Z","caller":"traceutil/trace.go:171","msg":"trace[1607034841] transaction","detail":"{read_only:false; response_revision:8308; number_of_response:1; }","duration":"175.900244ms","start":"2026-04-07T06:08:38.891076Z","end":"2026-04-07T06:08:39.066976Z","steps":["trace[1607034841] 'process raft request' (duration: 175.69656ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:08:40.054684Z","caller":"traceutil/trace.go:171","msg":"trace[739161508] linearizableReadLoop","detail":"{readStateIndex:8608; appliedIndex:8607; }","duration":"120.392663ms","start":"2026-04-07T06:08:39.934264Z","end":"2026-04-07T06:08:40.054657Z","steps":["trace[739161508] 'read index received' (duration: 120.161058ms)","trace[739161508] 'applied index is now lower than readState.Index' (duration: 230.395µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:08:40.054829Z","caller":"traceutil/trace.go:171","msg":"trace[1721904469] transaction","detail":"{read_only:false; response_revision:8310; number_of_response:1; }","duration":"132.016468ms","start":"2026-04-07T06:08:39.922782Z","end":"2026-04-07T06:08:40.054799Z","steps":["trace[1721904469] 'process raft request' (duration: 131.700002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:08:40.054928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.655528ms","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-04-07T06:08:40.055102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.529174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-07T06:08:40.055129Z","caller":"traceutil/trace.go:171","msg":"trace[677140177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8310; }","duration":"120.871962ms","start":"2026-04-07T06:08:39.934245Z","end":"2026-04-07T06:08:40.055117Z","steps":["trace[677140177] 'agreement among raft nodes before linearized reading' (duration: 120.547066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:08:40.055139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.133084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T06:08:40.055188Z","caller":"traceutil/trace.go:171","msg":"trace[1245470774] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8310; }","duration":"115.682617ms","start":"2026-04-07T06:08:39.939487Z","end":"2026-04-07T06:08:40.055169Z","steps":["trace[1245470774] 'agreement among raft nodes before linearized reading' (duration: 115.417242ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:08:40.055242Z","caller":"traceutil/trace.go:171","msg":"trace[1780053525] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8310; }","duration":"102.291647ms","start":"2026-04-07T06:08:39.952926Z","end":"2026-04-07T06:08:40.055218Z","steps":["trace[1780053525] 'agreement among raft nodes before linearized reading' (duration: 101.995051ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:08:40.966942Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6151} {"level":"info","ts":"2026-04-07T06:08:40.967074Z","caller":"traceutil/trace.go:171","msg":"trace[312588462] compact","detail":"{revision:6151; response_revision:8317; }","duration":"107.791688ms","start":"2026-04-07T06:08:40.859248Z","end":"2026-04-07T06:08:40.96704Z","steps":["trace[312588462] 'process raft request' (duration: 50.776075ms)","trace[312588462] 'check and update compact revision' (duration: 56.727977ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:08:41.369869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.994547ms","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-04-07T06:08:41.370012Z","caller":"traceutil/trace.go:171","msg":"trace[692957444] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8318; }","duration":"175.15296ms","start":"2026-04-07T06:08:41.194795Z","end":"2026-04-07T06:08:41.369947Z","steps":["trace[692957444] 'range keys from in-memory index tree' (duration: 174.851575ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:08:41.389123Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6151,"took":"419.15074ms","hash":2143974567,"current-db-size-bytes":58937344,"current-db-size":"59 MB","current-db-size-in-use-bytes":23162880,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-07T06:08:41.38919Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2143974567,"revision":6151,"compact-revision":3040} {"level":"info","ts":"2026-04-07T06:09:09.461646Z","caller":"traceutil/trace.go:171","msg":"trace[2116745298] linearizableReadLoop","detail":"{readStateIndex:8831; appliedIndex:8830; }","duration":"321.082268ms","start":"2026-04-07T06:09:09.140529Z","end":"2026-04-07T06:09:09.461611Z","steps":["trace[2116745298] 'read index received' (duration: 293.841468ms)","trace[2116745298] 'applied index is now lower than readState.Index' (duration: 27.23908ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:09:09.462198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.642424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-07T06:09:09.462124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.438756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:09:09.462258Z","caller":"traceutil/trace.go:171","msg":"trace[1274849651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8523; }","duration":"191.787507ms","start":"2026-04-07T06:09:09.270457Z","end":"2026-04-07T06:09:09.462245Z","steps":["trace[1274849651] 'agreement among raft nodes before linearized reading' (duration: 191.344467ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:09:09.462336Z","caller":"traceutil/trace.go:171","msg":"trace[89668953] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:8523; }","duration":"321.799844ms","start":"2026-04-07T06:09:09.140503Z","end":"2026-04-07T06:09:09.462303Z","steps":["trace[89668953] 'agreement among raft nodes before linearized reading' (duration: 321.248122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:09:09.462481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:09:09.140491Z","time spent":"321.934806ms","remote":"127.0.0.1:53038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true "} {"level":"info","ts":"2026-04-07T06:09:22.191453Z","caller":"traceutil/trace.go:171","msg":"trace[76898009] transaction","detail":"{read_only:false; response_revision:8633; number_of_response:1; }","duration":"175.843464ms","start":"2026-04-07T06:09:22.015575Z","end":"2026-04-07T06:09:22.191419Z","steps":["trace[76898009] 'process raft request' (duration: 175.635388ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:09:22.837095Z","caller":"traceutil/trace.go:171","msg":"trace[922478813] linearizableReadLoop","detail":"{readStateIndex:8956; appliedIndex:8955; }","duration":"143.781165ms","start":"2026-04-07T06:09:22.693281Z","end":"2026-04-07T06:09:22.837062Z","steps":["trace[922478813] 'read index received' (duration: 130.359853ms)","trace[922478813] 'applied index is now lower than readState.Index' (duration: 13.419662ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:09:22.837255Z","caller":"traceutil/trace.go:171","msg":"trace[1738181774] transaction","detail":"{read_only:false; response_revision:8643; number_of_response:1; }","duration":"190.864677ms","start":"2026-04-07T06:09:22.646373Z","end":"2026-04-07T06:09:22.837238Z","steps":["trace[1738181774] 'process raft request' (duration: 177.335894ms)","trace[1738181774] 'compare' (duration: 12.904811ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:09:22.837652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.337547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:09:22.837763Z","caller":"traceutil/trace.go:171","msg":"trace[829045266] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:8643; }","duration":"144.511339ms","start":"2026-04-07T06:09:22.69323Z","end":"2026-04-07T06:09:22.837742Z","steps":["trace[829045266] 'agreement among raft nodes before linearized reading' (duration: 144.336666ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:09:23.216161Z","caller":"traceutil/trace.go:171","msg":"trace[1942026696] linearizableReadLoop","detail":"{readStateIndex:8957; appliedIndex:8956; }","duration":"112.131696ms","start":"2026-04-07T06:09:23.104006Z","end":"2026-04-07T06:09:23.216138Z","steps":["trace[1942026696] 'read index received' (duration: 111.82023ms)","trace[1942026696] 'applied index is now lower than readState.Index' (duration: 310.576µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:09:23.216583Z","caller":"traceutil/trace.go:171","msg":"trace[379308489] transaction","detail":"{read_only:false; response_revision:8644; number_of_response:1; }","duration":"274.798864ms","start":"2026-04-07T06:09:22.941737Z","end":"2026-04-07T06:09:23.216536Z","steps":["trace[379308489] 'process raft request' (duration: 274.234952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:09:23.216666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.640077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v5z5z\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-07T06:09:23.216841Z","caller":"traceutil/trace.go:171","msg":"trace[2050135324] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v5z5z; range_end:; response_count:1; response_revision:8644; }","duration":"112.836601ms","start":"2026-04-07T06:09:23.103935Z","end":"2026-04-07T06:09:23.216771Z","steps":["trace[2050135324] 'agreement among raft nodes before linearized reading' (duration: 112.508723ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:09:58.067253Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000245a.wal"} {"level":"info","ts":"2026-04-07T06:11:16.845133Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ba52c55cf4193752","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T06:11:16.851288Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T06:11:16.851434Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T06:13:40.973645Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8317} {"level":"info","ts":"2026-04-07T06:13:41.055162Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8317,"took":"78.591465ms","hash":3562985882,"current-db-size-bytes":58937344,"current-db-size":"59 MB","current-db-size-in-use-bytes":23511040,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-07T06:13:41.055255Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3562985882,"revision":8317,"compact-revision":6151} {"level":"info","ts":"2026-04-07T06:18:40.981173Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10538} {"level":"info","ts":"2026-04-07T06:18:41.059827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10538,"took":"76.122558ms","hash":3018752874,"current-db-size-bytes":58937344,"current-db-size":"59 MB","current-db-size-in-use-bytes":20832256,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-07T06:18:41.060037Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3018752874,"revision":10538,"compact-revision":8317}