{"level":"warn","ts":"2026-04-08T06:10:34.616128Z","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-08T06:10:34.616235Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.77:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.77:2380","--initial-cluster=instance=https://199.204.45.77:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.77:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.77:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-08T06:10:34.61632Z","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-08T06:10:34.616338Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-04-08T06:10:34.616362Z","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-08T06:10:34.617165Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"]} {"level":"info","ts":"2026-04-08T06:10:34.617272Z","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.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.77:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-08T06:10:34.62242Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.804392ms"} {"level":"info","ts":"2026-04-08T06:10:34.635276Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9133559b3198d4ec","cluster-id":"60f1aee33b0786f5"} {"level":"info","ts":"2026-04-08T06:10:34.635432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T06:10:34.6355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 0"} {"level":"info","ts":"2026-04-08T06:10:34.635528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9133559b3198d4ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T06:10:34.635573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 1"} {"level":"info","ts":"2026-04-08T06:10:34.635659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"warn","ts":"2026-04-08T06:10:34.641619Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T06:10:34.642929Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T06:10:34.644092Z","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-08T06:10:34.646054Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9133559b3198d4ec","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T06:10:34.646215Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9133559b3198d4ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T06:10:34.646212Z","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-08T06:10:34.646274Z","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-08T06:10:34.646284Z","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-08T06:10:34.648391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"info","ts":"2026-04-08T06:10:34.649016Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","added-peer-id":"9133559b3198d4ec","added-peer-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-04-08T06:10:34.650479Z","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-08T06:10:34.650639Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-04-08T06:10:34.650666Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-04-08T06:10:34.651469Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9133559b3198d4ec","initial-advertise-peer-urls":["https://199.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T06:10:34.651511Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T06:10:35.336628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T06:10:35.336808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T06:10:35.3369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgPreVoteResp from 9133559b3198d4ec at term 1"} {"level":"info","ts":"2026-04-08T06:10:35.336973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became candidate at term 2"} {"level":"info","ts":"2026-04-08T06:10:35.337041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgVoteResp from 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-04-08T06:10:35.337111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became leader at term 2"} {"level":"info","ts":"2026-04-08T06:10:35.337163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9133559b3198d4ec elected leader 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-04-08T06:10:35.338065Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9133559b3198d4ec","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.77:2379]}","request-path":"/0/members/9133559b3198d4ec/attributes","cluster-id":"60f1aee33b0786f5","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T06:10:35.33811Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:10:35.338376Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:10:35.338494Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:10:35.339162Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:10:35.339221Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:10:35.339245Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:10:35.34042Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.77:2379"} {"level":"info","ts":"2026-04-08T06:10:35.341513Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T06:10:35.375435Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T06:10:35.375479Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-04-08T06:10:37.984743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.835718ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:10:37.984861Z","caller":"traceutil/trace.go:171","msg":"trace[539358732] transaction","detail":"{read_only:false; response_revision:129; number_of_response:1; }","duration":"270.918505ms","start":"2026-04-08T06:10:37.713925Z","end":"2026-04-08T06:10:37.984844Z","steps":["trace[539358732] 'process raft request' (duration: 138.661294ms)","trace[539358732] 'compare' (duration: 130.699436ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:10:38.298333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.500252ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:10:38.298542Z","caller":"traceutil/trace.go:171","msg":"trace[1730682766] transaction","detail":"{read_only:false; response_revision:130; number_of_response:1; }","duration":"308.876467ms","start":"2026-04-08T06:10:37.989644Z","end":"2026-04-08T06:10:38.29852Z","steps":["trace[1730682766] 'process raft request' (duration: 179.106001ms)","trace[1730682766] 'compare' (duration: 129.300108ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:10:38.298643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:10:37.989629Z","time spent":"308.986719ms","remote":"127.0.0.1:37580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T06:11:09.013072Z","caller":"traceutil/trace.go:171","msg":"trace[280141565] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"105.122542ms","start":"2026-04-08T06:11:08.907933Z","end":"2026-04-08T06:11:09.013055Z","steps":["trace[280141565] 'process raft request' (duration: 105.083342ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:11:09.013159Z","caller":"traceutil/trace.go:171","msg":"trace[1976955453] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"109.710573ms","start":"2026-04-08T06:11:08.903402Z","end":"2026-04-08T06:11:09.013113Z","steps":["trace[1976955453] 'process raft request' (duration: 21.524126ms)","trace[1976955453] 'compare' (duration: 87.960615ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:11:11.181219Z","caller":"traceutil/trace.go:171","msg":"trace[1686426248] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"163.115183ms","start":"2026-04-08T06:11:11.018081Z","end":"2026-04-08T06:11:11.181196Z","steps":["trace[1686426248] 'read index received' (duration: 162.310324ms)","trace[1686426248] 'applied index is now lower than readState.Index' (duration: 803.959µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:11:11.181423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.327575ms","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-08T06:11:11.181465Z","caller":"traceutil/trace.go:171","msg":"trace[354382037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:614; }","duration":"163.391795ms","start":"2026-04-08T06:11:11.018061Z","end":"2026-04-08T06:11:11.181453Z","steps":["trace[354382037] 'agreement among raft nodes before linearized reading' (duration: 163.225824ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:11:11.181491Z","caller":"traceutil/trace.go:171","msg":"trace[1848274791] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"238.095569ms","start":"2026-04-08T06:11:10.943358Z","end":"2026-04-08T06:11:11.181453Z","steps":["trace[1848274791] 'process raft request' (duration: 237.338892ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:11:11.38575Z","caller":"traceutil/trace.go:171","msg":"trace[36372849] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"200.500853ms","start":"2026-04-08T06:11:11.185216Z","end":"2026-04-08T06:11:11.385717Z","steps":["trace[36372849] 'process raft request' (duration: 134.586868ms)","trace[36372849] 'compare' (duration: 65.788704ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:11:11.394673Z","caller":"traceutil/trace.go:171","msg":"trace[1446306213] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"160.674826ms","start":"2026-04-08T06:11:11.233981Z","end":"2026-04-08T06:11:11.394656Z","steps":["trace[1446306213] 'process raft request' (duration: 160.590605ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:11:12.070898Z","caller":"traceutil/trace.go:171","msg":"trace[1071763321] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"611.656379ms","start":"2026-04-08T06:11:11.459164Z","end":"2026-04-08T06:11:12.07082Z","steps":["trace[1071763321] 'process raft request' (duration: 611.091603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:12.071467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:11:11.459142Z","time spent":"611.83281ms","remote":"127.0.0.1:37386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T06:11:12.071765Z","caller":"traceutil/trace.go:171","msg":"trace[477275599] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"478.396896ms","start":"2026-04-08T06:11:11.593306Z","end":"2026-04-08T06:11:12.071703Z","steps":["trace[477275599] 'read index received' (duration: 477.077521ms)","trace[477275599] 'applied index is now lower than readState.Index' (duration: 1.144793ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:11:12.072136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.8082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T06:11:12.072174Z","caller":"traceutil/trace.go:171","msg":"trace[1148663299] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:617; }","duration":"478.8881ms","start":"2026-04-08T06:11:11.593266Z","end":"2026-04-08T06:11:12.072154Z","steps":["trace[1148663299] 'agreement among raft nodes before linearized reading' (duration: 478.670658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:12.072201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:11:11.593246Z","time spent":"478.948531ms","remote":"127.0.0.1:37478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-08T06:11:12.403724Z","caller":"traceutil/trace.go:171","msg":"trace[59929216] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"331.842544ms","start":"2026-04-08T06:11:12.071845Z","end":"2026-04-08T06:11:12.403688Z","steps":["trace[59929216] 'read index received' (duration: 315.426441ms)","trace[59929216] 'applied index is now lower than readState.Index' (duration: 16.411503ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:11:12.403841Z","caller":"traceutil/trace.go:171","msg":"trace[1652344089] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"326.286426ms","start":"2026-04-08T06:11:12.077541Z","end":"2026-04-08T06:11:12.403828Z","steps":["trace[1652344089] 'process raft request' (duration: 325.958002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:12.403935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.386987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T06:11:12.40398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:11:12.077519Z","time spent":"326.379276ms","remote":"127.0.0.1:37478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T06:11:12.404022Z","caller":"traceutil/trace.go:171","msg":"trace[1065429915] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"774.501318ms","start":"2026-04-08T06:11:11.6295Z","end":"2026-04-08T06:11:12.404002Z","steps":["trace[1065429915] 'agreement among raft nodes before linearized reading' (duration: 774.332446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:12.404025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.683725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T06:11:12.404068Z","caller":"traceutil/trace.go:171","msg":"trace[579439781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"116.781586ms","start":"2026-04-08T06:11:12.287276Z","end":"2026-04-08T06:11:12.404057Z","steps":["trace[579439781] 'agreement among raft nodes before linearized reading' (duration: 116.574614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:12.404071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:11:11.62949Z","time spent":"774.572068ms","remote":"127.0.0.1:37194","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-04-08T06:11:12.404219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.416671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T06:11:12.404283Z","caller":"traceutil/trace.go:171","msg":"trace[1139029788] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"503.513062ms","start":"2026-04-08T06:11:11.900752Z","end":"2026-04-08T06:11:12.404265Z","steps":["trace[1139029788] 'agreement among raft nodes before linearized reading' (duration: 502.965247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:12.404328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:11:11.900731Z","time spent":"503.590343ms","remote":"127.0.0.1:37478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-08T06:11:12.403764Z","caller":"traceutil/trace.go:171","msg":"trace[1715227428] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"590.793625ms","start":"2026-04-08T06:11:11.8129Z","end":"2026-04-08T06:11:12.403694Z","steps":["trace[1715227428] 'process raft request' (duration: 574.490423ms)","trace[1715227428] 'compare' (duration: 15.591975ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:11:12.404471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:11:11.812882Z","time spent":"591.549373ms","remote":"127.0.0.1:37284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:11:26.694563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.313854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T06:11:26.694687Z","caller":"traceutil/trace.go:171","msg":"trace[633420808] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:769; }","duration":"191.517485ms","start":"2026-04-08T06:11:26.503145Z","end":"2026-04-08T06:11:26.694662Z","steps":["trace[633420808] 'range keys from in-memory index tree' (duration: 191.121402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:26.694583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.959953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-hvzcq\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-04-08T06:11:26.694778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.735317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T06:11:26.694813Z","caller":"traceutil/trace.go:171","msg":"trace[73343354] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-hvzcq; range_end:; response_count:1; response_revision:769; }","duration":"161.223385ms","start":"2026-04-08T06:11:26.533563Z","end":"2026-04-08T06:11:26.694786Z","steps":["trace[73343354] 'range keys from in-memory index tree' (duration: 160.804351ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:11:26.694854Z","caller":"traceutil/trace.go:171","msg":"trace[3479097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:769; }","duration":"192.861668ms","start":"2026-04-08T06:11:26.501976Z","end":"2026-04-08T06:11:26.694838Z","steps":["trace[3479097] 'range keys from in-memory index tree' (duration: 192.535525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:26.694861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.635753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T06:11:26.69492Z","caller":"traceutil/trace.go:171","msg":"trace[584101255] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:769; }","duration":"198.738735ms","start":"2026-04-08T06:11:26.496162Z","end":"2026-04-08T06:11:26.694901Z","steps":["trace[584101255] 'range keys from in-memory index tree' (duration: 198.432752ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:11:59.918301Z","caller":"traceutil/trace.go:171","msg":"trace[675718975] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"205.753007ms","start":"2026-04-08T06:11:59.712495Z","end":"2026-04-08T06:11:59.918248Z","steps":["trace[675718975] 'process raft request' (duration: 183.389543ms)","trace[675718975] 'compare' (duration: 22.014699ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:41.761374Z","caller":"traceutil/trace.go:171","msg":"trace[203194853] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"127.216805ms","start":"2026-04-08T06:12:41.634129Z","end":"2026-04-08T06:12:41.761346Z","steps":["trace[203194853] 'process raft request' (duration: 127.006569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:41.968478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.426489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-04-08T06:12:41.968577Z","caller":"traceutil/trace.go:171","msg":"trace[985001911] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1830; }","duration":"148.567483ms","start":"2026-04-08T06:12:41.819979Z","end":"2026-04-08T06:12:41.968547Z","steps":["trace[985001911] 'range keys from in-memory index tree' (duration: 148.238084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:41.968587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.808658ms","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-08T06:12:41.968659Z","caller":"traceutil/trace.go:171","msg":"trace[1794035025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1830; }","duration":"114.125806ms","start":"2026-04-08T06:12:41.854514Z","end":"2026-04-08T06:12:41.96864Z","steps":["trace[1794035025] 'range keys from in-memory index tree' (duration: 113.664193ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.114218Z","caller":"traceutil/trace.go:171","msg":"trace[150270461] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"135.734877ms","start":"2026-04-08T06:12:41.978464Z","end":"2026-04-08T06:12:42.114199Z","steps":["trace[150270461] 'process raft request' (duration: 135.680935ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:42.114237Z","caller":"traceutil/trace.go:171","msg":"trace[235740179] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"137.228988ms","start":"2026-04-08T06:12:41.976986Z","end":"2026-04-08T06:12:42.114215Z","steps":["trace[235740179] 'process raft request' (duration: 122.700084ms)","trace[235740179] 'compare' (duration: 14.335809ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:42.314462Z","caller":"traceutil/trace.go:171","msg":"trace[585868034] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"213.722041ms","start":"2026-04-08T06:12:42.100277Z","end":"2026-04-08T06:12:42.313999Z","steps":["trace[585868034] 'process raft request' (duration: 119.401014ms)","trace[585868034] 'compare' (duration: 94.176673ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:50.237322Z","caller":"traceutil/trace.go:171","msg":"trace[1966426127] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"202.758539ms","start":"2026-04-08T06:12:50.034522Z","end":"2026-04-08T06:12:50.237281Z","steps":["trace[1966426127] 'process raft request' (duration: 202.497152ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:13:16.545835Z","caller":"traceutil/trace.go:171","msg":"trace[909204032] transaction","detail":"{read_only:false; response_revision:2078; number_of_response:1; }","duration":"118.54442ms","start":"2026-04-08T06:13:16.427252Z","end":"2026-04-08T06:13:16.545796Z","steps":["trace[909204032] 'process raft request' (duration: 95.952334ms)","trace[909204032] 'compare' (duration: 22.295459ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:14:53.779795Z","caller":"traceutil/trace.go:171","msg":"trace[1118041549] transaction","detail":"{read_only:false; response_revision:2704; number_of_response:1; }","duration":"222.029376ms","start":"2026-04-08T06:14:53.557731Z","end":"2026-04-08T06:14:53.779761Z","steps":["trace[1118041549] 'process raft request' (duration: 221.807163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:49.32271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.587113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T06:18:49.322841Z","caller":"traceutil/trace.go:171","msg":"trace[858868946] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4712; }","duration":"174.730267ms","start":"2026-04-08T06:18:49.148066Z","end":"2026-04-08T06:18:49.322796Z","steps":["trace[858868946] 'range keys from in-memory index tree' (duration: 174.238335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:49.322711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.60749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-502261b2-bb02-47e5-b5fe-6372fec295bd\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-08T06:18:49.32304Z","caller":"traceutil/trace.go:171","msg":"trace[1363861268] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-502261b2-bb02-47e5-b5fe-6372fec295bd; range_end:; response_count:1; response_revision:4712; }","duration":"242.97801ms","start":"2026-04-08T06:18:49.080038Z","end":"2026-04-08T06:18:49.323016Z","steps":["trace[1363861268] 'range keys from in-memory index tree' (duration: 242.263942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:49.323183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.673371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T06:18:49.323277Z","caller":"traceutil/trace.go:171","msg":"trace[577163368] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4712; }","duration":"181.864966ms","start":"2026-04-08T06:18:49.141391Z","end":"2026-04-08T06:18:49.323256Z","steps":["trace[577163368] 'range keys from in-memory index tree' (duration: 180.82191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:49.324053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.195745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T06:18:49.324123Z","caller":"traceutil/trace.go:171","msg":"trace[1587948872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4712; }","duration":"174.299147ms","start":"2026-04-08T06:18:49.149811Z","end":"2026-04-08T06:18:49.32411Z","steps":["trace[1587948872] 'range keys from in-memory index tree' (duration: 173.990949ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:49.324337Z","caller":"traceutil/trace.go:171","msg":"trace[496917923] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"143.994376ms","start":"2026-04-08T06:18:49.180328Z","end":"2026-04-08T06:18:49.324323Z","steps":["trace[496917923] 'process raft request' (duration: 94.053242ms)","trace[496917923] 'compare' (duration: 47.974984ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:19:02.357624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.205278ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:19:02.357726Z","caller":"traceutil/trace.go:171","msg":"trace[246930763] linearizableReadLoop","detail":"{readStateIndex:5077; appliedIndex:5076; }","duration":"159.40133ms","start":"2026-04-08T06:19:02.198307Z","end":"2026-04-08T06:19:02.357708Z","steps":["trace[246930763] 'read index received' (duration: 38.876254ms)","trace[246930763] 'applied index is now lower than readState.Index' (duration: 120.524166ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:19:02.358037Z","caller":"traceutil/trace.go:171","msg":"trace[1170666350] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"164.558774ms","start":"2026-04-08T06:19:02.193464Z","end":"2026-04-08T06:19:02.358023Z","steps":["trace[1170666350] 'process raft request' (duration: 43.874774ms)","trace[1170666350] 'compare' (duration: 120.091866ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:19:02.358283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.971204ms","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-08T06:19:02.358318Z","caller":"traceutil/trace.go:171","msg":"trace[498470559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4892; }","duration":"160.023085ms","start":"2026-04-08T06:19:02.198286Z","end":"2026-04-08T06:19:02.358309Z","steps":["trace[498470559] 'agreement among raft nodes before linearized reading' (duration: 159.904772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:02.358489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.802056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-04-08T06:19:02.358524Z","caller":"traceutil/trace.go:171","msg":"trace[68532273] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4892; }","duration":"142.875969ms","start":"2026-04-08T06:19:02.215639Z","end":"2026-04-08T06:19:02.358515Z","steps":["trace[68532273] 'agreement among raft nodes before linearized reading' (duration: 142.788846ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:02.577989Z","caller":"traceutil/trace.go:171","msg":"trace[1780751257] linearizableReadLoop","detail":"{readStateIndex:5079; appliedIndex:5077; }","duration":"169.499175ms","start":"2026-04-08T06:19:02.40846Z","end":"2026-04-08T06:19:02.57796Z","steps":["trace[1780751257] 'read index received' (duration: 146.078946ms)","trace[1780751257] 'applied index is now lower than readState.Index' (duration: 23.418579ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:19:02.578268Z","caller":"traceutil/trace.go:171","msg":"trace[1691237642] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"214.540159ms","start":"2026-04-08T06:19:02.363715Z","end":"2026-04-08T06:19:02.578255Z","steps":["trace[1691237642] 'process raft request' (duration: 213.996086ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:02.577804Z","caller":"traceutil/trace.go:171","msg":"trace[2142160843] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"214.523919ms","start":"2026-04-08T06:19:02.363246Z","end":"2026-04-08T06:19:02.57777Z","steps":["trace[2142160843] 'process raft request' (duration: 191.200672ms)","trace[2142160843] 'compare' (duration: 22.931647ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:19:02.579152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.826762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-08T06:19:02.579255Z","caller":"traceutil/trace.go:171","msg":"trace[1504692014] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4894; }","duration":"151.654042ms","start":"2026-04-08T06:19:02.427583Z","end":"2026-04-08T06:19:02.579237Z","steps":["trace[1504692014] 'agreement among raft nodes before linearized reading' (duration: 150.73817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:02.579373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.886319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:19:02.579432Z","caller":"traceutil/trace.go:171","msg":"trace[1442792937] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:4894; }","duration":"171.007152ms","start":"2026-04-08T06:19:02.408411Z","end":"2026-04-08T06:19:02.579418Z","steps":["trace[1442792937] 'agreement among raft nodes before linearized reading' (duration: 170.886769ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:20:35.392757Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2925} {"level":"info","ts":"2026-04-08T06:20:35.467147Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2925,"took":"72.763785ms","hash":647710444,"current-db-size-bytes":54026240,"current-db-size":"54 MB","current-db-size-in-use-bytes":30117888,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-08T06:20:35.467228Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":647710444,"revision":2925,"compact-revision":-1} {"level":"warn","ts":"2026-04-08T06:22:32.58404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.051406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4840"} {"level":"info","ts":"2026-04-08T06:22:32.584155Z","caller":"traceutil/trace.go:171","msg":"trace[1175406552] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6449; }","duration":"114.29705ms","start":"2026-04-08T06:22:32.469834Z","end":"2026-04-08T06:22:32.584131Z","steps":["trace[1175406552] 'range keys from in-memory index tree' (duration: 113.892733ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:25:35.408495Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5657} {"level":"info","ts":"2026-04-08T06:25:35.493421Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5657,"took":"82.928375ms","hash":3709019210,"current-db-size-bytes":54026240,"current-db-size":"54 MB","current-db-size-in-use-bytes":18272256,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-08T06:25:35.493482Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3709019210,"revision":5657,"compact-revision":2925}