{"level":"warn","ts":"2026-05-19T19:10:34.885272Z","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-19T19:10:34.885353Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132: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.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132: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-19T19:10:34.885413Z","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-19T19:10:34.885424Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-05-19T19:10:34.885442Z","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-19T19:10:34.886068Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]} {"level":"info","ts":"2026-05-19T19:10:34.886153Z","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.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132: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-19T19:10:34.900768Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"14.410259ms"} {"level":"info","ts":"2026-05-19T19:10:34.914174Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"} {"level":"info","ts":"2026-05-19T19:10:34.914255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T19:10:34.914277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"} {"level":"info","ts":"2026-05-19T19:10:34.914288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T19:10:34.914298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"} {"level":"info","ts":"2026-05-19T19:10:34.914333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"warn","ts":"2026-05-19T19:10:34.919841Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T19:10:34.921635Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T19:10:34.922807Z","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-19T19:10:34.924844Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T19:10:34.925188Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T19:10:34.925215Z","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-19T19:10:34.925381Z","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-19T19:10:34.9254Z","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-19T19:10:34.925761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"info","ts":"2026-05-19T19:10:34.928177Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-05-19T19:10:34.931667Z","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-19T19:10:34.931918Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-05-19T19:10:34.93197Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-05-19T19:10:34.932217Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T19:10:34.932287Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T19:10:35.715082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T19:10:35.715384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T19:10:35.715407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"} {"level":"info","ts":"2026-05-19T19:10:35.715424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"} {"level":"info","ts":"2026-05-19T19:10:35.715429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-05-19T19:10:35.715439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"} {"level":"info","ts":"2026-05-19T19:10:35.715448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-05-19T19:10:35.721277Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T19:10:35.721438Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T19:10:35.721574Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T19:10:35.72166Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:10:35.723083Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T19:10:35.723156Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T19:10:35.723788Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:10:35.723888Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T19:10:35.723899Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:10:35.723934Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T19:10:35.728723Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"} {"level":"info","ts":"2026-05-19T19:10:41.799965Z","caller":"traceutil/trace.go:171","msg":"trace[807882029] transaction","detail":"{read_only:false; number_of_response:0; response_revision:314; }","duration":"109.364497ms","start":"2026-05-19T19:10:41.690583Z","end":"2026-05-19T19:10:41.799948Z","steps":["trace[807882029] 'process raft request' (duration: 109.182075ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:10:41.988701Z","caller":"traceutil/trace.go:171","msg":"trace[197691532] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:330; }","duration":"114.975102ms","start":"2026-05-19T19:10:41.873699Z","end":"2026-05-19T19:10:41.988674Z","steps":["trace[197691532] 'read index received' (duration: 26.071706ms)","trace[197691532] 'applied index is now lower than readState.Index' (duration: 88.901876ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:10:41.988814Z","caller":"traceutil/trace.go:171","msg":"trace[921791417] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"134.288095ms","start":"2026-05-19T19:10:41.854491Z","end":"2026-05-19T19:10:41.988779Z","steps":["trace[921791417] 'process raft request' (duration: 45.37211ms)","trace[921791417] 'compare' (duration: 88.666204ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:10:41.988864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.138983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:10:41.988941Z","caller":"traceutil/trace.go:171","msg":"trace[1816553676] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:0; response_revision:318; }","duration":"115.295245ms","start":"2026-05-19T19:10:41.873634Z","end":"2026-05-19T19:10:41.988929Z","steps":["trace[1816553676] 'agreement among raft nodes before linearized reading' (duration: 115.162064ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:10:45.46622Z","caller":"traceutil/trace.go:171","msg":"trace[1243676348] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"115.971971ms","start":"2026-05-19T19:10:45.350216Z","end":"2026-05-19T19:10:45.466188Z","steps":["trace[1243676348] 'process raft request' (duration: 94.015961ms)","trace[1243676348] 'compare' (duration: 21.789949ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:10:45.489807Z","caller":"traceutil/trace.go:171","msg":"trace[741059292] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"139.354294ms","start":"2026-05-19T19:10:45.350422Z","end":"2026-05-19T19:10:45.489777Z","steps":["trace[741059292] 'process raft request' (duration: 139.140372ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:10:45.490109Z","caller":"traceutil/trace.go:171","msg":"trace[757024522] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"137.62613ms","start":"2026-05-19T19:10:45.352391Z","end":"2026-05-19T19:10:45.490017Z","steps":["trace[757024522] 'process raft request' (duration: 137.323988ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:10:45.490089Z","caller":"traceutil/trace.go:171","msg":"trace[188661445] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:366; }","duration":"115.595568ms","start":"2026-05-19T19:10:45.374465Z","end":"2026-05-19T19:10:45.49006Z","steps":["trace[188661445] 'read index received' (duration: 69.742542ms)","trace[188661445] 'applied index is now lower than readState.Index' (duration: 45.850576ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:10:45.490419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.760849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-19T19:10:45.490557Z","caller":"traceutil/trace.go:171","msg":"trace[711985458] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:356; }","duration":"116.088892ms","start":"2026-05-19T19:10:45.374423Z","end":"2026-05-19T19:10:45.490512Z","steps":["trace[711985458] 'agreement among raft nodes before linearized reading' (duration: 115.748689ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:02.818469Z","caller":"traceutil/trace.go:171","msg":"trace[1511640747] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"176.491483ms","start":"2026-05-19T19:11:02.641954Z","end":"2026-05-19T19:11:02.818446Z","steps":["trace[1511640747] 'process raft request' (duration: 176.379749ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.899869Z","caller":"traceutil/trace.go:171","msg":"trace[353780] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"278.73702ms","start":"2026-05-19T19:11:09.621035Z","end":"2026-05-19T19:11:09.899772Z","steps":["trace[353780] 'process raft request' (duration: 278.519261ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.964325Z","caller":"traceutil/trace.go:171","msg":"trace[1267951109] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"155.709174ms","start":"2026-05-19T19:11:09.808596Z","end":"2026-05-19T19:11:09.964306Z","steps":["trace[1267951109] 'process raft request' (duration: 155.476404ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.964466Z","caller":"traceutil/trace.go:171","msg":"trace[960214842] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"167.073035ms","start":"2026-05-19T19:11:09.797293Z","end":"2026-05-19T19:11:09.964366Z","steps":["trace[960214842] 'process raft request' (duration: 166.113347ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.964476Z","caller":"traceutil/trace.go:171","msg":"trace[1247592619] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"123.944275ms","start":"2026-05-19T19:11:09.840512Z","end":"2026-05-19T19:11:09.964456Z","steps":["trace[1247592619] 'process raft request' (duration: 123.901072ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.964696Z","caller":"traceutil/trace.go:171","msg":"trace[1996706133] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"166.122148ms","start":"2026-05-19T19:11:09.798556Z","end":"2026-05-19T19:11:09.964678Z","steps":["trace[1996706133] 'process raft request' (duration: 165.010172ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.964775Z","caller":"traceutil/trace.go:171","msg":"trace[1005488379] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"141.619203ms","start":"2026-05-19T19:11:09.82315Z","end":"2026-05-19T19:11:09.96477Z","steps":["trace[1005488379] 'process raft request' (duration: 141.121521ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.964919Z","caller":"traceutil/trace.go:171","msg":"trace[216198720] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"141.389133ms","start":"2026-05-19T19:11:09.823523Z","end":"2026-05-19T19:11:09.964912Z","steps":["trace[216198720] 'process raft request' (duration: 140.804379ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.965078Z","caller":"traceutil/trace.go:171","msg":"trace[1392131303] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"166.296124ms","start":"2026-05-19T19:11:09.798766Z","end":"2026-05-19T19:11:09.965062Z","steps":["trace[1392131303] 'process raft request' (duration: 164.830894ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.964734Z","caller":"traceutil/trace.go:171","msg":"trace[784578350] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"156.108031ms","start":"2026-05-19T19:11:09.808617Z","end":"2026-05-19T19:11:09.964725Z","steps":["trace[784578350] 'process raft request' (duration: 155.490925ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.964755Z","caller":"traceutil/trace.go:171","msg":"trace[1818112936] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"153.439472ms","start":"2026-05-19T19:11:09.811312Z","end":"2026-05-19T19:11:09.964751Z","steps":["trace[1818112936] 'process raft request' (duration: 152.840027ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.964312Z","caller":"traceutil/trace.go:171","msg":"trace[1805541165] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"155.770446ms","start":"2026-05-19T19:11:09.808515Z","end":"2026-05-19T19:11:09.964285Z","steps":["trace[1805541165] 'process raft request' (duration: 155.11648ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:09.965619Z","caller":"traceutil/trace.go:171","msg":"trace[272332399] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"156.245416ms","start":"2026-05-19T19:11:09.808577Z","end":"2026-05-19T19:11:09.964822Z","steps":["trace[272332399] 'process raft request' (duration: 155.439762ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:10.99879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.622678ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:11:10.998905Z","caller":"traceutil/trace.go:171","msg":"trace[1726777521] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"539.263924ms","start":"2026-05-19T19:11:10.459623Z","end":"2026-05-19T19:11:10.998887Z","steps":["trace[1726777521] 'process raft request' (duration: 57.817902ms)","trace[1726777521] 'compare' (duration: 480.482613ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:11:10.99897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:10.459599Z","time spent":"539.340227ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65412,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:11:11.000585Z","caller":"traceutil/trace.go:171","msg":"trace[1300995526] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"540.084306ms","start":"2026-05-19T19:11:10.460486Z","end":"2026-05-19T19:11:11.000571Z","steps":["trace[1300995526] 'process raft request' (duration: 539.962211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:11.000675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:10.460466Z","time spent":"540.1662ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:11:11.012697Z","caller":"traceutil/trace.go:171","msg":"trace[184021452] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"150.75704ms","start":"2026-05-19T19:11:10.861922Z","end":"2026-05-19T19:11:11.01268Z","steps":["trace[184021452] 'read index received' (duration: 138.636497ms)","trace[184021452] 'applied index is now lower than readState.Index' (duration: 12.119793ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:11:11.012747Z","caller":"traceutil/trace.go:171","msg":"trace[20537209] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"387.374602ms","start":"2026-05-19T19:11:10.625349Z","end":"2026-05-19T19:11:11.012724Z","steps":["trace[20537209] 'process raft request' (duration: 387.028048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:11.012855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:10.625318Z","time spent":"387.485956ms","remote":"127.0.0.1:57950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T19:11:11.012948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.004549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-19T19:11:11.013032Z","caller":"traceutil/trace.go:171","msg":"trace[902617431] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:582; }","duration":"151.140725ms","start":"2026-05-19T19:11:10.861872Z","end":"2026-05-19T19:11:11.013012Z","steps":["trace[902617431] 'agreement among raft nodes before linearized reading' (duration: 150.875025ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:16.999351Z","caller":"traceutil/trace.go:171","msg":"trace[1950349024] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"223.254641ms","start":"2026-05-19T19:11:16.776076Z","end":"2026-05-19T19:11:16.999331Z","steps":["trace[1950349024] 'read index received' (duration: 221.797996ms)","trace[1950349024] 'applied index is now lower than readState.Index' (duration: 1.455635ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:11:16.999483Z","caller":"traceutil/trace.go:171","msg":"trace[1622675648] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"286.201834ms","start":"2026-05-19T19:11:16.713254Z","end":"2026-05-19T19:11:16.999456Z","steps":["trace[1622675648] 'process raft request' (duration: 284.930066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:16.999595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.4942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6ddfh\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-19T19:11:16.999649Z","caller":"traceutil/trace.go:171","msg":"trace[916976948] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6ddfh; range_end:; response_count:1; response_revision:630; }","duration":"223.597754ms","start":"2026-05-19T19:11:16.776034Z","end":"2026-05-19T19:11:16.999632Z","steps":["trace[916976948] 'agreement among raft nodes before linearized reading' (duration: 223.381616ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:17.525486Z","caller":"traceutil/trace.go:171","msg":"trace[1227315455] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"486.490934ms","start":"2026-05-19T19:11:17.03897Z","end":"2026-05-19T19:11:17.525461Z","steps":["trace[1227315455] 'read index received' (duration: 486.14487ms)","trace[1227315455] 'applied index is now lower than readState.Index' (duration: 345.014µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:11:17.525586Z","caller":"traceutil/trace.go:171","msg":"trace[1669778612] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"499.701515ms","start":"2026-05-19T19:11:17.025789Z","end":"2026-05-19T19:11:17.52549Z","steps":["trace[1669778612] 'process raft request' (duration: 499.383102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:17.525841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.845856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-19T19:11:17.526191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:17.02574Z","time spent":"500.232303ms","remote":"127.0.0.1:58104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:11:17.526325Z","caller":"traceutil/trace.go:171","msg":"trace[817718499] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"487.133247ms","start":"2026-05-19T19:11:17.038929Z","end":"2026-05-19T19:11:17.526063Z","steps":["trace[817718499] 'agreement among raft nodes before linearized reading' (duration: 486.730232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:17.52676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:17.038913Z","time spent":"487.538012ms","remote":"127.0.0.1:58180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T19:11:18.06008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.705351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T19:11:18.060266Z","caller":"traceutil/trace.go:171","msg":"trace[73276831] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"527.429601ms","start":"2026-05-19T19:11:17.532818Z","end":"2026-05-19T19:11:18.060248Z","steps":["trace[73276831] 'process raft request' (duration: 527.372479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:18.060389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:17.532792Z","time spent":"527.549255ms","remote":"127.0.0.1:58180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T19:11:18.06048Z","caller":"traceutil/trace.go:171","msg":"trace[236109655] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"534.629467ms","start":"2026-05-19T19:11:17.525798Z","end":"2026-05-19T19:11:18.060427Z","steps":["trace[236109655] 'read index received' (duration: 236.529442ms)","trace[236109655] 'applied index is now lower than readState.Index' (duration: 298.097005ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T19:11:18.060609Z","caller":"traceutil/trace.go:171","msg":"trace[1131674968] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"986.268097ms","start":"2026-05-19T19:11:17.074327Z","end":"2026-05-19T19:11:18.060595Z","steps":["trace[1131674968] 'process raft request' (duration: 687.986765ms)","trace[1131674968] 'compare' (duration: 297.556925ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:11:18.060701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:17.074306Z","time spent":"986.33678ms","remote":"127.0.0.1:58158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T19:11:18.060819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.089536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-19T19:11:18.060861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.085576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-19T19:11:18.060893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.631299ms","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-05-19T19:11:18.060901Z","caller":"traceutil/trace.go:171","msg":"trace[495244793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:633; }","duration":"580.176929ms","start":"2026-05-19T19:11:17.480703Z","end":"2026-05-19T19:11:18.060879Z","steps":["trace[495244793] 'agreement among raft nodes before linearized reading' (duration: 579.958651ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T19:11:18.060928Z","caller":"traceutil/trace.go:171","msg":"trace[1646423942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:633; }","duration":"580.21114ms","start":"2026-05-19T19:11:17.480699Z","end":"2026-05-19T19:11:18.06091Z","steps":["trace[1646423942] 'agreement among raft nodes before linearized reading' (duration: 579.968771ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:18.060949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:17.480656Z","time spent":"580.285153ms","remote":"127.0.0.1:58180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-19T19:11:18.060953Z","caller":"traceutil/trace.go:171","msg":"trace[596041692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:633; }","duration":"119.728403ms","start":"2026-05-19T19:11:17.941205Z","end":"2026-05-19T19:11:18.060934Z","steps":["trace[596041692] 'agreement among raft nodes before linearized reading' (duration: 119.522415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:18.060983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:17.480666Z","time spent":"580.308543ms","remote":"127.0.0.1:58180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T19:11:39.285534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:38.83641Z","time spent":"449.120029ms","remote":"127.0.0.1:57932","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-19T19:11:39.28563Z","caller":"traceutil/trace.go:171","msg":"trace[1682953191] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:838; }","duration":"389.1367ms","start":"2026-05-19T19:11:38.896446Z","end":"2026-05-19T19:11:39.285582Z","steps":["trace[1682953191] 'read index received' (duration: 389.11371ms)","trace[1682953191] 'applied index is now lower than readState.Index' (duration: 18.51µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T19:11:39.286019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.548302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-z8tkc\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-19T19:11:39.286166Z","caller":"traceutil/trace.go:171","msg":"trace[1011036808] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-z8tkc; range_end:; response_count:1; response_revision:809; }","duration":"389.774399ms","start":"2026-05-19T19:11:38.896368Z","end":"2026-05-19T19:11:39.286143Z","steps":["trace[1011036808] 'agreement among raft nodes before linearized reading' (duration: 389.350556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:39.286227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:38.896333Z","time spent":"389.884682ms","remote":"127.0.0.1:58104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-z8tkc\" "} {"level":"info","ts":"2026-05-19T19:11:39.369547Z","caller":"traceutil/trace.go:171","msg":"trace[1234566248] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"443.436414ms","start":"2026-05-19T19:11:38.92608Z","end":"2026-05-19T19:11:39.369516Z","steps":["trace[1234566248] 'process raft request' (duration: 442.911569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:39.369735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:38.92606Z","time spent":"443.576858ms","remote":"127.0.0.1:58180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T19:11:39.36973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.391332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:11:39.369933Z","caller":"traceutil/trace.go:171","msg":"trace[1277625669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"394.626288ms","start":"2026-05-19T19:11:38.975282Z","end":"2026-05-19T19:11:39.369908Z","steps":["trace[1277625669] 'agreement among raft nodes before linearized reading' (duration: 394.109563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:11:39.370012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T19:11:38.975274Z","time spent":"394.725122ms","remote":"127.0.0.1:57894","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-19T19:13:00.198941Z","caller":"traceutil/trace.go:171","msg":"trace[340278573] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"132.850837ms","start":"2026-05-19T19:13:00.066067Z","end":"2026-05-19T19:13:00.198918Z","steps":["trace[340278573] 'process raft request' (duration: 132.716145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:13:40.872042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.575251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:811"} {"level":"info","ts":"2026-05-19T19:13:40.872132Z","caller":"traceutil/trace.go:171","msg":"trace[769956021] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:1386; }","duration":"103.709553ms","start":"2026-05-19T19:13:40.768402Z","end":"2026-05-19T19:13:40.872111Z","steps":["trace[769956021] 'range keys from in-memory index tree' (duration: 103.474039ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T19:13:41.095291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.031748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T19:13:41.095342Z","caller":"traceutil/trace.go:171","msg":"trace[294742281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1390; }","duration":"123.138699ms","start":"2026-05-19T19:13:40.972192Z","end":"2026-05-19T19:13:41.09533Z","steps":["trace[294742281] 'range keys from in-memory index tree' (duration: 122.978037ms)"],"step_count":1}