{"level":"warn","ts":"2026-04-28T06:05:12.37385Z","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-28T06:05:12.373936Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242: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.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242: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-28T06:05:12.373992Z","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-28T06:05:12.374Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-04-28T06:05:12.374022Z","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-28T06:05:12.374621Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-04-28T06:05:12.374688Z","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.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242: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-28T06:05:12.378767Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.903966ms"} {"level":"info","ts":"2026-04-28T06:05:12.387077Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-04-28T06:05:12.387145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T06:05:12.387166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-04-28T06:05:12.387183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T06:05:12.387194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-04-28T06:05:12.387226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-04-28T06:05:12.394766Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T06:05:12.40423Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T06:05:12.405956Z","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-28T06:05:12.411558Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T06:05:12.411785Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T06:05:12.411883Z","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-28T06:05:12.41198Z","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-28T06:05:12.411994Z","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-28T06:05:12.412658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-04-28T06:05:12.412742Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-04-28T06:05:12.415169Z","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-28T06:05:12.4154Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T06:05:12.41546Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T06:05:12.415617Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-04-28T06:05:12.415707Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-04-28T06:05:12.488331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T06:05:12.488566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T06:05:12.488674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-04-28T06:05:12.488753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-04-28T06:05:12.488827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-04-28T06:05:12.488921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-04-28T06:05:12.489005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-04-28T06:05:12.490745Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T06:05:12.49159Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T06:05:12.491629Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T06:05:12.491583Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T06:05:12.492043Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T06:05:12.492086Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T06:05:12.492319Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T06:05:12.492557Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T06:05:12.492598Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T06:05:12.494223Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-28T06:05:12.495261Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"warn","ts":"2026-04-28T06:05:18.333893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.618279ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T06:05:18.334014Z","caller":"traceutil/trace.go:171","msg":"trace[1339385769] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:315; }","duration":"243.705941ms","start":"2026-04-28T06:05:18.090291Z","end":"2026-04-28T06:05:18.333997Z","steps":["trace[1339385769] 'read index received' (duration: 112.490743ms)","trace[1339385769] 'applied index is now lower than readState.Index' (duration: 131.213738ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:05:18.334038Z","caller":"traceutil/trace.go:171","msg":"trace[2078867760] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"251.145222ms","start":"2026-04-28T06:05:18.082861Z","end":"2026-04-28T06:05:18.334007Z","steps":["trace[2078867760] 'process raft request' (duration: 119.915984ms)","trace[2078867760] 'compare' (duration: 130.427026ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:05:18.33411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.811513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T06:05:18.33414Z","caller":"traceutil/trace.go:171","msg":"trace[6547137] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:0; response_revision:306; }","duration":"243.883174ms","start":"2026-04-28T06:05:18.090248Z","end":"2026-04-28T06:05:18.334131Z","steps":["trace[6547137] 'agreement among raft nodes before linearized reading' (duration: 243.806693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:05:18.780626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.89996ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T06:05:18.78079Z","caller":"traceutil/trace.go:171","msg":"trace[196371191] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:316; }","duration":"237.204205ms","start":"2026-04-28T06:05:18.543563Z","end":"2026-04-28T06:05:18.780767Z","steps":["trace[196371191] 'read index received' (duration: 229.290988ms)","trace[196371191] 'applied index is now lower than readState.Index' (duration: 7.912497ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:05:18.780871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.307418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-04-28T06:05:18.780897Z","caller":"traceutil/trace.go:171","msg":"trace[1778574864] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:308; }","duration":"237.366999ms","start":"2026-04-28T06:05:18.543522Z","end":"2026-04-28T06:05:18.780889Z","steps":["trace[1778574864] 'agreement among raft nodes before linearized reading' (duration: 237.293937ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:05:18.780892Z","caller":"traceutil/trace.go:171","msg":"trace[1815763528] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"441.247844ms","start":"2026-04-28T06:05:18.33961Z","end":"2026-04-28T06:05:18.780858Z","steps":["trace[1815763528] 'process raft request' (duration: 441.107772ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:05:18.780939Z","caller":"traceutil/trace.go:171","msg":"trace[1836774933] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"441.500839ms","start":"2026-04-28T06:05:18.339394Z","end":"2026-04-28T06:05:18.780895Z","steps":["trace[1836774933] 'process raft request' (duration: 171.693743ms)","trace[1836774933] 'compare' (duration: 268.792049ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:05:18.781072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:05:18.339604Z","time spent":"441.391458ms","remote":"127.0.0.1:48272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T06:05:18.781162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:05:18.339384Z","time spent":"441.681352ms","remote":"127.0.0.1:48324","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-28T06:05:18.804198Z","caller":"traceutil/trace.go:171","msg":"trace[499481055] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"259.791442ms","start":"2026-04-28T06:05:18.544391Z","end":"2026-04-28T06:05:18.804182Z","steps":["trace[499481055] 'process raft request' (duration: 259.503888ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:05:18.804306Z","caller":"traceutil/trace.go:171","msg":"trace[1929886794] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"259.076211ms","start":"2026-04-28T06:05:18.545225Z","end":"2026-04-28T06:05:18.804301Z","steps":["trace[1929886794] 'process raft request' (duration: 258.724926ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:05:18.804359Z","caller":"traceutil/trace.go:171","msg":"trace[870885603] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"258.624323ms","start":"2026-04-28T06:05:18.545731Z","end":"2026-04-28T06:05:18.804356Z","steps":["trace[870885603] 'process raft request' (duration: 258.229947ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:05:18.804406Z","caller":"traceutil/trace.go:171","msg":"trace[2123583051] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"258.596143ms","start":"2026-04-28T06:05:18.545807Z","end":"2026-04-28T06:05:18.804403Z","steps":["trace[2123583051] 'process raft request' (duration: 258.170466ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:05:41.419452Z","caller":"traceutil/trace.go:171","msg":"trace[1209265082] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"105.344824ms","start":"2026-04-28T06:05:41.314079Z","end":"2026-04-28T06:05:41.419424Z","steps":["trace[1209265082] 'process raft request' (duration: 100.762669ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:05:47.476265Z","caller":"traceutil/trace.go:171","msg":"trace[1602030287] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"201.110636ms","start":"2026-04-28T06:05:47.27513Z","end":"2026-04-28T06:05:47.476241Z","steps":["trace[1602030287] 'process raft request' (duration: 200.958455ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:05:47.684873Z","caller":"traceutil/trace.go:171","msg":"trace[854386639] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"146.22441ms","start":"2026-04-28T06:05:47.538614Z","end":"2026-04-28T06:05:47.684838Z","steps":["trace[854386639] 'process raft request' (duration: 145.590901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:05:48.156798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.519376ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T06:05:48.156973Z","caller":"traceutil/trace.go:171","msg":"trace[2129055590] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"374.489489ms","start":"2026-04-28T06:05:47.782466Z","end":"2026-04-28T06:05:48.156955Z","steps":["trace[2129055590] 'read index received' (duration: 241.73631ms)","trace[2129055590] 'applied index is now lower than readState.Index' (duration: 132.752079ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:05:48.157062Z","caller":"traceutil/trace.go:171","msg":"trace[1622731499] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"423.393394ms","start":"2026-04-28T06:05:47.733659Z","end":"2026-04-28T06:05:48.157052Z","steps":["trace[1622731499] 'process raft request' (duration: 423.248052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:05:48.157123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:05:47.733639Z","time spent":"423.456216ms","remote":"127.0.0.1:48302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T06:05:48.157133Z","caller":"traceutil/trace.go:171","msg":"trace[667563946] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"457.068596ms","start":"2026-04-28T06:05:47.700024Z","end":"2026-04-28T06:05:48.157092Z","steps":["trace[667563946] 'process raft request' (duration: 324.165815ms)","trace[667563946] 'compare' (duration: 132.352373ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:05:48.157215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:05:47.700003Z","time spent":"457.161356ms","remote":"127.0.0.1:48252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T06:05:48.157285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.065578ms","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-28T06:05:48.157341Z","caller":"traceutil/trace.go:171","msg":"trace[1133823543] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"131.168629ms","start":"2026-04-28T06:05:48.026158Z","end":"2026-04-28T06:05:48.157326Z","steps":["trace[1133823543] 'agreement among raft nodes before linearized reading' (duration: 130.996296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:05:48.157413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.281117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T06:05:48.157449Z","caller":"traceutil/trace.go:171","msg":"trace[337175198] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"121.331537ms","start":"2026-04-28T06:05:48.036106Z","end":"2026-04-28T06:05:48.157438Z","steps":["trace[337175198] 'agreement among raft nodes before linearized reading' (duration: 121.275306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:05:48.157415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.913914ms","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-28T06:05:48.157523Z","caller":"traceutil/trace.go:171","msg":"trace[2133168917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"375.073577ms","start":"2026-04-28T06:05:47.782421Z","end":"2026-04-28T06:05:48.157495Z","steps":["trace[2133168917] 'agreement among raft nodes before linearized reading' (duration: 374.776693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:05:48.157589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:05:47.782406Z","time spent":"375.168698ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T06:06:02.957096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.747727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-l9dtj\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-28T06:06:02.957192Z","caller":"traceutil/trace.go:171","msg":"trace[1661874192] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-l9dtj; range_end:; response_count:1; response_revision:770; }","duration":"242.891709ms","start":"2026-04-28T06:06:02.714275Z","end":"2026-04-28T06:06:02.957167Z","steps":["trace[1661874192] 'range keys from in-memory index tree' (duration: 242.517845ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:06:32.571513Z","caller":"traceutil/trace.go:171","msg":"trace[1983526043] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"177.885677ms","start":"2026-04-28T06:06:32.393609Z","end":"2026-04-28T06:06:32.571495Z","steps":["trace[1983526043] 'process raft request' (duration: 176.263679ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:07:16.035564Z","caller":"traceutil/trace.go:171","msg":"trace[973659869] linearizableReadLoop","detail":"{readStateIndex:1874; appliedIndex:1873; }","duration":"124.614426ms","start":"2026-04-28T06:07:15.910924Z","end":"2026-04-28T06:07:16.035538Z","steps":["trace[973659869] 'read index received' (duration: 118.964491ms)","trace[973659869] 'applied index is now lower than readState.Index' (duration: 5.648775ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:07:16.035729Z","caller":"traceutil/trace.go:171","msg":"trace[2026235970] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"134.917787ms","start":"2026-04-28T06:07:15.90078Z","end":"2026-04-28T06:07:16.035698Z","steps":["trace[2026235970] 'process raft request' (duration: 129.117291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:07:16.035875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.928129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4a85d546-cac0-423e-86a5-e1df7b2ca5d4\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-28T06:07:16.035926Z","caller":"traceutil/trace.go:171","msg":"trace[244407213] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4a85d546-cac0-423e-86a5-e1df7b2ca5d4; range_end:; response_count:1; response_revision:1818; }","duration":"125.03095ms","start":"2026-04-28T06:07:15.910883Z","end":"2026-04-28T06:07:16.035914Z","steps":["trace[244407213] 'agreement among raft nodes before linearized reading' (duration: 124.791498ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:08:47.805628Z","caller":"traceutil/trace.go:171","msg":"trace[97099743] linearizableReadLoop","detail":"{readStateIndex:2686; appliedIndex:2685; }","duration":"217.181854ms","start":"2026-04-28T06:08:47.588415Z","end":"2026-04-28T06:08:47.805597Z","steps":["trace[97099743] 'read index received' (duration: 184.362258ms)","trace[97099743] 'applied index is now lower than readState.Index' (duration: 32.817986ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:08:47.805812Z","caller":"traceutil/trace.go:171","msg":"trace[842733264] transaction","detail":"{read_only:false; response_revision:2592; number_of_response:1; }","duration":"233.687121ms","start":"2026-04-28T06:08:47.572085Z","end":"2026-04-28T06:08:47.805772Z","steps":["trace[842733264] 'process raft request' (duration: 200.750091ms)","trace[842733264] 'compare' (duration: 32.525396ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:08:47.805897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.456904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-04-28T06:08:47.805983Z","caller":"traceutil/trace.go:171","msg":"trace[1787740871] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2592; }","duration":"217.571238ms","start":"2026-04-28T06:08:47.588389Z","end":"2026-04-28T06:08:47.80596Z","steps":["trace[1787740871] 'agreement among raft nodes before linearized reading' (duration: 217.372351ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:09:15.489867Z","caller":"traceutil/trace.go:171","msg":"trace[2001607298] linearizableReadLoop","detail":"{readStateIndex:2890; appliedIndex:2889; }","duration":"127.429734ms","start":"2026-04-28T06:09:15.362413Z","end":"2026-04-28T06:09:15.489843Z","steps":["trace[2001607298] 'read index received' (duration: 127.185226ms)","trace[2001607298] 'applied index is now lower than readState.Index' (duration: 243.568µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:09:15.489902Z","caller":"traceutil/trace.go:171","msg":"trace[142978386] transaction","detail":"{read_only:false; response_revision:2785; number_of_response:1; }","duration":"191.89922ms","start":"2026-04-28T06:09:15.297982Z","end":"2026-04-28T06:09:15.489881Z","steps":["trace[142978386] 'process raft request' (duration: 191.697733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:09:15.490308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.877718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18aa705b4b67be94\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-04-28T06:09:15.490355Z","caller":"traceutil/trace.go:171","msg":"trace[1784416894] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18aa705b4b67be94; range_end:; response_count:1; response_revision:2785; }","duration":"127.973611ms","start":"2026-04-28T06:09:15.36237Z","end":"2026-04-28T06:09:15.490343Z","steps":["trace[1784416894] 'agreement among raft nodes before linearized reading' (duration: 127.63093ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:09:15.735269Z","caller":"traceutil/trace.go:171","msg":"trace[798598003] transaction","detail":"{read_only:false; response_revision:2788; number_of_response:1; }","duration":"116.765704ms","start":"2026-04-28T06:09:15.618477Z","end":"2026-04-28T06:09:15.735243Z","steps":["trace[798598003] 'process raft request' (duration: 116.549007ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:09:15.735286Z","caller":"traceutil/trace.go:171","msg":"trace[222623912] transaction","detail":"{read_only:false; response_revision:2786; number_of_response:1; }","duration":"242.636719ms","start":"2026-04-28T06:09:15.492627Z","end":"2026-04-28T06:09:15.735264Z","steps":["trace[222623912] 'process raft request' (duration: 227.516282ms)","trace[222623912] 'compare' (duration: 14.603812ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:09:15.735367Z","caller":"traceutil/trace.go:171","msg":"trace[1429575714] transaction","detail":"{read_only:false; response_revision:2787; number_of_response:1; }","duration":"241.6854ms","start":"2026-04-28T06:09:15.493653Z","end":"2026-04-28T06:09:15.735339Z","steps":["trace[1429575714] 'process raft request' (duration: 241.308398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:11:35.513236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.303378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-59d852fb-e633-432b-8a80-b187c1e04b16\" ","response":"range_response_count:1 size:4067"} {"level":"info","ts":"2026-04-28T06:11:35.51383Z","caller":"traceutil/trace.go:171","msg":"trace[1805669638] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-59d852fb-e633-432b-8a80-b187c1e04b16; range_end:; response_count:1; response_revision:4390; }","duration":"112.92774ms","start":"2026-04-28T06:11:35.400881Z","end":"2026-04-28T06:11:35.513809Z","steps":["trace[1805669638] 'range keys from in-memory index tree' (duration: 112.123795ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:11:35.655119Z","caller":"traceutil/trace.go:171","msg":"trace[774312401] transaction","detail":"{read_only:false; response_revision:4391; number_of_response:1; }","duration":"113.414469ms","start":"2026-04-28T06:11:35.54168Z","end":"2026-04-28T06:11:35.655095Z","steps":["trace[774312401] 'process raft request' (duration: 113.001791ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:11:38.403747Z","caller":"traceutil/trace.go:171","msg":"trace[1738511532] transaction","detail":"{read_only:false; response_revision:4499; number_of_response:1; }","duration":"126.203815ms","start":"2026-04-28T06:11:38.277514Z","end":"2026-04-28T06:11:38.403718Z","steps":["trace[1738511532] 'process raft request' (duration: 121.856997ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:11:38.421394Z","caller":"traceutil/trace.go:171","msg":"trace[899447524] transaction","detail":"{read_only:false; response_revision:4500; number_of_response:1; }","duration":"116.118721ms","start":"2026-04-28T06:11:38.305232Z","end":"2026-04-28T06:11:38.421351Z","steps":["trace[899447524] 'process raft request' (duration: 115.930148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:11:50.642226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.599091ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T06:11:50.642517Z","caller":"traceutil/trace.go:171","msg":"trace[159706483] transaction","detail":"{read_only:false; response_revision:4695; number_of_response:1; }","duration":"384.763568ms","start":"2026-04-28T06:11:50.257693Z","end":"2026-04-28T06:11:50.642456Z","steps":["trace[159706483] 'process raft request' (duration: 32.77728ms)","trace[159706483] 'compare' (duration: 351.467029ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:11:50.642544Z","caller":"traceutil/trace.go:171","msg":"trace[1630853596] linearizableReadLoop","detail":"{readStateIndex:4895; appliedIndex:4893; }","duration":"252.106458ms","start":"2026-04-28T06:11:50.390384Z","end":"2026-04-28T06:11:50.64249Z","steps":["trace[1630853596] 'read index received' (duration: 241.688853ms)","trace[1630853596] 'applied index is now lower than readState.Index' (duration: 10.416005ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:11:50.642638Z","caller":"traceutil/trace.go:171","msg":"trace[516943116] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"293.566193ms","start":"2026-04-28T06:11:50.349046Z","end":"2026-04-28T06:11:50.642613Z","steps":["trace[516943116] 'process raft request' (duration: 293.307178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:11:50.642898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.514734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10516"} {"level":"warn","ts":"2026-04-28T06:11:50.642953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.935214ms","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-04-28T06:11:50.642993Z","caller":"traceutil/trace.go:171","msg":"trace[2089899257] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4696; }","duration":"251.982075ms","start":"2026-04-28T06:11:50.391002Z","end":"2026-04-28T06:11:50.642984Z","steps":["trace[2089899257] 'agreement among raft nodes before linearized reading' (duration: 251.848223ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:11:50.642955Z","caller":"traceutil/trace.go:171","msg":"trace[174958247] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4696; }","duration":"252.607436ms","start":"2026-04-28T06:11:50.390334Z","end":"2026-04-28T06:11:50.642941Z","steps":["trace[174958247] 'agreement among raft nodes before linearized reading' (duration: 252.397703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T06:11:50.643688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T06:11:50.257676Z","time spent":"384.940401ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T06:11:50.989997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.033644ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-28T06:11:51.518668Z","caller":"traceutil/trace.go:171","msg":"trace[1872594805] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"104.940375ms","start":"2026-04-28T06:11:51.413704Z","end":"2026-04-28T06:11:51.518644Z","steps":["trace[1872594805] 'process raft request' (duration: 104.785842ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:11:51.557433Z","caller":"traceutil/trace.go:171","msg":"trace[1291301122] linearizableReadLoop","detail":"{readStateIndex:4908; appliedIndex:4906; }","duration":"124.947589ms","start":"2026-04-28T06:11:51.432462Z","end":"2026-04-28T06:11:51.557409Z","steps":["trace[1291301122] 'read index received' (duration: 86.046851ms)","trace[1291301122] 'applied index is now lower than readState.Index' (duration: 38.899758ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T06:11:51.557595Z","caller":"traceutil/trace.go:171","msg":"trace[96694280] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"143.194251ms","start":"2026-04-28T06:11:51.414371Z","end":"2026-04-28T06:11:51.557565Z","steps":["trace[96694280] 'process raft request' (duration: 130.490426ms)","trace[96694280] 'compare' (duration: 12.428201ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T06:11:51.557651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.165703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T06:11:51.557782Z","caller":"traceutil/trace.go:171","msg":"trace[1635701844] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:4708; }","duration":"125.347296ms","start":"2026-04-28T06:11:51.432416Z","end":"2026-04-28T06:11:51.557763Z","steps":["trace[1635701844] 'agreement among raft nodes before linearized reading' (duration: 125.158603ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T06:15:12.897266Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3268} {"level":"info","ts":"2026-04-28T06:15:13.004248Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3268,"took":"105.689675ms","hash":63241202,"current-db-size-bytes":59564032,"current-db-size":"60 MB","current-db-size-in-use-bytes":32505856,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-28T06:15:13.004328Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":63241202,"revision":3268,"compact-revision":-1}