{"level":"warn","ts":"2026-05-06T04:59:39.5661Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T04:59:39.566194Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.54: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.19.213.54:2380","--initial-cluster=instance=https://199.19.213.54:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.54:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.54:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-06T04:59:39.56626Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T04:59:39.566295Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.54:2380"]} {"level":"info","ts":"2026-05-06T04:59:39.566314Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-06T04:59:39.566944Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"]} {"level":"info","ts":"2026-05-06T04:59:39.567078Z","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.19.213.54:2380"],"listen-peer-urls":["https://199.19.213.54:2380"],"advertise-client-urls":["https://199.19.213.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.54:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-06T04:59:39.573965Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.613837ms"} {"level":"info","ts":"2026-05-06T04:59:39.580371Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"193b4dda7792855b","cluster-id":"dd6702a2f79ce697"} {"level":"info","ts":"2026-05-06T04:59:39.580444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T04:59:39.580469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became follower at term 0"} {"level":"info","ts":"2026-05-06T04:59:39.580486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 193b4dda7792855b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T04:59:39.580499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became follower at term 1"} {"level":"info","ts":"2026-05-06T04:59:39.580537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=(1818132475278427483)"} {"level":"warn","ts":"2026-05-06T04:59:39.588099Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T04:59:39.589697Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T04:59:39.590821Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-06T04:59:39.593806Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"193b4dda7792855b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T04:59:39.593934Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"193b4dda7792855b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T04:59:39.59413Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T04:59:39.594264Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T04:59:39.594311Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T04:59:39.595501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=(1818132475278427483)"} {"level":"info","ts":"2026-05-06T04:59:39.595894Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dd6702a2f79ce697","local-member-id":"193b4dda7792855b","added-peer-id":"193b4dda7792855b","added-peer-peer-urls":["https://199.19.213.54:2380"]} {"level":"info","ts":"2026-05-06T04:59:39.599409Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-06T04:59:39.599642Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.54:2380"} {"level":"info","ts":"2026-05-06T04:59:39.599726Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.54:2380"} {"level":"info","ts":"2026-05-06T04:59:39.600024Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"193b4dda7792855b","initial-advertise-peer-urls":["https://199.19.213.54:2380"],"listen-peer-urls":["https://199.19.213.54:2380"],"advertise-client-urls":["https://199.19.213.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T04:59:39.600091Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T04:59:40.480704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T04:59:40.48075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T04:59:40.480786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b received MsgPreVoteResp from 193b4dda7792855b at term 1"} {"level":"info","ts":"2026-05-06T04:59:40.480801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became candidate at term 2"} {"level":"info","ts":"2026-05-06T04:59:40.480807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b received MsgVoteResp from 193b4dda7792855b at term 2"} {"level":"info","ts":"2026-05-06T04:59:40.480816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became leader at term 2"} {"level":"info","ts":"2026-05-06T04:59:40.480827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 193b4dda7792855b elected leader 193b4dda7792855b at term 2"} {"level":"info","ts":"2026-05-06T04:59:40.482067Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:59:40.482203Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"193b4dda7792855b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.54:2379]}","request-path":"/0/members/193b4dda7792855b/attributes","cluster-id":"dd6702a2f79ce697","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T04:59:40.482268Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T04:59:40.482453Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T04:59:40.482551Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T04:59:40.482418Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T04:59:40.485833Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-06T04:59:40.487275Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.54:2379"} {"level":"info","ts":"2026-05-06T04:59:40.492441Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dd6702a2f79ce697","local-member-id":"193b4dda7792855b","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:59:40.495716Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:59:40.495755Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:59:41.874105Z","caller":"traceutil/trace.go:171","msg":"trace[1273695815] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"156.751358ms","start":"2026-05-06T04:59:41.717332Z","end":"2026-05-06T04:59:41.874083Z","steps":["trace[1273695815] 'process raft request' (duration: 156.518512ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:41.881773Z","caller":"traceutil/trace.go:171","msg":"trace[380640967] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"161.923539ms","start":"2026-05-06T04:59:41.719828Z","end":"2026-05-06T04:59:41.881751Z","steps":["trace[380640967] 'read index received' (duration: 154.233631ms)","trace[380640967] 'applied index is now lower than readState.Index' (duration: 7.689018ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T04:59:41.882098Z","caller":"traceutil/trace.go:171","msg":"trace[2095618754] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"161.316191ms","start":"2026-05-06T04:59:41.720762Z","end":"2026-05-06T04:59:41.882078Z","steps":["trace[2095618754] 'process raft request' (duration: 160.754226ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:41.882146Z","caller":"traceutil/trace.go:171","msg":"trace[1772425065] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"164.347574ms","start":"2026-05-06T04:59:41.717782Z","end":"2026-05-06T04:59:41.882129Z","steps":["trace[1772425065] 'process raft request' (duration: 163.636714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:59:41.882477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.625787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T04:59:41.882764Z","caller":"traceutil/trace.go:171","msg":"trace[1946037053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"162.934525ms","start":"2026-05-06T04:59:41.719815Z","end":"2026-05-06T04:59:41.882749Z","steps":["trace[1946037053] 'agreement among raft nodes before linearized reading' (duration: 162.559535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:59:41.882802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.814401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T04:59:41.882836Z","caller":"traceutil/trace.go:171","msg":"trace[227127993] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"116.856702ms","start":"2026-05-06T04:59:41.765971Z","end":"2026-05-06T04:59:41.882828Z","steps":["trace[227127993] 'agreement among raft nodes before linearized reading' (duration: 116.806811ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:59:41.882967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.198135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-06T04:59:41.883067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.516134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T04:59:41.8831Z","caller":"traceutil/trace.go:171","msg":"trace[558666507] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"152.561236ms","start":"2026-05-06T04:59:41.730532Z","end":"2026-05-06T04:59:41.883093Z","steps":["trace[558666507] 'agreement among raft nodes before linearized reading' (duration: 152.503944ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:41.88318Z","caller":"traceutil/trace.go:171","msg":"trace[1584747187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"162.391261ms","start":"2026-05-06T04:59:41.720696Z","end":"2026-05-06T04:59:41.883087Z","steps":["trace[1584747187] 'agreement among raft nodes before linearized reading' (duration: 162.121383ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:44.381591Z","caller":"traceutil/trace.go:171","msg":"trace[935889351] linearizableReadLoop","detail":"{readStateIndex:214; appliedIndex:213; }","duration":"421.81478ms","start":"2026-05-06T04:59:43.959751Z","end":"2026-05-06T04:59:44.381566Z","steps":["trace[935889351] 'read index received' (duration: 421.546544ms)","trace[935889351] 'applied index is now lower than readState.Index' (duration: 267.176µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T04:59:44.381664Z","caller":"traceutil/trace.go:171","msg":"trace[553707323] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"476.701929ms","start":"2026-05-06T04:59:43.904924Z","end":"2026-05-06T04:59:44.381626Z","steps":["trace[553707323] 'process raft request' (duration: 476.473913ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:59:44.381781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.002045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-06T04:59:44.381869Z","caller":"traceutil/trace.go:171","msg":"trace[1167499248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:209; }","duration":"422.142858ms","start":"2026-05-06T04:59:43.959707Z","end":"2026-05-06T04:59:44.38185Z","steps":["trace[1167499248] 'agreement among raft nodes before linearized reading' (duration: 421.965734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:59:44.381869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.662186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-06T04:59:44.381918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:59:43.95969Z","time spent":"422.21947ms","remote":"127.0.0.1:57460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-06T04:59:44.382032Z","caller":"traceutil/trace.go:171","msg":"trace[618719992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:209; }","duration":"421.81717ms","start":"2026-05-06T04:59:43.960139Z","end":"2026-05-06T04:59:44.381956Z","steps":["trace[618719992] 'agreement among raft nodes before linearized reading' (duration: 421.619295ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:59:44.381888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.377034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T04:59:44.382159Z","caller":"traceutil/trace.go:171","msg":"trace[201003106] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:209; }","duration":"233.693652ms","start":"2026-05-06T04:59:44.148451Z","end":"2026-05-06T04:59:44.382145Z","steps":["trace[201003106] 'agreement among raft nodes before linearized reading' (duration: 233.358394ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:59:44.382127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:59:43.96012Z","time spent":"421.992175ms","remote":"127.0.0.1:57460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-06T04:59:44.382445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:59:43.904901Z","time spent":"476.837802ms","remote":"127.0.0.1:57404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3694,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T04:59:44.823421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.776143ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T04:59:44.823528Z","caller":"traceutil/trace.go:171","msg":"trace[728357067] linearizableReadLoop","detail":"{readStateIndex:215; appliedIndex:214; }","duration":"437.289062ms","start":"2026-05-06T04:59:44.386221Z","end":"2026-05-06T04:59:44.82351Z","steps":["trace[728357067] 'read index received' (duration: 19.16136ms)","trace[728357067] 'applied index is now lower than readState.Index' (duration: 418.126392ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T04:59:44.82359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.379755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-mel18w\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T04:59:44.823754Z","caller":"traceutil/trace.go:171","msg":"trace[786273184] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-mel18w; range_end:; response_count:0; response_revision:210; }","duration":"437.570599ms","start":"2026-05-06T04:59:44.386171Z","end":"2026-05-06T04:59:44.823742Z","steps":["trace[786273184] 'agreement among raft nodes before linearized reading' (duration: 437.387134ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:59:44.823805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:59:44.386161Z","time spent":"437.631821ms","remote":"127.0.0.1:57324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-mel18w\" "} {"level":"info","ts":"2026-05-06T04:59:44.823582Z","caller":"traceutil/trace.go:171","msg":"trace[1450796578] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"437.707492ms","start":"2026-05-06T04:59:44.385843Z","end":"2026-05-06T04:59:44.82355Z","steps":["trace[1450796578] 'process raft request' (duration: 19.569169ms)","trace[1450796578] 'compare' (duration: 417.63938ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T04:59:44.824129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:59:44.385821Z","time spent":"438.224895ms","remote":"127.0.0.1:57460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T04:59:44.891736Z","caller":"traceutil/trace.go:171","msg":"trace[909928648] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"505.145041ms","start":"2026-05-06T04:59:44.386568Z","end":"2026-05-06T04:59:44.891713Z","steps":["trace[909928648] 'process raft request' (duration: 505.057799ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:59:44.891818Z","caller":"traceutil/trace.go:171","msg":"trace[1198997929] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"505.296334ms","start":"2026-05-06T04:59:44.386482Z","end":"2026-05-06T04:59:44.891779Z","steps":["trace[1198997929] 'process raft request' (duration: 505.019488ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:59:44.891972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:59:44.386536Z","time spent":"505.264304ms","remote":"127.0.0.1:57460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T04:59:44.892002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:59:44.38646Z","time spent":"505.450089ms","remote":"127.0.0.1:57460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:00:09.724294Z","caller":"traceutil/trace.go:171","msg":"trace[1852358838] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"161.241142ms","start":"2026-05-06T05:00:09.563025Z","end":"2026-05-06T05:00:09.724266Z","steps":["trace[1852358838] 'read index received' (duration: 154.398403ms)","trace[1852358838] 'applied index is now lower than readState.Index' (duration: 6.841649ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:00:09.724355Z","caller":"traceutil/trace.go:171","msg":"trace[240540951] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"175.728091ms","start":"2026-05-06T05:00:09.548595Z","end":"2026-05-06T05:00:09.724324Z","steps":["trace[240540951] 'process raft request' (duration: 168.889561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:00:09.724598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.543856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-05-06T05:00:09.724743Z","caller":"traceutil/trace.go:171","msg":"trace[1713954047] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:583; }","duration":"161.703469ms","start":"2026-05-06T05:00:09.563019Z","end":"2026-05-06T05:00:09.724723Z","steps":["trace[1713954047] 'agreement among raft nodes before linearized reading' (duration: 161.362733ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:10.023004Z","caller":"traceutil/trace.go:171","msg":"trace[309498797] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"132.154385ms","start":"2026-05-06T05:00:09.890831Z","end":"2026-05-06T05:00:10.022986Z","steps":["trace[309498797] 'read index received' (duration: 131.84183ms)","trace[309498797] 'applied index is now lower than readState.Index' (duration: 311.525µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:00:10.023286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.436469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-05-06T05:00:10.023327Z","caller":"traceutil/trace.go:171","msg":"trace[576018304] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:585; }","duration":"132.507961ms","start":"2026-05-06T05:00:09.890807Z","end":"2026-05-06T05:00:10.023315Z","steps":["trace[576018304] 'agreement among raft nodes before linearized reading' (duration: 132.254628ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:10.023787Z","caller":"traceutil/trace.go:171","msg":"trace[26634005] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"160.718208ms","start":"2026-05-06T05:00:09.863059Z","end":"2026-05-06T05:00:10.023777Z","steps":["trace[26634005] 'process raft request' (duration: 159.698753ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:11.92726Z","caller":"traceutil/trace.go:171","msg":"trace[492396927] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"311.558228ms","start":"2026-05-06T05:00:11.615674Z","end":"2026-05-06T05:00:11.927233Z","steps":["trace[492396927] 'process raft request' (duration: 311.166982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:00:11.927411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:00:11.615636Z","time spent":"311.70622ms","remote":"127.0.0.1:57324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036015,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:00:12.11688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.985936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:00:12.117079Z","caller":"traceutil/trace.go:171","msg":"trace[1374587963] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:593; }","duration":"129.26797ms","start":"2026-05-06T05:00:11.987787Z","end":"2026-05-06T05:00:12.117055Z","steps":["trace[1374587963] 'range keys from in-memory index tree' (duration: 128.900156ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:12.726902Z","caller":"traceutil/trace.go:171","msg":"trace[1295295638] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"121.37001ms","start":"2026-05-06T05:00:12.605501Z","end":"2026-05-06T05:00:12.726871Z","steps":["trace[1295295638] 'process raft request' (duration: 96.331377ms)","trace[1295295638] 'compare' (duration: 24.864001ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:00:15.930446Z","caller":"traceutil/trace.go:171","msg":"trace[974922184] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"140.723742ms","start":"2026-05-06T05:00:15.789704Z","end":"2026-05-06T05:00:15.930428Z","steps":["trace[974922184] 'process raft request' (duration: 136.466467ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:00:16.165875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.461288ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:00:16.16602Z","caller":"traceutil/trace.go:171","msg":"trace[252149438] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:622; }","duration":"107.619659ms","start":"2026-05-06T05:00:16.058383Z","end":"2026-05-06T05:00:16.166002Z","steps":["trace[252149438] 'range keys from in-memory index tree' (duration: 107.415647ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:16.194176Z","caller":"traceutil/trace.go:171","msg":"trace[732692215] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"402.246525ms","start":"2026-05-06T05:00:15.791872Z","end":"2026-05-06T05:00:16.194118Z","steps":["trace[732692215] 'process raft request' (duration: 402.021832ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:16.194308Z","caller":"traceutil/trace.go:171","msg":"trace[583289570] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"402.230845ms","start":"2026-05-06T05:00:15.792059Z","end":"2026-05-06T05:00:16.19429Z","steps":["trace[583289570] 'process raft request' (duration: 401.961442ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:16.194325Z","caller":"traceutil/trace.go:171","msg":"trace[312972389] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"401.8811ms","start":"2026-05-06T05:00:15.792425Z","end":"2026-05-06T05:00:16.194306Z","steps":["trace[312972389] 'process raft request' (duration: 401.633867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:00:16.194414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:00:15.79185Z","time spent":"402.426777ms","remote":"127.0.0.1:57432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:00:16.194446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:00:15.792416Z","time spent":"401.962361ms","remote":"127.0.0.1:57406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T05:00:16.19442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:00:15.792049Z","time spent":"402.310066ms","remote":"127.0.0.1:57314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T05:00:16.194955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.569411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rv9fq\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-06T05:00:16.195015Z","caller":"traceutil/trace.go:171","msg":"trace[1154373654] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rv9fq; range_end:; response_count:1; response_revision:625; }","duration":"287.683903ms","start":"2026-05-06T05:00:15.907317Z","end":"2026-05-06T05:00:16.195001Z","steps":["trace[1154373654] 'agreement among raft nodes before linearized reading' (duration: 287.50219ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:16.19477Z","caller":"traceutil/trace.go:171","msg":"trace[578794467] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:644; }","duration":"287.386279ms","start":"2026-05-06T05:00:15.907367Z","end":"2026-05-06T05:00:16.194753Z","steps":["trace[578794467] 'read index received' (duration: 18.884205ms)","trace[578794467] 'applied index is now lower than readState.Index' (duration: 268.500074ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:00:16.72816Z","caller":"traceutil/trace.go:171","msg":"trace[636054276] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"393.325164ms","start":"2026-05-06T05:00:16.334811Z","end":"2026-05-06T05:00:16.728136Z","steps":["trace[636054276] 'read index received' (duration: 318.314998ms)","trace[636054276] 'applied index is now lower than readState.Index' (duration: 75.008696ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:00:16.728304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.488645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:00:16.72834Z","caller":"traceutil/trace.go:171","msg":"trace[64465562] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"393.586447ms","start":"2026-05-06T05:00:16.334744Z","end":"2026-05-06T05:00:16.728331Z","steps":["trace[64465562] 'agreement among raft nodes before linearized reading' (duration: 393.480266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:00:16.728372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:00:16.334714Z","time spent":"393.651097ms","remote":"127.0.0.1:57214","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-05-06T05:00:16.728457Z","caller":"traceutil/trace.go:171","msg":"trace[1913709517] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"521.068388ms","start":"2026-05-06T05:00:16.207346Z","end":"2026-05-06T05:00:16.728414Z","steps":["trace[1913709517] 'process raft request' (duration: 445.8265ms)","trace[1913709517] 'compare' (duration: 74.67891ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:00:16.729038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:00:16.207327Z","time spent":"521.28622ms","remote":"127.0.0.1:57406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:00:16.995629Z","caller":"traceutil/trace.go:171","msg":"trace[1681854645] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"605.180189ms","start":"2026-05-06T05:00:16.390413Z","end":"2026-05-06T05:00:16.995593Z","steps":["trace[1681854645] 'process raft request' (duration: 560.265487ms)","trace[1681854645] 'compare' (duration: 44.655858ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:00:16.995819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:00:16.390388Z","time spent":"605.337811ms","remote":"127.0.0.1:57404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4538,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:00:16.995838Z","caller":"traceutil/trace.go:171","msg":"trace[806929224] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:650; }","duration":"266.228426ms","start":"2026-05-06T05:00:16.729579Z","end":"2026-05-06T05:00:16.995808Z","steps":["trace[806929224] 'read index received' (duration: 221.06723ms)","trace[806929224] 'applied index is now lower than readState.Index' (duration: 45.160255ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:00:16.995922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.340097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:00:16.995943Z","caller":"traceutil/trace.go:171","msg":"trace[1605606887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"266.406858ms","start":"2026-05-06T05:00:16.729529Z","end":"2026-05-06T05:00:16.995936Z","steps":["trace[1605606887] 'agreement among raft nodes before linearized reading' (duration: 266.355917ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:16.995988Z","caller":"traceutil/trace.go:171","msg":"trace[1216562480] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"450.40872ms","start":"2026-05-06T05:00:16.545563Z","end":"2026-05-06T05:00:16.995972Z","steps":["trace[1216562480] 'process raft request' (duration: 449.894493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:00:16.99609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:00:16.545541Z","time spent":"450.487221ms","remote":"127.0.0.1:57460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:02:22.040061Z","caller":"traceutil/trace.go:171","msg":"trace[235678629] linearizableReadLoop","detail":"{readStateIndex:1373; appliedIndex:1372; }","duration":"246.091986ms","start":"2026-05-06T05:02:21.793947Z","end":"2026-05-06T05:02:22.040039Z","steps":["trace[235678629] 'read index received' (duration: 245.921003ms)","trace[235678629] 'applied index is now lower than readState.Index' (duration: 170.033µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:02:22.040162Z","caller":"traceutil/trace.go:171","msg":"trace[787204715] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"246.494322ms","start":"2026-05-06T05:02:21.793639Z","end":"2026-05-06T05:02:22.040133Z","steps":["trace[787204715] 'process raft request' (duration: 246.270539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:02:22.040273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.299249ms","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-05-06T05:02:22.04032Z","caller":"traceutil/trace.go:171","msg":"trace[55081769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1321; }","duration":"246.38783ms","start":"2026-05-06T05:02:21.793922Z","end":"2026-05-06T05:02:22.04031Z","steps":["trace[55081769] 'agreement among raft nodes before linearized reading' (duration: 246.210417ms)"],"step_count":1}