{"level":"warn","ts":"2026-10-09T05:14:42.387338Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-09T05:14:42.387436Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78: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.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-10-09T05:14:42.387508Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-09T05:14:42.387519Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-10-09T05:14:42.387546Z","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-10-09T05:14:42.388531Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-10-09T05:14:42.388626Z","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.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-10-09T05:14:42.394653Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.431863ms"} {"level":"info","ts":"2026-10-09T05:14:42.405015Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-10-09T05:14:42.405131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-10-09T05:14:42.405185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-10-09T05:14:42.405204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-09T05:14:42.405216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-10-09T05:14:42.405275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-10-09T05:14:42.413955Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-09T05:14:42.415653Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-09T05:14:42.416911Z","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-10-09T05:14:42.42236Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-09T05:14:42.424573Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-09T05:14:42.427763Z","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-10-09T05:14:42.42782Z","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-10-09T05:14:42.427831Z","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-10-09T05:14:42.430084Z","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-10-09T05:14:42.430237Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-10-09T05:14:42.430377Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-10-09T05:14:42.43031Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-09T05:14:42.430348Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-09T05:14:42.430709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-10-09T05:14:42.430934Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-10-09T05:14:43.206753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-10-09T05:14:43.206814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-09T05:14:43.206847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-10-09T05:14:43.206864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-10-09T05:14:43.20687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-10-09T05:14:43.206879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-10-09T05:14:43.206888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-10-09T05:14:43.208111Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T05:14:43.209066Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-10-09T05:14:43.209093Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T05:14:43.209181Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T05:14:43.20965Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T05:14:43.209735Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T05:14:43.209761Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T05:14:43.209847Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-09T05:14:43.209873Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-09T05:14:43.211829Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-09T05:14:43.211993Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"warn","ts":"2026-10-09T05:14:46.85072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.103552ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-09T05:14:46.850816Z","caller":"traceutil/trace.go:171","msg":"trace[445102010] linearizableReadLoop","detail":"{readStateIndex:205; appliedIndex:204; }","duration":"264.959327ms","start":"2026-10-09T05:14:46.585846Z","end":"2026-10-09T05:14:46.850805Z","steps":["trace[445102010] 'read index received' (duration: 121.330128ms)","trace[445102010] 'applied index is now lower than readState.Index' (duration: 143.628509ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T05:14:46.850888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.03499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T05:14:46.850905Z","caller":"traceutil/trace.go:171","msg":"trace[1508361851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:200; }","duration":"265.085082ms","start":"2026-10-09T05:14:46.585814Z","end":"2026-10-09T05:14:46.850899Z","steps":["trace[1508361851] 'agreement among raft nodes before linearized reading' (duration: 265.02929ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:14:46.851301Z","caller":"traceutil/trace.go:171","msg":"trace[716745872] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"279.439322ms","start":"2026-10-09T05:14:46.571801Z","end":"2026-10-09T05:14:46.851241Z","steps":["trace[716745872] 'process raft request' (duration: 135.492021ms)","trace[716745872] 'compare' (duration: 143.007688ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T05:14:47.27891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.437396ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-09T05:14:47.27904Z","caller":"traceutil/trace.go:171","msg":"trace[309063560] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"422.617143ms","start":"2026-10-09T05:14:46.85641Z","end":"2026-10-09T05:14:47.279027Z","steps":["trace[309063560] 'process raft request' (duration: 422.578811ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:14:47.279082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T05:14:46.856393Z","time spent":"422.670945ms","remote":"127.0.0.1:57452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1342,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-09T05:14:47.279183Z","caller":"traceutil/trace.go:171","msg":"trace[1712535582] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"424.373674ms","start":"2026-10-09T05:14:46.85478Z","end":"2026-10-09T05:14:47.279153Z","steps":["trace[1712535582] 'process raft request' (duration: 128.633587ms)","trace[1712535582] 'compare' (duration: 295.319043ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T05:14:47.279311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T05:14:46.854756Z","time spent":"424.500539ms","remote":"127.0.0.1:57640","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-10-09T05:15:28.661672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.953117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-10-09T05:15:28.661761Z","caller":"traceutil/trace.go:171","msg":"trace[1197930726] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:574; }","duration":"247.096382ms","start":"2026-10-09T05:15:28.414645Z","end":"2026-10-09T05:15:28.661741Z","steps":["trace[1197930726] 'range keys from in-memory index tree' (duration: 246.77034ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:15:28.664544Z","caller":"traceutil/trace.go:171","msg":"trace[1100107653] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"238.81643ms","start":"2026-10-09T05:15:28.425712Z","end":"2026-10-09T05:15:28.664528Z","steps":["trace[1100107653] 'process raft request' (duration: 238.689226ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:15:28.670685Z","caller":"traceutil/trace.go:171","msg":"trace[2128674837] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"240.615062ms","start":"2026-10-09T05:15:28.430055Z","end":"2026-10-09T05:15:28.67067Z","steps":["trace[2128674837] 'process raft request' (duration: 240.460898ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:15:33.119375Z","caller":"traceutil/trace.go:171","msg":"trace[1690031361] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"159.98128ms","start":"2026-10-09T05:15:32.959346Z","end":"2026-10-09T05:15:33.119327Z","steps":["trace[1690031361] 'process raft request' (duration: 158.783099ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:15:33.546127Z","caller":"traceutil/trace.go:171","msg":"trace[697385006] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"365.587328ms","start":"2026-10-09T05:15:33.180513Z","end":"2026-10-09T05:15:33.5461Z","steps":["trace[697385006] 'read index received' (duration: 12.663695ms)","trace[697385006] 'applied index is now lower than readState.Index' (duration: 352.922583ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:15:33.546265Z","caller":"traceutil/trace.go:171","msg":"trace[1519215840] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"375.180606ms","start":"2026-10-09T05:15:33.171069Z","end":"2026-10-09T05:15:33.54625Z","steps":["trace[1519215840] 'process raft request' (duration: 288.959471ms)","trace[1519215840] 'compare' (duration: 85.921824ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T05:15:33.546361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.831497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T05:15:33.546432Z","caller":"traceutil/trace.go:171","msg":"trace[721590652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"365.92756ms","start":"2026-10-09T05:15:33.180485Z","end":"2026-10-09T05:15:33.546412Z","steps":["trace[721590652] 'agreement among raft nodes before linearized reading' (duration: 365.797935ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:15:33.546469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T05:15:33.18047Z","time spent":"365.988802ms","remote":"127.0.0.1:57324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-09T05:15:33.546593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T05:15:33.171023Z","time spent":"375.27513ms","remote":"127.0.0.1:57548","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-10-09T05:15:33.638687Z","caller":"traceutil/trace.go:171","msg":"trace[1041200090] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"433.754408ms","start":"2026-10-09T05:15:33.204912Z","end":"2026-10-09T05:15:33.638666Z","steps":["trace[1041200090] 'process raft request' (duration: 433.619133ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:15:33.63883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T05:15:33.204895Z","time spent":"433.886203ms","remote":"127.0.0.1:57716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T05:15:33.639415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.081228ms","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-10-09T05:15:33.639515Z","caller":"traceutil/trace.go:171","msg":"trace[1726244358] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:605; }","duration":"278.198473ms","start":"2026-10-09T05:15:33.361294Z","end":"2026-10-09T05:15:33.639492Z","steps":["trace[1726244358] 'agreement among raft nodes before linearized reading' (duration: 277.923984ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:15:49.319669Z","caller":"traceutil/trace.go:171","msg":"trace[1924557502] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:801; }","duration":"145.814807ms","start":"2026-10-09T05:15:49.173824Z","end":"2026-10-09T05:15:49.319639Z","steps":["trace[1924557502] 'read index received' (duration: 145.516597ms)","trace[1924557502] 'applied index is now lower than readState.Index' (duration: 296.53µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:15:49.319786Z","caller":"traceutil/trace.go:171","msg":"trace[1614312565] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"160.835736ms","start":"2026-10-09T05:15:49.158904Z","end":"2026-10-09T05:15:49.31974Z","steps":["trace[1614312565] 'process raft request' (duration: 160.546446ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:15:49.319926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.072406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T05:15:49.320127Z","caller":"traceutil/trace.go:171","msg":"trace[911160109] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:770; }","duration":"146.311215ms","start":"2026-10-09T05:15:49.173793Z","end":"2026-10-09T05:15:49.320104Z","steps":["trace[911160109] 'agreement among raft nodes before linearized reading' (duration: 146.016324ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:17:10.242006Z","caller":"traceutil/trace.go:171","msg":"trace[1318098355] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"231.49839ms","start":"2026-10-09T05:17:10.010462Z","end":"2026-10-09T05:17:10.24196Z","steps":["trace[1318098355] 'process raft request' (duration: 231.270752ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:17:44.610442Z","caller":"traceutil/trace.go:171","msg":"trace[1099150622] linearizableReadLoop","detail":"{readStateIndex:2183; appliedIndex:2182; }","duration":"140.958454ms","start":"2026-10-09T05:17:44.469464Z","end":"2026-10-09T05:17:44.610423Z","steps":["trace[1099150622] 'read index received' (duration: 90.999852ms)","trace[1099150622] 'applied index is now lower than readState.Index' (duration: 49.957802ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:17:44.610541Z","caller":"traceutil/trace.go:171","msg":"trace[339406984] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"146.773443ms","start":"2026-10-09T05:17:44.463727Z","end":"2026-10-09T05:17:44.610501Z","steps":["trace[339406984] 'process raft request' (duration: 96.82245ms)","trace[339406984] 'compare' (duration: 49.758379ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T05:17:44.610718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.225282ms","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-10-09T05:17:44.611001Z","caller":"traceutil/trace.go:171","msg":"trace[2096476573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2099; }","duration":"141.422517ms","start":"2026-10-09T05:17:44.469442Z","end":"2026-10-09T05:17:44.610864Z","steps":["trace[2096476573] 'agreement among raft nodes before linearized reading' (duration: 141.090644ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:17:44.611267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.004275ms","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-10-09T05:17:44.611341Z","caller":"traceutil/trace.go:171","msg":"trace[643792895] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2099; }","duration":"136.723225ms","start":"2026-10-09T05:17:44.474596Z","end":"2026-10-09T05:17:44.611319Z","steps":["trace[643792895] 'agreement among raft nodes before linearized reading' (duration: 135.951169ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:17:45.035734Z","caller":"traceutil/trace.go:171","msg":"trace[584926844] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"102.644934ms","start":"2026-10-09T05:17:44.933037Z","end":"2026-10-09T05:17:45.035682Z","steps":["trace[584926844] 'process raft request' (duration: 102.442821ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:19:12.731781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.00972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-09T05:19:12.731986Z","caller":"traceutil/trace.go:171","msg":"trace[817876928] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2684; }","duration":"197.225524ms","start":"2026-10-09T05:19:12.534741Z","end":"2026-10-09T05:19:12.731967Z","steps":["trace[817876928] 'range keys from in-memory index tree' (duration: 196.812967ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:19:13.107824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.924679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9281"} {"level":"info","ts":"2026-10-09T05:19:13.107928Z","caller":"traceutil/trace.go:171","msg":"trace[16610541] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2685; }","duration":"275.052934ms","start":"2026-10-09T05:19:12.832851Z","end":"2026-10-09T05:19:13.107904Z","steps":["trace[16610541] 'range keys from in-memory index tree' (duration: 274.763873ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:23:34.94357Z","caller":"traceutil/trace.go:171","msg":"trace[1881130950] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"179.519766ms","start":"2026-10-09T05:23:34.764023Z","end":"2026-10-09T05:23:34.943542Z","steps":["trace[1881130950] 'process raft request' (duration: 179.166211ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:23:40.451086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-10-09T05:23:40.451195Z","caller":"traceutil/trace.go:171","msg":"trace[1889920260] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4851; }","duration":"136.368683ms","start":"2026-10-09T05:23:40.314805Z","end":"2026-10-09T05:23:40.451174Z","steps":["trace[1889920260] 'range keys from in-memory index tree' (duration: 136.082989ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:23:40.817567Z","caller":"traceutil/trace.go:171","msg":"trace[1629912249] transaction","detail":"{read_only:false; response_revision:4864; number_of_response:1; }","duration":"162.187203ms","start":"2026-10-09T05:23:40.655358Z","end":"2026-10-09T05:23:40.817545Z","steps":["trace[1629912249] 'process raft request' (duration: 162.099192ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:23:40.817581Z","caller":"traceutil/trace.go:171","msg":"trace[1262923183] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"162.767152ms","start":"2026-10-09T05:23:40.654781Z","end":"2026-10-09T05:23:40.817549Z","steps":["trace[1262923183] 'process raft request' (duration: 132.510144ms)","trace[1262923183] 'compare' (duration: 29.937753ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:23:40.865041Z","caller":"traceutil/trace.go:171","msg":"trace[1380069258] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"161.631595ms","start":"2026-10-09T05:23:40.703386Z","end":"2026-10-09T05:23:40.865018Z","steps":["trace[1380069258] 'process raft request' (duration: 161.480133ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:23:43.675785Z","caller":"traceutil/trace.go:171","msg":"trace[1754254522] linearizableReadLoop","detail":"{readStateIndex:5088; appliedIndex:5087; }","duration":"111.589716ms","start":"2026-10-09T05:23:43.564166Z","end":"2026-10-09T05:23:43.675756Z","steps":["trace[1754254522] 'read index received' (duration: 111.387723ms)","trace[1754254522] 'applied index is now lower than readState.Index' (duration: 200.633µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:23:43.675935Z","caller":"traceutil/trace.go:171","msg":"trace[2082066938] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"113.522475ms","start":"2026-10-09T05:23:43.562378Z","end":"2026-10-09T05:23:43.675901Z","steps":["trace[2082066938] 'process raft request' (duration: 113.19351ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:23:43.676042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.84457ms","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-10-09T05:23:43.676092Z","caller":"traceutil/trace.go:171","msg":"trace[544576089] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4899; }","duration":"111.914391ms","start":"2026-10-09T05:23:43.564162Z","end":"2026-10-09T05:23:43.676076Z","steps":["trace[544576089] 'agreement among raft nodes before linearized reading' (duration: 111.732408ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:23:53.573835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.283558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T05:23:53.573907Z","caller":"traceutil/trace.go:171","msg":"trace[1841906830] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5025; }","duration":"396.411681ms","start":"2026-10-09T05:23:53.177479Z","end":"2026-10-09T05:23:53.573891Z","steps":["trace[1841906830] 'range keys from in-memory index tree' (duration: 396.127916ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:23:53.57394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T05:23:53.177458Z","time spent":"396.472871ms","remote":"127.0.0.1:57324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-09T05:23:53.841161Z","caller":"traceutil/trace.go:171","msg":"trace[1525392871] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"123.617843ms","start":"2026-10-09T05:23:53.717516Z","end":"2026-10-09T05:23:53.841134Z","steps":["trace[1525392871] 'process raft request' (duration: 89.051247ms)","trace[1525392871] 'compare' (duration: 34.433444ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:23:53.866837Z","caller":"traceutil/trace.go:171","msg":"trace[760972338] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"147.424016ms","start":"2026-10-09T05:23:53.719387Z","end":"2026-10-09T05:23:53.866811Z","steps":["trace[760972338] 'process raft request' (duration: 147.208972ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:23:53.867175Z","caller":"traceutil/trace.go:171","msg":"trace[1628747160] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"147.616649ms","start":"2026-10-09T05:23:53.719543Z","end":"2026-10-09T05:23:53.86716Z","steps":["trace[1628747160] 'process raft request' (duration: 147.215602ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:23:53.867281Z","caller":"traceutil/trace.go:171","msg":"trace[1006878515] linearizableReadLoop","detail":"{readStateIndex:5225; appliedIndex:5221; }","duration":"132.845541ms","start":"2026-10-09T05:23:53.734412Z","end":"2026-10-09T05:23:53.867258Z","steps":["trace[1006878515] 'read index received' (duration: 72.168194ms)","trace[1006878515] 'applied index is now lower than readState.Index' (duration: 60.672967ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T05:23:53.867404Z","caller":"traceutil/trace.go:171","msg":"trace[1588309051] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"147.783712ms","start":"2026-10-09T05:23:53.719612Z","end":"2026-10-09T05:23:53.867396Z","steps":["trace[1588309051] 'process raft request' (duration: 147.427376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:23:53.86764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.224738ms","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":"warn","ts":"2026-10-09T05:23:53.867672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.878268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-09T05:23:53.867685Z","caller":"traceutil/trace.go:171","msg":"trace[1376810167] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5031; }","duration":"133.34359ms","start":"2026-10-09T05:23:53.73433Z","end":"2026-10-09T05:23:53.867674Z","steps":["trace[1376810167] 'agreement among raft nodes before linearized reading' (duration: 133.201328ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:23:53.867702Z","caller":"traceutil/trace.go:171","msg":"trace[1101019371] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5031; }","duration":"128.952269ms","start":"2026-10-09T05:23:53.73874Z","end":"2026-10-09T05:23:53.867692Z","steps":["trace[1101019371] 'agreement among raft nodes before linearized reading' (duration: 128.844117ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:24:29.003967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.65958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-09T05:24:29.004022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.741012ms","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-10-09T05:24:29.004098Z","caller":"traceutil/trace.go:171","msg":"trace[215861248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5353; }","duration":"117.823303ms","start":"2026-10-09T05:24:28.886244Z","end":"2026-10-09T05:24:29.004067Z","steps":["trace[215861248] 'range keys from in-memory index tree' (duration: 117.486178ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:24:29.004117Z","caller":"traceutil/trace.go:171","msg":"trace[2111323642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5353; }","duration":"117.854923ms","start":"2026-10-09T05:24:28.886238Z","end":"2026-10-09T05:24:29.004092Z","steps":["trace[2111323642] 'range keys from in-memory index tree' (duration: 117.584189ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:24:29.004408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.719047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/keystone-credential-keys\" ","response":"range_response_count:1 size:353"} {"level":"info","ts":"2026-10-09T05:24:29.004451Z","caller":"traceutil/trace.go:171","msg":"trace[2012116141] range","detail":"{range_begin:/registry/secrets/openstack/keystone-credential-keys; range_end:; response_count:1; response_revision:5353; }","duration":"123.789188ms","start":"2026-10-09T05:24:28.880651Z","end":"2026-10-09T05:24:29.00444Z","steps":["trace[2012116141] 'range keys from in-memory index tree' (duration: 123.587634ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:24:29.004481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.525246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-credential-setup-g4q5p\" ","response":"range_response_count:1 size:7802"} {"level":"info","ts":"2026-10-09T05:24:29.004521Z","caller":"traceutil/trace.go:171","msg":"trace[1161542950] range","detail":"{range_begin:/registry/pods/openstack/keystone-credential-setup-g4q5p; range_end:; response_count:1; response_revision:5353; }","duration":"102.594318ms","start":"2026-10-09T05:24:28.901917Z","end":"2026-10-09T05:24:29.004511Z","steps":["trace[1161542950] 'range keys from in-memory index tree' (duration: 102.419494ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:24:29.004592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.003603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-09T05:24:29.004662Z","caller":"traceutil/trace.go:171","msg":"trace[1853135168] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5353; }","duration":"200.102494ms","start":"2026-10-09T05:24:28.804543Z","end":"2026-10-09T05:24:29.004645Z","steps":["trace[1853135168] 'range keys from in-memory index tree' (duration: 199.873581ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T05:24:29.004707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.668874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-09T05:24:29.004873Z","caller":"traceutil/trace.go:171","msg":"trace[1002353530] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5353; }","duration":"136.934828ms","start":"2026-10-09T05:24:28.867883Z","end":"2026-10-09T05:24:29.004818Z","steps":["trace[1002353530] 'range keys from in-memory index tree' (duration: 136.364108ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T05:24:43.239922Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2845} {"level":"info","ts":"2026-10-09T05:24:43.459977Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2845,"took":"218.484082ms","hash":2945330124,"current-db-size-bytes":53657600,"current-db-size":"54 MB","current-db-size-in-use-bytes":28545024,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-09T05:24:43.460046Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2945330124,"revision":2845,"compact-revision":-1} {"level":"info","ts":"2026-10-09T05:29:43.248556Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5458} {"level":"info","ts":"2026-10-09T05:29:43.341206Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5458,"took":"90.73645ms","hash":2236042954,"current-db-size-bytes":53657600,"current-db-size":"54 MB","current-db-size-in-use-bytes":18358272,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-10-09T05:29:43.341275Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2236042954,"revision":5458,"compact-revision":2845}