{"level":"warn","ts":"2026-05-07T00:42:26.877491Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T00:42:26.877563Z","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-05-07T00:42:26.877619Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T00:42:26.877631Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-05-07T00:42:26.877651Z","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-05-07T00:42:26.878222Z","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-05-07T00:42:26.878291Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-07T00:42:26.882838Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.355886ms"} {"level":"info","ts":"2026-05-07T00:42:26.891571Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-05-07T00:42:26.89166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-05-07T00:42:26.891679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-05-07T00:42:26.891693Z","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-05-07T00:42:26.891702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-05-07T00:42:26.891741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-05-07T00:42:26.905515Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-07T00:42:26.908532Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-07T00:42:26.909856Z","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-05-07T00:42:26.911949Z","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-05-07T00:42:26.912049Z","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-05-07T00:42:26.912073Z","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-05-07T00:42:26.912142Z","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-05-07T00:42:26.912154Z","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-05-07T00:42:26.913494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-05-07T00:42:26.914091Z","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-05-07T00:42:26.91544Z","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-05-07T00:42:26.915638Z","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-05-07T00:42:26.915627Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-05-07T00:42:26.915724Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-05-07T00:42:26.915685Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-07T00:42:27.292661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-05-07T00:42:27.292748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-07T00:42:27.292811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-05-07T00:42:27.292836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-05-07T00:42:27.292848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-05-07T00:42:27.292943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-05-07T00:42:27.292966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-05-07T00:42:27.294431Z","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-05-07T00:42:27.295452Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T00:42:27.298482Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T00:42:27.298504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T00:42:27.303227Z","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-05-07T00:42:27.303325Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T00:42:27.303359Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T00:42:27.298655Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-07T00:42:27.306092Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-07T00:42:27.307328Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-05-07T00:42:27.310001Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-07T00:42:28.879452Z","caller":"traceutil/trace.go:171","msg":"trace[1729475749] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:6; }","duration":"292.210578ms","start":"2026-05-07T00:42:28.58721Z","end":"2026-05-07T00:42:28.87942Z","steps":["trace[1729475749] 'read index received' (duration: 235.685577ms)","trace[1729475749] 'applied index is now lower than readState.Index' (duration: 56.523871ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:42:28.879538Z","caller":"traceutil/trace.go:171","msg":"trace[14118887] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"293.20471ms","start":"2026-05-07T00:42:28.5863Z","end":"2026-05-07T00:42:28.879505Z","steps":["trace[14118887] 'process raft request' (duration: 236.581177ms)","trace[14118887] 'compare' (duration: 56.391868ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:42:28.879739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.480394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T00:42:28.879804Z","caller":"traceutil/trace.go:171","msg":"trace[926756169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4; }","duration":"292.624937ms","start":"2026-05-07T00:42:28.587164Z","end":"2026-05-07T00:42:28.879789Z","steps":["trace[926756169] 'agreement among raft nodes before linearized reading' (duration: 292.409273ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:42:29.142623Z","caller":"traceutil/trace.go:171","msg":"trace[111666881] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"555.311429ms","start":"2026-05-07T00:42:28.587262Z","end":"2026-05-07T00:42:29.142573Z","steps":["trace[111666881] 'process raft request' (duration: 525.063249ms)","trace[111666881] 'compare' (duration: 29.899763ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:42:29.143232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.587243Z","time spent":"555.465032ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T00:42:29.143408Z","caller":"traceutil/trace.go:171","msg":"trace[493159982] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"555.82986ms","start":"2026-05-07T00:42:28.587566Z","end":"2026-05-07T00:42:29.143396Z","steps":["trace[493159982] 'process raft request' (duration: 555.051624ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:42:29.143371Z","caller":"traceutil/trace.go:171","msg":"trace[1053948444] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"555.85822ms","start":"2026-05-07T00:42:28.587428Z","end":"2026-05-07T00:42:29.143286Z","steps":["trace[1053948444] 'process raft request' (duration: 555.129636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:29.143469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.58755Z","time spent":"555.891761ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T00:42:29.143575Z","caller":"traceutil/trace.go:171","msg":"trace[1772015667] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"556.238398ms","start":"2026-05-07T00:42:28.587326Z","end":"2026-05-07T00:42:29.143564Z","steps":["trace[1772015667] 'process raft request' (duration: 555.098725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:29.143626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.587314Z","time spent":"556.289099ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T00:42:29.143626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.587421Z","time spent":"556.084925ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T00:42:29.143705Z","caller":"traceutil/trace.go:171","msg":"trace[1409851749] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"556.392921ms","start":"2026-05-07T00:42:28.587303Z","end":"2026-05-07T00:42:29.143696Z","steps":["trace[1409851749] 'process raft request' (duration: 555.200056ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:29.14376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.587279Z","time spent":"556.454283ms","remote":"127.0.0.1:57014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T00:42:29.143976Z","caller":"traceutil/trace.go:171","msg":"trace[311109971] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"549.307652ms","start":"2026-05-07T00:42:28.594628Z","end":"2026-05-07T00:42:29.143935Z","steps":["trace[311109971] 'process raft request' (duration: 548.018784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:29.144177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.594621Z","time spent":"549.426744ms","remote":"127.0.0.1:56736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T00:42:29.144453Z","caller":"traceutil/trace.go:171","msg":"trace[679176778] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"547.85763ms","start":"2026-05-07T00:42:28.59658Z","end":"2026-05-07T00:42:29.144437Z","steps":["trace[679176778] 'process raft request' (duration: 546.839148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:29.144565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.59657Z","time spent":"547.927291ms","remote":"127.0.0.1:56654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T00:42:29.144615Z","caller":"traceutil/trace.go:171","msg":"trace[1644253567] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:7; }","duration":"265.052201ms","start":"2026-05-07T00:42:28.879544Z","end":"2026-05-07T00:42:29.144596Z","steps":["trace[1644253567] 'read index received' (duration: 232.735658ms)","trace[1644253567] 'applied index is now lower than readState.Index' (duration: 32.314243ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:42:29.144845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.398473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-07T00:42:29.14488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.987212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-07T00:42:29.144992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.639323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-07T00:42:29.144979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.992244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T00:42:29.145083Z","caller":"traceutil/trace.go:171","msg":"trace[2094665414] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"557.115287ms","start":"2026-05-07T00:42:28.587951Z","end":"2026-05-07T00:42:29.145066Z","steps":["trace[2094665414] 'agreement among raft nodes before linearized reading' (duration: 556.989904ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:42:29.145031Z","caller":"traceutil/trace.go:171","msg":"trace[1665941715] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"507.142365ms","start":"2026-05-07T00:42:28.637871Z","end":"2026-05-07T00:42:29.145013Z","steps":["trace[1665941715] 'agreement among raft nodes before linearized reading' (duration: 506.790028ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:29.145155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.587943Z","time spent":"557.198418ms","remote":"127.0.0.1:56586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-05-07T00:42:29.145157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.637859Z","time spent":"507.286128ms","remote":"127.0.0.1:56612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-07T00:42:29.145028Z","caller":"traceutil/trace.go:171","msg":"trace[1380186037] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:11; }","duration":"377.694555ms","start":"2026-05-07T00:42:28.767322Z","end":"2026-05-07T00:42:29.145016Z","steps":["trace[1380186037] 'agreement among raft nodes before linearized reading' (duration: 377.647824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:29.145422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.767289Z","time spent":"378.088052ms","remote":"127.0.0.1:56738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-05-07T00:42:29.14494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.882921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T00:42:29.145614Z","caller":"traceutil/trace.go:171","msg":"trace[1283791088] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"525.576276ms","start":"2026-05-07T00:42:28.620024Z","end":"2026-05-07T00:42:29.1456Z","steps":["trace[1283791088] 'agreement among raft nodes before linearized reading' (duration: 524.894592ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:29.145658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.620011Z","time spent":"525.634277ms","remote":"127.0.0.1:56868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-05-07T00:42:29.144897Z","caller":"traceutil/trace.go:171","msg":"trace[631500625] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"557.464794ms","start":"2026-05-07T00:42:28.587414Z","end":"2026-05-07T00:42:29.144879Z","steps":["trace[631500625] 'agreement among raft nodes before linearized reading' (duration: 557.24439ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:42:29.145848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:42:28.58739Z","time spent":"558.447344ms","remote":"127.0.0.1:56612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-07T00:42:29.150212Z","caller":"traceutil/trace.go:171","msg":"trace[1633590360] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"262.520906ms","start":"2026-05-07T00:42:28.883385Z","end":"2026-05-07T00:42:29.145906Z","steps":["trace[1633590360] 'process raft request' (duration: 261.043436ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:01.846177Z","caller":"traceutil/trace.go:171","msg":"trace[1741223603] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"287.671059ms","start":"2026-05-07T00:43:01.558478Z","end":"2026-05-07T00:43:01.846149Z","steps":["trace[1741223603] 'process raft request' (duration: 286.747718ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:02.354828Z","caller":"traceutil/trace.go:171","msg":"trace[238438321] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"480.409955ms","start":"2026-05-07T00:43:01.874371Z","end":"2026-05-07T00:43:02.354781Z","steps":["trace[238438321] 'process raft request' (duration: 480.197493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:43:02.355221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:43:01.874328Z","time spent":"480.599768ms","remote":"127.0.0.1:56670","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-05-07T00:43:02.377153Z","caller":"traceutil/trace.go:171","msg":"trace[2117900646] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"500.455318ms","start":"2026-05-07T00:43:01.876679Z","end":"2026-05-07T00:43:02.377134Z","steps":["trace[2117900646] 'process raft request' (duration: 500.227035ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:02.37719Z","caller":"traceutil/trace.go:171","msg":"trace[1580118642] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:636; }","duration":"121.122834ms","start":"2026-05-07T00:43:02.256041Z","end":"2026-05-07T00:43:02.377164Z","steps":["trace[1580118642] 'read index received' (duration: 98.534781ms)","trace[1580118642] 'applied index is now lower than readState.Index' (duration: 22.584203ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:43:02.377251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:43:01.876655Z","time spent":"500.547388ms","remote":"127.0.0.1:56738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:43:02.377428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.367397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-07T00:43:02.377489Z","caller":"traceutil/trace.go:171","msg":"trace[1754807994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"121.506079ms","start":"2026-05-07T00:43:02.255968Z","end":"2026-05-07T00:43:02.377474Z","steps":["trace[1754807994] 'agreement among raft nodes before linearized reading' (duration: 121.286786ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:02.377649Z","caller":"traceutil/trace.go:171","msg":"trace[418836548] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"450.146381ms","start":"2026-05-07T00:43:01.927476Z","end":"2026-05-07T00:43:02.377623Z","steps":["trace[418836548] 'process raft request' (duration: 449.586445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:43:02.377774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:43:01.927456Z","time spent":"450.250243ms","remote":"127.0.0.1:56826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T00:43:02.377778Z","caller":"traceutil/trace.go:171","msg":"trace[1962737917] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"197.503516ms","start":"2026-05-07T00:43:02.180261Z","end":"2026-05-07T00:43:02.377765Z","steps":["trace[1962737917] 'process raft request' (duration: 196.849438ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:18.574037Z","caller":"traceutil/trace.go:171","msg":"trace[511846176] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"117.623241ms","start":"2026-05-07T00:43:18.456376Z","end":"2026-05-07T00:43:18.573999Z","steps":["trace[511846176] 'process raft request' (duration: 117.420089ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:18.655934Z","caller":"traceutil/trace.go:171","msg":"trace[1729560113] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"196.783838ms","start":"2026-05-07T00:43:18.45913Z","end":"2026-05-07T00:43:18.655914Z","steps":["trace[1729560113] 'process raft request' (duration: 196.670017ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:43:51.422156Z","caller":"traceutil/trace.go:171","msg":"trace[1923598651] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"171.556316ms","start":"2026-05-07T00:43:51.250565Z","end":"2026-05-07T00:43:51.422122Z","steps":["trace[1923598651] 'process raft request' (duration: 171.379823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:44:36.375789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.095834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-07T00:44:36.375901Z","caller":"traceutil/trace.go:171","msg":"trace[1640128906] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1869; }","duration":"223.268079ms","start":"2026-05-07T00:44:36.152612Z","end":"2026-05-07T00:44:36.37588Z","steps":["trace[1640128906] 'range keys from in-memory index tree' (duration: 222.893369ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:44:36.376107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.618399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-05-07T00:44:36.376169Z","caller":"traceutil/trace.go:171","msg":"trace[1389541120] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1869; }","duration":"275.728552ms","start":"2026-05-07T00:44:36.100421Z","end":"2026-05-07T00:44:36.37615Z","steps":["trace[1389541120] 'range keys from in-memory index tree' (duration: 275.504876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:44:36.376239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.845009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-07T00:44:36.376343Z","caller":"traceutil/trace.go:171","msg":"trace[1278425787] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1869; }","duration":"267.986683ms","start":"2026-05-07T00:44:36.10833Z","end":"2026-05-07T00:44:36.376317Z","steps":["trace[1278425787] 'range keys from in-memory index tree' (duration: 267.751746ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:44:36.632776Z","caller":"traceutil/trace.go:171","msg":"trace[1112352690] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"250.569743ms","start":"2026-05-07T00:44:36.382159Z","end":"2026-05-07T00:44:36.632728Z","steps":["trace[1112352690] 'process raft request' (duration: 230.950777ms)","trace[1112352690] 'compare' (duration: 18.944969ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:44:36.633064Z","caller":"traceutil/trace.go:171","msg":"trace[797126080] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"245.717198ms","start":"2026-05-07T00:44:36.386918Z","end":"2026-05-07T00:44:36.632635Z","steps":["trace[797126080] 'process raft request' (duration: 245.629116ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:44:36.829661Z","caller":"traceutil/trace.go:171","msg":"trace[358807328] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"187.855385ms","start":"2026-05-07T00:44:36.641768Z","end":"2026-05-07T00:44:36.829623Z","steps":["trace[358807328] 'process raft request' (duration: 182.351633ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:44:36.829927Z","caller":"traceutil/trace.go:171","msg":"trace[1006345251] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"186.959071ms","start":"2026-05-07T00:44:36.642936Z","end":"2026-05-07T00:44:36.829895Z","steps":["trace[1006345251] 'process raft request' (duration: 186.590782ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:44:36.831519Z","caller":"traceutil/trace.go:171","msg":"trace[1428545268] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"188.317277ms","start":"2026-05-07T00:44:36.643175Z","end":"2026-05-07T00:44:36.831493Z","steps":["trace[1428545268] 'process raft request' (duration: 186.632093ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:44:36.832182Z","caller":"traceutil/trace.go:171","msg":"trace[1215626847] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1946; }","duration":"159.767861ms","start":"2026-05-07T00:44:36.672353Z","end":"2026-05-07T00:44:36.832121Z","steps":["trace[1215626847] 'read index received' (duration: 151.814086ms)","trace[1215626847] 'applied index is now lower than readState.Index' (duration: 7.951695ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:44:36.833301Z","caller":"traceutil/trace.go:171","msg":"trace[659578031] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"189.473607ms","start":"2026-05-07T00:44:36.643805Z","end":"2026-05-07T00:44:36.833279Z","steps":["trace[659578031] 'process raft request' (duration: 187.308131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:44:36.833401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.113703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18ad21e01827b1d8\" ","response":"range_response_count:1 size:982"} {"level":"warn","ts":"2026-05-07T00:44:36.833942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.520717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-07T00:44:36.834142Z","caller":"traceutil/trace.go:171","msg":"trace[1215250142] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1877; }","duration":"161.786053ms","start":"2026-05-07T00:44:36.672302Z","end":"2026-05-07T00:44:36.834088Z","steps":["trace[1215250142] 'agreement among raft nodes before linearized reading' (duration: 160.276083ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:44:36.834375Z","caller":"traceutil/trace.go:171","msg":"trace[1664940805] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18ad21e01827b1d8; range_end:; response_count:1; response_revision:1877; }","duration":"100.291207ms","start":"2026-05-07T00:44:36.733204Z","end":"2026-05-07T00:44:36.833495Z","steps":["trace[1664940805] 'agreement among raft nodes before linearized reading' (duration: 99.820035ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:45:10.851335Z","caller":"traceutil/trace.go:171","msg":"trace[2098578797] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"127.791355ms","start":"2026-05-07T00:45:10.723514Z","end":"2026-05-07T00:45:10.851305Z","steps":["trace[2098578797] 'process raft request' (duration: 127.576351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:45:11.109819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.204382ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T00:45:11.110061Z","caller":"traceutil/trace.go:171","msg":"trace[1630887042] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"209.133111ms","start":"2026-05-07T00:45:10.900905Z","end":"2026-05-07T00:45:11.110038Z","steps":["trace[1630887042] 'process raft request' (duration: 209.053739ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:45:11.110287Z","caller":"traceutil/trace.go:171","msg":"trace[1312530684] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"253.638497ms","start":"2026-05-07T00:45:10.856604Z","end":"2026-05-07T00:45:11.110242Z","steps":["trace[1312530684] 'process raft request' (duration: 134.690281ms)","trace[1312530684] 'compare' (duration: 118.024308ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:45:11.392584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.047142ms","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-05-07T00:45:11.392707Z","caller":"traceutil/trace.go:171","msg":"trace[684197851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2116; }","duration":"150.287007ms","start":"2026-05-07T00:45:11.24239Z","end":"2026-05-07T00:45:11.392678Z","steps":["trace[684197851] 'range keys from in-memory index tree' (duration: 149.756887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:46:15.801147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.245196ms","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-05-07T00:46:15.801231Z","caller":"traceutil/trace.go:171","msg":"trace[1464655923] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2560; }","duration":"181.373977ms","start":"2026-05-07T00:46:15.619838Z","end":"2026-05-07T00:46:15.801212Z","steps":["trace[1464655923] 'range keys from in-memory index tree' (duration: 181.064512ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:46:15.80205Z","caller":"traceutil/trace.go:171","msg":"trace[228232346] transaction","detail":"{read_only:false; response_revision:2561; number_of_response:1; }","duration":"149.345493ms","start":"2026-05-07T00:46:15.65269Z","end":"2026-05-07T00:46:15.802035Z","steps":["trace[228232346] 'process raft request' (duration: 144.248812ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:46:53.51269Z","caller":"traceutil/trace.go:171","msg":"trace[1770323583] transaction","detail":"{read_only:false; response_revision:2765; number_of_response:1; }","duration":"104.828068ms","start":"2026-05-07T00:46:53.407812Z","end":"2026-05-07T00:46:53.51264Z","steps":["trace[1770323583] 'process raft request' (duration: 104.499864ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:47.386302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.318311ms","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-05-07T00:50:47.386405Z","caller":"traceutil/trace.go:171","msg":"trace[2102992526] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4764; }","duration":"117.474803ms","start":"2026-05-07T00:50:47.26891Z","end":"2026-05-07T00:50:47.386385Z","steps":["trace[2102992526] 'range keys from in-memory index tree' (duration: 117.122219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:47.387134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.921559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2350215"} {"level":"info","ts":"2026-05-07T00:50:47.387179Z","caller":"traceutil/trace.go:171","msg":"trace[601686226] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4764; }","duration":"126.96995ms","start":"2026-05-07T00:50:47.260198Z","end":"2026-05-07T00:50:47.387168Z","steps":["trace[601686226] 'range keys from in-memory index tree' (duration: 126.071149ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:47.387726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.10171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-07T00:50:47.387808Z","caller":"traceutil/trace.go:171","msg":"trace[489663770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4764; }","duration":"109.255672ms","start":"2026-05-07T00:50:47.278536Z","end":"2026-05-07T00:50:47.387792Z","steps":["trace[489663770] 'range keys from in-memory index tree' (duration: 108.871228ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:47.692097Z","caller":"traceutil/trace.go:171","msg":"trace[900509224] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"134.573473ms","start":"2026-05-07T00:50:47.55747Z","end":"2026-05-07T00:50:47.692044Z","steps":["trace[900509224] 'process raft request' (duration: 134.332979ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:47.692275Z","caller":"traceutil/trace.go:171","msg":"trace[151341217] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"131.708262ms","start":"2026-05-07T00:50:47.560524Z","end":"2026-05-07T00:50:47.692233Z","steps":["trace[151341217] 'process raft request' (duration: 131.52583ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:47.692255Z","caller":"traceutil/trace.go:171","msg":"trace[2119574453] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"134.485693ms","start":"2026-05-07T00:50:47.557723Z","end":"2026-05-07T00:50:47.692209Z","steps":["trace[2119574453] 'process raft request' (duration: 134.27564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:47.692326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.946237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-aa63944b-5249-4832-9e54-5b6b880d0976\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-07T00:50:47.692121Z","caller":"traceutil/trace.go:171","msg":"trace[211988645] linearizableReadLoop","detail":"{readStateIndex:4961; appliedIndex:4957; }","duration":"133.743874ms","start":"2026-05-07T00:50:47.558353Z","end":"2026-05-07T00:50:47.692097Z","steps":["trace[211988645] 'read index received' (duration: 41.103656ms)","trace[211988645] 'applied index is now lower than readState.Index' (duration: 92.638908ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:50:47.692378Z","caller":"traceutil/trace.go:171","msg":"trace[948241064] range","detail":"{range_begin:/registry/persistentvolumes/pvc-aa63944b-5249-4832-9e54-5b6b880d0976; range_end:; response_count:1; response_revision:4779; }","duration":"134.023807ms","start":"2026-05-07T00:50:47.558341Z","end":"2026-05-07T00:50:47.692365Z","steps":["trace[948241064] 'agreement among raft nodes before linearized reading' (duration: 133.835775ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:47.692433Z","caller":"traceutil/trace.go:171","msg":"trace[2135222189] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"134.848596ms","start":"2026-05-07T00:50:47.557533Z","end":"2026-05-07T00:50:47.692381Z","steps":["trace[2135222189] 'process raft request' (duration: 134.415282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:47.692623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.923524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-05-07T00:50:47.692674Z","caller":"traceutil/trace.go:171","msg":"trace[1918824753] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4779; }","duration":"132.029595ms","start":"2026-05-07T00:50:47.560627Z","end":"2026-05-07T00:50:47.692656Z","steps":["trace[1918824753] 'agreement among raft nodes before linearized reading' (duration: 131.832923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:59.213676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.17946ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T00:50:59.213825Z","caller":"traceutil/trace.go:171","msg":"trace[106318254] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"266.147461ms","start":"2026-05-07T00:50:58.947653Z","end":"2026-05-07T00:50:59.2138Z","steps":["trace[106318254] 'process raft request' (duration: 110.738248ms)","trace[106318254] 'compare' (duration: 154.981238ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:50:59.247914Z","caller":"traceutil/trace.go:171","msg":"trace[2079871365] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"103.760371ms","start":"2026-05-07T00:50:59.144122Z","end":"2026-05-07T00:50:59.247882Z","steps":["trace[2079871365] 'process raft request' (duration: 103.558169ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:52:27.338416Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2945} {"level":"info","ts":"2026-05-07T00:52:27.412365Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2945,"took":"71.927336ms","hash":646207313,"current-db-size-bytes":54591488,"current-db-size":"55 MB","current-db-size-in-use-bytes":29757440,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-07T00:52:27.412437Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":646207313,"revision":2945,"compact-revision":-1} {"level":"info","ts":"2026-05-07T00:57:27.344731Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5662} {"level":"info","ts":"2026-05-07T00:57:27.417781Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5662,"took":"71.46955ms","hash":2344597787,"current-db-size-bytes":54591488,"current-db-size":"55 MB","current-db-size-in-use-bytes":18354176,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-07T00:57:27.417872Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2344597787,"revision":5662,"compact-revision":2945}