{"level":"warn","ts":"2026-04-18T22:14:25.916405Z","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-18T22:14:25.916509Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.77: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.77:2380","--initial-cluster=instance=https://199.204.45.77:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.77:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.77: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-18T22:14:25.916586Z","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-18T22:14:25.916603Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-04-18T22:14:25.916653Z","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-18T22:14:25.917576Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"]} {"level":"info","ts":"2026-04-18T22:14:25.91776Z","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.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.77: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-18T22:14:25.923501Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.071169ms"} {"level":"info","ts":"2026-04-18T22:14:25.929406Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9133559b3198d4ec","cluster-id":"60f1aee33b0786f5"} {"level":"info","ts":"2026-04-18T22:14:25.929453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T22:14:25.929519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 0"} {"level":"info","ts":"2026-04-18T22:14:25.929544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9133559b3198d4ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T22:14:25.929556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 1"} {"level":"info","ts":"2026-04-18T22:14:25.929598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"warn","ts":"2026-04-18T22:14:25.941836Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T22:14:25.946205Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T22:14:25.947507Z","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-18T22:14:25.950493Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9133559b3198d4ec","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T22:14:25.950717Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9133559b3198d4ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T22:14:25.950726Z","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-18T22:14:25.950883Z","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-18T22:14:25.950909Z","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-18T22:14:25.951535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"info","ts":"2026-04-18T22:14:25.951629Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","added-peer-id":"9133559b3198d4ec","added-peer-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-04-18T22:14:25.954201Z","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-18T22:14:25.954434Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9133559b3198d4ec","initial-advertise-peer-urls":["https://199.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T22:14:25.954471Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T22:14:25.954614Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-04-18T22:14:25.954631Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-04-18T22:14:26.429941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T22:14:26.430059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T22:14:26.430144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgPreVoteResp from 9133559b3198d4ec at term 1"} {"level":"info","ts":"2026-04-18T22:14:26.430219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became candidate at term 2"} {"level":"info","ts":"2026-04-18T22:14:26.430244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgVoteResp from 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-04-18T22:14:26.430288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became leader at term 2"} {"level":"info","ts":"2026-04-18T22:14:26.430312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9133559b3198d4ec elected leader 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-04-18T22:14:26.43141Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9133559b3198d4ec","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.77:2379]}","request-path":"/0/members/9133559b3198d4ec/attributes","cluster-id":"60f1aee33b0786f5","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T22:14:26.431654Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:14:26.431742Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:14:26.43186Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:14:26.433606Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-18T22:14:26.446145Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:14:26.447032Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T22:14:26.449524Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T22:14:26.448766Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.77:2379"} {"level":"info","ts":"2026-04-18T22:14:26.449493Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:14:26.449742Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:15:01.854775Z","caller":"traceutil/trace.go:171","msg":"trace[1144217970] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"199.523811ms","start":"2026-04-18T22:15:01.655226Z","end":"2026-04-18T22:15:01.854749Z","steps":["trace[1144217970] 'process raft request' (duration: 198.842695ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:02.684982Z","caller":"traceutil/trace.go:171","msg":"trace[903062635] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"531.754807ms","start":"2026-04-18T22:15:02.153197Z","end":"2026-04-18T22:15:02.684952Z","steps":["trace[903062635] 'process raft request' (duration: 531.591334ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:02.685046Z","caller":"traceutil/trace.go:171","msg":"trace[178428153] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:595; }","duration":"462.690155ms","start":"2026-04-18T22:15:02.22232Z","end":"2026-04-18T22:15:02.68501Z","steps":["trace[178428153] 'read index received' (duration: 462.675115ms)","trace[178428153] 'applied index is now lower than readState.Index' (duration: 11.89µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:15:02.685348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.004832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-18T22:15:02.685431Z","caller":"traceutil/trace.go:171","msg":"trace[49254947] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:573; }","duration":"463.150415ms","start":"2026-04-18T22:15:02.22227Z","end":"2026-04-18T22:15:02.68542Z","steps":["trace[49254947] 'agreement among raft nodes before linearized reading' (duration: 462.886719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:15:02.685503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.22225Z","time spent":"463.217886ms","remote":"127.0.0.1:55236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-18T22:15:02.6858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.153169Z","time spent":"531.909751ms","remote":"127.0.0.1:55236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:15:02.718767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.484654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-18T22:15:02.718884Z","caller":"traceutil/trace.go:171","msg":"trace[318347112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:574; }","duration":"414.641067ms","start":"2026-04-18T22:15:02.30422Z","end":"2026-04-18T22:15:02.718861Z","steps":["trace[318347112] 'agreement among raft nodes before linearized reading' (duration: 414.419002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:15:02.718923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.304195Z","time spent":"414.719829ms","remote":"127.0.0.1:55236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-18T22:15:02.719118Z","caller":"traceutil/trace.go:171","msg":"trace[594028549] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"393.129772ms","start":"2026-04-18T22:15:02.325974Z","end":"2026-04-18T22:15:02.719104Z","steps":["trace[594028549] 'process raft request' (duration: 392.175572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:15:02.719189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.32593Z","time spent":"393.212183ms","remote":"127.0.0.1:55050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:15:02.719406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.398064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lpdjd\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-18T22:15:02.719469Z","caller":"traceutil/trace.go:171","msg":"trace[1780775645] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lpdjd; range_end:; response_count:1; response_revision:574; }","duration":"359.484975ms","start":"2026-04-18T22:15:02.359971Z","end":"2026-04-18T22:15:02.719456Z","steps":["trace[1780775645] 'agreement among raft nodes before linearized reading' (duration: 359.336262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:15:02.719508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.359954Z","time spent":"359.545727ms","remote":"127.0.0.1:55140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-lpdjd\" "} {"level":"warn","ts":"2026-04-18T22:15:02.7196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.641589ms","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-04-18T22:15:02.719694Z","caller":"traceutil/trace.go:171","msg":"trace[104124854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:574; }","duration":"372.789793ms","start":"2026-04-18T22:15:02.346879Z","end":"2026-04-18T22:15:02.719669Z","steps":["trace[104124854] 'agreement among raft nodes before linearized reading' (duration: 372.572779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:15:02.719755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.346856Z","time spent":"372.886715ms","remote":"127.0.0.1:55236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-18T22:15:03.20314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.531091ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:15:03.203552Z","caller":"traceutil/trace.go:171","msg":"trace[50836666] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"466.911446ms","start":"2026-04-18T22:15:02.736625Z","end":"2026-04-18T22:15:03.203536Z","steps":["trace[50836666] 'process raft request' (duration: 466.861515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:15:03.203721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.736595Z","time spent":"467.002088ms","remote":"127.0.0.1:55140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:15:03.203742Z","caller":"traceutil/trace.go:171","msg":"trace[789252990] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"479.870496ms","start":"2026-04-18T22:15:02.723834Z","end":"2026-04-18T22:15:03.203705Z","steps":["trace[789252990] 'process raft request' (duration: 479.417676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:15:03.203902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.723806Z","time spent":"480.014399ms","remote":"127.0.0.1:55236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:15:03.20391Z","caller":"traceutil/trace.go:171","msg":"trace[1787822620] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"479.815685ms","start":"2026-04-18T22:15:02.724068Z","end":"2026-04-18T22:15:03.203883Z","steps":["trace[1787822620] 'process raft request' (duration: 479.375205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:15:03.204057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.724043Z","time spent":"479.948138ms","remote":"127.0.0.1:55236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:15:03.204333Z","caller":"traceutil/trace.go:171","msg":"trace[759711794] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"514.377851ms","start":"2026-04-18T22:15:02.689913Z","end":"2026-04-18T22:15:03.204291Z","steps":["trace[759711794] 'process raft request' (duration: 76.464832ms)","trace[759711794] 'compare' (duration: 436.357666ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:15:03.204632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.689883Z","time spent":"514.547515ms","remote":"127.0.0.1:55236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:15:03.205779Z","caller":"traceutil/trace.go:171","msg":"trace[1537678844] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:596; }","duration":"300.670395ms","start":"2026-04-18T22:15:02.905089Z","end":"2026-04-18T22:15:03.20576Z","steps":["trace[1537678844] 'read index received' (duration: 290.430043ms)","trace[1537678844] 'applied index is now lower than readState.Index' (duration: 10.236001ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:15:03.206258Z","caller":"traceutil/trace.go:171","msg":"trace[1807018210] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"425.977062ms","start":"2026-04-18T22:15:02.780236Z","end":"2026-04-18T22:15:03.206213Z","steps":["trace[1807018210] 'process raft request' (duration: 425.193205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:15:03.206507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.780212Z","time spent":"426.180656ms","remote":"127.0.0.1:55502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:15:03.20675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.646495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-18T22:15:03.206883Z","caller":"traceutil/trace.go:171","msg":"trace[157341730] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:579; }","duration":"301.83776ms","start":"2026-04-18T22:15:02.905009Z","end":"2026-04-18T22:15:03.206847Z","steps":["trace[157341730] 'agreement among raft nodes before linearized reading' (duration: 301.271428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:15:03.206953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:15:02.904979Z","time spent":"301.961692ms","remote":"127.0.0.1:55236","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-04-18T22:15:03.207496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.59491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:15:03.207623Z","caller":"traceutil/trace.go:171","msg":"trace[241460224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"167.746594ms","start":"2026-04-18T22:15:03.039846Z","end":"2026-04-18T22:15:03.207592Z","steps":["trace[241460224] 'agreement among raft nodes before linearized reading' (duration: 167.520169ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:26.609264Z","caller":"traceutil/trace.go:171","msg":"trace[219803460] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"119.245617ms","start":"2026-04-18T22:15:26.489995Z","end":"2026-04-18T22:15:26.60924Z","steps":["trace[219803460] 'process raft request' (duration: 119.071323ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:17.952449Z","caller":"traceutil/trace.go:171","msg":"trace[303017520] transaction","detail":"{read_only:false; response_revision:1417; number_of_response:1; }","duration":"101.199708ms","start":"2026-04-18T22:16:17.851215Z","end":"2026-04-18T22:16:17.952415Z","steps":["trace[303017520] 'process raft request' (duration: 96.295722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:41.987091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.224836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-18T22:16:41.987253Z","caller":"traceutil/trace.go:171","msg":"trace[1098414199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1813; }","duration":"294.427311ms","start":"2026-04-18T22:16:41.692801Z","end":"2026-04-18T22:16:41.987229Z","steps":["trace[1098414199] 'range keys from in-memory index tree' (duration: 294.036392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:41.987285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.611211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-18T22:16:41.98738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.071154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-18T22:16:41.987415Z","caller":"traceutil/trace.go:171","msg":"trace[1336463603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1813; }","duration":"299.771915ms","start":"2026-04-18T22:16:41.687614Z","end":"2026-04-18T22:16:41.987386Z","steps":["trace[1336463603] 'range keys from in-memory index tree' (duration: 299.403947ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:41.987435Z","caller":"traceutil/trace.go:171","msg":"trace[1370533766] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1813; }","duration":"295.164036ms","start":"2026-04-18T22:16:41.692254Z","end":"2026-04-18T22:16:41.987418Z","steps":["trace[1370533766] 'range keys from in-memory index tree' (duration: 294.91812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:41.987092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.493576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-18T22:16:41.987712Z","caller":"traceutil/trace.go:171","msg":"trace[955987867] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1813; }","duration":"298.097349ms","start":"2026-04-18T22:16:41.689555Z","end":"2026-04-18T22:16:41.987652Z","steps":["trace[955987867] 'range keys from in-memory index tree' (duration: 297.284051ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:42.106155Z","caller":"traceutil/trace.go:171","msg":"trace[2077087408] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"113.015707ms","start":"2026-04-18T22:16:41.993113Z","end":"2026-04-18T22:16:42.106129Z","steps":["trace[2077087408] 'process raft request' (duration: 93.771356ms)","trace[2077087408] 'compare' (duration: 19.011897ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:42.106313Z","caller":"traceutil/trace.go:171","msg":"trace[1002433939] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"109.720728ms","start":"2026-04-18T22:16:41.996567Z","end":"2026-04-18T22:16:42.106288Z","steps":["trace[1002433939] 'process raft request' (duration: 109.505563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:08.330258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.759113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:18:08.330337Z","caller":"traceutil/trace.go:171","msg":"trace[1689336027] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:2386; }","duration":"119.913946ms","start":"2026-04-18T22:18:08.210407Z","end":"2026-04-18T22:18:08.330321Z","steps":["trace[1689336027] 'count revisions from in-memory index tree' (duration: 119.653301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:08.330354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.906886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"} {"level":"info","ts":"2026-04-18T22:18:08.330412Z","caller":"traceutil/trace.go:171","msg":"trace[897358800] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2386; }","duration":"120.006448ms","start":"2026-04-18T22:18:08.21039Z","end":"2026-04-18T22:18:08.330396Z","steps":["trace[897358800] 'range keys from in-memory index tree' (duration: 119.63925ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:38.906939Z","caller":"traceutil/trace.go:171","msg":"trace[613264916] transaction","detail":"{read_only:false; response_revision:2559; number_of_response:1; }","duration":"197.195694ms","start":"2026-04-18T22:18:38.709717Z","end":"2026-04-18T22:18:38.906912Z","steps":["trace[613264916] 'process raft request' (duration: 173.41362ms)","trace[613264916] 'compare' (duration: 23.645551ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:18:38.90693Z","caller":"traceutil/trace.go:171","msg":"trace[87298517] linearizableReadLoop","detail":"{readStateIndex:2655; appliedIndex:2654; }","duration":"107.782437ms","start":"2026-04-18T22:18:38.799116Z","end":"2026-04-18T22:18:38.906899Z","steps":["trace[87298517] 'read index received' (duration: 84.026563ms)","trace[87298517] 'applied index is now lower than readState.Index' (duration: 23.754594ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:18:38.907075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.961911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:18:38.907295Z","caller":"traceutil/trace.go:171","msg":"trace[774856373] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2559; }","duration":"108.201526ms","start":"2026-04-18T22:18:38.79908Z","end":"2026-04-18T22:18:38.907281Z","steps":["trace[774856373] 'agreement among raft nodes before linearized reading' (duration: 107.910449ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:21:19.639305Z","caller":"traceutil/trace.go:171","msg":"trace[875459103] linearizableReadLoop","detail":"{readStateIndex:3728; appliedIndex:3727; }","duration":"168.893344ms","start":"2026-04-18T22:21:19.470372Z","end":"2026-04-18T22:21:19.639265Z","steps":["trace[875459103] 'read index received' (duration: 123.680896ms)","trace[875459103] 'applied index is now lower than readState.Index' (duration: 45.210968ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:21:19.639366Z","caller":"traceutil/trace.go:171","msg":"trace[1589671390] transaction","detail":"{read_only:false; response_revision:3592; number_of_response:1; }","duration":"171.007938ms","start":"2026-04-18T22:21:19.468301Z","end":"2026-04-18T22:21:19.639309Z","steps":["trace[1589671390] 'process raft request' (duration: 125.710039ms)","trace[1589671390] 'compare' (duration: 45.084535ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:21:19.639516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.134668ms","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-18T22:21:19.639574Z","caller":"traceutil/trace.go:171","msg":"trace[2031669500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3592; }","duration":"169.233821ms","start":"2026-04-18T22:21:19.470326Z","end":"2026-04-18T22:21:19.63956Z","steps":["trace[2031669500] 'agreement among raft nodes before linearized reading' (duration: 169.064737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:21:19.639881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.772777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-18T22:21:19.639939Z","caller":"traceutil/trace.go:171","msg":"trace[1212918086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3592; }","duration":"165.879298ms","start":"2026-04-18T22:21:19.474046Z","end":"2026-04-18T22:21:19.639925Z","steps":["trace[1212918086] 'agreement among raft nodes before linearized reading' (duration: 165.444659ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:22:31.914708Z","caller":"traceutil/trace.go:171","msg":"trace[267041930] linearizableReadLoop","detail":"{readStateIndex:4718; appliedIndex:4717; }","duration":"140.950657ms","start":"2026-04-18T22:22:31.773731Z","end":"2026-04-18T22:22:31.914681Z","steps":["trace[267041930] 'read index received' (duration: 140.794114ms)","trace[267041930] 'applied index is now lower than readState.Index' (duration: 155.343µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:22:31.914896Z","caller":"traceutil/trace.go:171","msg":"trace[521199645] transaction","detail":"{read_only:false; response_revision:4545; number_of_response:1; }","duration":"144.141687ms","start":"2026-04-18T22:22:31.770632Z","end":"2026-04-18T22:22:31.914773Z","steps":["trace[521199645] 'process raft request' (duration: 143.875242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:22:31.914985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.225973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-04-18T22:22:31.91507Z","caller":"traceutil/trace.go:171","msg":"trace[1329210547] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4545; }","duration":"141.325675ms","start":"2026-04-18T22:22:31.773723Z","end":"2026-04-18T22:22:31.915049Z","steps":["trace[1329210547] 'agreement among raft nodes before linearized reading' (duration: 141.065109ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:22:31.957646Z","caller":"traceutil/trace.go:171","msg":"trace[81288822] transaction","detail":"{read_only:false; response_revision:4546; number_of_response:1; }","duration":"176.658852ms","start":"2026-04-18T22:22:31.780966Z","end":"2026-04-18T22:22:31.957625Z","steps":["trace[81288822] 'process raft request' (duration: 175.715582ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:22:31.957676Z","caller":"traceutil/trace.go:171","msg":"trace[352357008] transaction","detail":"{read_only:false; response_revision:4547; number_of_response:1; }","duration":"107.730466ms","start":"2026-04-18T22:22:31.84992Z","end":"2026-04-18T22:22:31.95765Z","steps":["trace[352357008] 'process raft request' (duration: 106.98002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:22:35.780539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.629082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cb129fda-e545-4db7-9d89-cea672215f94\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-04-18T22:22:35.780611Z","caller":"traceutil/trace.go:171","msg":"trace[2040171032] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cb129fda-e545-4db7-9d89-cea672215f94; range_end:; response_count:1; response_revision:4703; }","duration":"176.723714ms","start":"2026-04-18T22:22:35.603872Z","end":"2026-04-18T22:22:35.780596Z","steps":["trace[2040171032] 'range keys from in-memory index tree' (duration: 176.446388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:22:35.780829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.377443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-gs5hx.18a793adc533c15f\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-04-18T22:22:35.780928Z","caller":"traceutil/trace.go:171","msg":"trace[60828887] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-gs5hx.18a793adc533c15f; range_end:; response_count:1; response_revision:4703; }","duration":"174.507716ms","start":"2026-04-18T22:22:35.606396Z","end":"2026-04-18T22:22:35.780904Z","steps":["trace[60828887] 'range keys from in-memory index tree' (duration: 174.111318ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:22:47.096314Z","caller":"traceutil/trace.go:171","msg":"trace[1220822058] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"111.122158ms","start":"2026-04-18T22:22:46.985167Z","end":"2026-04-18T22:22:47.096289Z","steps":["trace[1220822058] 'process raft request' (duration: 110.976795ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:22:47.107639Z","caller":"traceutil/trace.go:171","msg":"trace[1264252275] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"122.173365ms","start":"2026-04-18T22:22:46.985435Z","end":"2026-04-18T22:22:47.107609Z","steps":["trace[1264252275] 'process raft request' (duration: 121.964691ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:22:47.893329Z","caller":"traceutil/trace.go:171","msg":"trace[1082326842] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"150.075953ms","start":"2026-04-18T22:22:47.743228Z","end":"2026-04-18T22:22:47.893304Z","steps":["trace[1082326842] 'process raft request' (duration: 149.534802ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:22:54.918014Z","caller":"traceutil/trace.go:171","msg":"trace[917011217] transaction","detail":"{read_only:false; response_revision:5102; number_of_response:1; }","duration":"132.363102ms","start":"2026-04-18T22:22:54.785622Z","end":"2026-04-18T22:22:54.917985Z","steps":["trace[917011217] 'process raft request' (duration: 132.172368ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:22:55.099362Z","caller":"traceutil/trace.go:171","msg":"trace[1744588245] transaction","detail":"{read_only:false; response_revision:5103; number_of_response:1; }","duration":"176.268407ms","start":"2026-04-18T22:22:54.923029Z","end":"2026-04-18T22:22:55.099298Z","steps":["trace[1744588245] 'process raft request' (duration: 142.547722ms)","trace[1744588245] 'compare' (duration: 33.52898ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:24:26.47701Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2804} {"level":"info","ts":"2026-04-18T22:24:26.541957Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2804,"took":"63.374899ms","hash":4250336418,"current-db-size-bytes":56410112,"current-db-size":"56 MB","current-db-size-in-use-bytes":32747520,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-18T22:24:26.542024Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4250336418,"revision":2804,"compact-revision":-1} {"level":"info","ts":"2026-04-18T22:28:41.721085Z","caller":"traceutil/trace.go:171","msg":"trace[1824264308] linearizableReadLoop","detail":"{readStateIndex:8106; appliedIndex:8105; }","duration":"197.639417ms","start":"2026-04-18T22:28:41.523421Z","end":"2026-04-18T22:28:41.72106Z","steps":["trace[1824264308] 'read index received' (duration: 197.446723ms)","trace[1824264308] 'applied index is now lower than readState.Index' (duration: 191.704µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:28:41.721213Z","caller":"traceutil/trace.go:171","msg":"trace[1784909573] transaction","detail":"{read_only:false; response_revision:7833; number_of_response:1; }","duration":"209.563512ms","start":"2026-04-18T22:28:41.511636Z","end":"2026-04-18T22:28:41.7212Z","steps":["trace[1784909573] 'process raft request' (duration: 209.282346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:28:41.721461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.255457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-04-18T22:28:41.721581Z","caller":"traceutil/trace.go:171","msg":"trace[609935089] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:7833; }","duration":"189.37923ms","start":"2026-04-18T22:28:41.532179Z","end":"2026-04-18T22:28:41.721558Z","steps":["trace[609935089] 'agreement among raft nodes before linearized reading' (duration: 189.151405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:28:41.721851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.423154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:28:41.721868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.487973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-18T22:28:41.721903Z","caller":"traceutil/trace.go:171","msg":"trace[1005653639] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7833; }","duration":"198.518916ms","start":"2026-04-18T22:28:41.52337Z","end":"2026-04-18T22:28:41.721889Z","steps":["trace[1005653639] 'agreement among raft nodes before linearized reading' (duration: 198.443264ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:28:41.721914Z","caller":"traceutil/trace.go:171","msg":"trace[1711487534] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7833; }","duration":"146.556704ms","start":"2026-04-18T22:28:41.575344Z","end":"2026-04-18T22:28:41.721901Z","steps":["trace[1711487534] 'agreement among raft nodes before linearized reading' (duration: 146.435941ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:28:41.829684Z","caller":"traceutil/trace.go:171","msg":"trace[1317032978] transaction","detail":"{read_only:false; response_revision:7834; number_of_response:1; }","duration":"103.959343ms","start":"2026-04-18T22:28:41.725702Z","end":"2026-04-18T22:28:41.829661Z","steps":["trace[1317032978] 'process raft request' (duration: 99.542178ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:28:41.833352Z","caller":"traceutil/trace.go:171","msg":"trace[913657834] transaction","detail":"{read_only:false; response_revision:7835; number_of_response:1; }","duration":"107.11645ms","start":"2026-04-18T22:28:41.726221Z","end":"2026-04-18T22:28:41.833337Z","steps":["trace[913657834] 'process raft request' (duration: 107.049449ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:29:23.092147Z","caller":"traceutil/trace.go:171","msg":"trace[1556129644] transaction","detail":"{read_only:false; response_revision:8109; number_of_response:1; }","duration":"125.234124ms","start":"2026-04-18T22:29:22.966882Z","end":"2026-04-18T22:29:23.092116Z","steps":["trace[1556129644] 'process raft request' (duration: 124.872936ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:29:26.49159Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5937} {"level":"info","ts":"2026-04-18T22:29:26.591966Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5937,"took":"97.987889ms","hash":1484295764,"current-db-size-bytes":56410112,"current-db-size":"56 MB","current-db-size-in-use-bytes":22433792,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-18T22:29:26.592045Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1484295764,"revision":5937,"compact-revision":2804} {"level":"info","ts":"2026-04-18T22:29:34.242926Z","caller":"traceutil/trace.go:171","msg":"trace[178018041] transaction","detail":"{read_only:false; response_revision:8210; number_of_response:1; }","duration":"104.425138ms","start":"2026-04-18T22:29:34.138474Z","end":"2026-04-18T22:29:34.242899Z","steps":["trace[178018041] 'process raft request' (duration: 89.392325ms)","trace[178018041] 'compare' (duration: 14.917791ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:29:35.013991Z","caller":"traceutil/trace.go:171","msg":"trace[1319732376] linearizableReadLoop","detail":"{readStateIndex:8505; appliedIndex:8503; }","duration":"108.180129ms","start":"2026-04-18T22:29:34.905791Z","end":"2026-04-18T22:29:35.013972Z","steps":["trace[1319732376] 'read index received' (duration: 97.295115ms)","trace[1319732376] 'applied index is now lower than readState.Index' (duration: 10.884104ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:29:35.014089Z","caller":"traceutil/trace.go:171","msg":"trace[214821105] transaction","detail":"{read_only:false; response_revision:8216; number_of_response:1; }","duration":"108.376303ms","start":"2026-04-18T22:29:34.905671Z","end":"2026-04-18T22:29:35.014047Z","steps":["trace[214821105] 'process raft request' (duration: 108.036036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:29:35.014252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.450894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-69x8d\" ","response":"range_response_count:1 size:4652"} {"level":"info","ts":"2026-04-18T22:29:35.014361Z","caller":"traceutil/trace.go:171","msg":"trace[60836976] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-69x8d; range_end:; response_count:1; response_revision:8216; }","duration":"108.579097ms","start":"2026-04-18T22:29:34.905732Z","end":"2026-04-18T22:29:35.014311Z","steps":["trace[60836976] 'agreement among raft nodes before linearized reading' (duration: 108.381523ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:29:36.525814Z","caller":"traceutil/trace.go:171","msg":"trace[2074107390] linearizableReadLoop","detail":"{readStateIndex:8513; appliedIndex:8512; }","duration":"274.225046ms","start":"2026-04-18T22:29:36.251564Z","end":"2026-04-18T22:29:36.525789Z","steps":["trace[2074107390] 'read index received' (duration: 274.059832ms)","trace[2074107390] 'applied index is now lower than readState.Index' (duration: 164.044µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:29:36.525932Z","caller":"traceutil/trace.go:171","msg":"trace[430461674] transaction","detail":"{read_only:false; response_revision:8224; number_of_response:1; }","duration":"274.590504ms","start":"2026-04-18T22:29:36.251301Z","end":"2026-04-18T22:29:36.525891Z","steps":["trace[430461674] 'process raft request' (duration: 274.332887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:29:36.525985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.40328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:29:36.526132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.586192ms","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-18T22:29:36.526166Z","caller":"traceutil/trace.go:171","msg":"trace[1950820422] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8224; }","duration":"195.647702ms","start":"2026-04-18T22:29:36.330508Z","end":"2026-04-18T22:29:36.526156Z","steps":["trace[1950820422] 'agreement among raft nodes before linearized reading' (duration: 195.52467ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:29:36.526157Z","caller":"traceutil/trace.go:171","msg":"trace[1220380566] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8224; }","duration":"274.601814ms","start":"2026-04-18T22:29:36.251514Z","end":"2026-04-18T22:29:36.526116Z","steps":["trace[1220380566] 'agreement among raft nodes before linearized reading' (duration: 274.41655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:29:36.526173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.925966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-18T22:29:36.526201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.433148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-18T22:29:36.526255Z","caller":"traceutil/trace.go:171","msg":"trace[386812341] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8224; }","duration":"201.045308ms","start":"2026-04-18T22:29:36.32519Z","end":"2026-04-18T22:29:36.526236Z","steps":["trace[386812341] 'agreement among raft nodes before linearized reading' (duration: 200.831173ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:29:36.526339Z","caller":"traceutil/trace.go:171","msg":"trace[1655857412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8224; }","duration":"251.545001ms","start":"2026-04-18T22:29:36.274722Z","end":"2026-04-18T22:29:36.526267Z","steps":["trace[1655857412] 'agreement among raft nodes before linearized reading' (duration: 251.295675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:29:36.526358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.360397ms","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-18T22:29:36.526471Z","caller":"traceutil/trace.go:171","msg":"trace[734295681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8224; }","duration":"168.534581ms","start":"2026-04-18T22:29:36.357915Z","end":"2026-04-18T22:29:36.52645Z","steps":["trace[734295681] 'agreement among raft nodes before linearized reading' (duration: 168.173264ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:31:29.543919Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000257f.wal"} {"level":"info","ts":"2026-04-18T22:32:18.109496Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9133559b3198d4ec","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-18T22:32:18.115796Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-18T22:32:18.116053Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-18T22:34:26.500579Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8156} {"level":"info","ts":"2026-04-18T22:34:26.580216Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8156,"took":"77.472675ms","hash":2025494867,"current-db-size-bytes":56410112,"current-db-size":"56 MB","current-db-size-in-use-bytes":24141824,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-18T22:34:26.580286Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2025494867,"revision":8156,"compact-revision":5937} {"level":"info","ts":"2026-04-18T22:39:26.508277Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10508} {"level":"info","ts":"2026-04-18T22:39:26.58461Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10508,"took":"74.62593ms","hash":3295709911,"current-db-size-bytes":56410112,"current-db-size":"56 MB","current-db-size-in-use-bytes":19644416,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-18T22:39:26.584679Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3295709911,"revision":10508,"compact-revision":8156}