{"level":"warn","ts":"2026-04-20T11:50:56.079165Z","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-20T11:50:56.079276Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-20T11:50:56.079536Z","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-20T11:50:56.079559Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-04-20T11:50:56.079647Z","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-20T11:50:56.080676Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-04-20T11:50:56.080871Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-20T11:50:56.085262Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.069188ms"} {"level":"info","ts":"2026-04-20T11:50:56.097211Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-04-20T11:50:56.097367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T11:50:56.0974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-04-20T11:50:56.097475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T11:50:56.097495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-04-20T11:50:56.097619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-04-20T11:50:56.111855Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T11:50:56.113376Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T11:50:56.11457Z","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-20T11:50:56.117459Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T11:50:56.11768Z","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-20T11:50:56.117796Z","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-20T11:50:56.117827Z","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-20T11:50:56.117911Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T11:50:56.119863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-04-20T11:50:56.120124Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-04-20T11:50:56.122923Z","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-20T11:50:56.123127Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T11:50:56.123179Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T11:50:56.123643Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-04-20T11:50:56.123684Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-04-20T11:50:56.998642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T11:50:56.998701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T11:50:56.998738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-04-20T11:50:56.998761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-04-20T11:50:56.998774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-04-20T11:50:56.998801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-04-20T11:50:56.998833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-04-20T11:50:57.000755Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:50:57.001972Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T11:50:57.001974Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T11:50:57.002018Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T11:50:57.002255Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T11:50:57.002301Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T11:50:57.002607Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:50:57.002714Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:50:57.002752Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:50:57.004644Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T11:50:57.005054Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-04-20T11:51:25.71602Z","caller":"traceutil/trace.go:171","msg":"trace[879271109] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"147.158087ms","start":"2026-04-20T11:51:25.568838Z","end":"2026-04-20T11:51:25.715996Z","steps":["trace[879271109] 'process raft request' (duration: 147.004223ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.850996Z","caller":"traceutil/trace.go:171","msg":"trace[65693521] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"260.88724ms","start":"2026-04-20T11:51:25.590086Z","end":"2026-04-20T11:51:25.850973Z","steps":["trace[65693521] 'process raft request' (duration: 260.725516ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.850984Z","caller":"traceutil/trace.go:171","msg":"trace[519631320] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"265.418452ms","start":"2026-04-20T11:51:25.585495Z","end":"2026-04-20T11:51:25.850913Z","steps":["trace[519631320] 'process raft request' (duration: 264.930579ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.85103Z","caller":"traceutil/trace.go:171","msg":"trace[931051962] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"260.87931ms","start":"2026-04-20T11:51:25.590125Z","end":"2026-04-20T11:51:25.851004Z","steps":["trace[931051962] 'process raft request' (duration: 260.756637ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.851146Z","caller":"traceutil/trace.go:171","msg":"trace[212170862] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"260.660225ms","start":"2026-04-20T11:51:25.590439Z","end":"2026-04-20T11:51:25.851099Z","steps":["trace[212170862] 'process raft request' (duration: 260.564842ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.851185Z","caller":"traceutil/trace.go:171","msg":"trace[2030801823] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"254.803178ms","start":"2026-04-20T11:51:25.596368Z","end":"2026-04-20T11:51:25.851171Z","steps":["trace[2030801823] 'process raft request' (duration: 254.674354ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.851242Z","caller":"traceutil/trace.go:171","msg":"trace[689349495] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"250.952474ms","start":"2026-04-20T11:51:25.600282Z","end":"2026-04-20T11:51:25.851235Z","steps":["trace[689349495] 'process raft request' (duration: 250.805ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.851336Z","caller":"traceutil/trace.go:171","msg":"trace[681431664] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"247.80478ms","start":"2026-04-20T11:51:25.603524Z","end":"2026-04-20T11:51:25.851328Z","steps":["trace[681431664] 'process raft request' (duration: 247.625595ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.851408Z","caller":"traceutil/trace.go:171","msg":"trace[957329991] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"239.763705ms","start":"2026-04-20T11:51:25.61163Z","end":"2026-04-20T11:51:25.851394Z","steps":["trace[957329991] 'process raft request' (duration: 239.563839ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.851444Z","caller":"traceutil/trace.go:171","msg":"trace[979806696] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"236.809187ms","start":"2026-04-20T11:51:25.614617Z","end":"2026-04-20T11:51:25.851426Z","steps":["trace[979806696] 'process raft request' (duration: 236.682203ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.851663Z","caller":"traceutil/trace.go:171","msg":"trace[1665353906] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"261.335332ms","start":"2026-04-20T11:51:25.590299Z","end":"2026-04-20T11:51:25.851635Z","steps":["trace[1665353906] 'process raft request' (duration: 260.653304ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.855915Z","caller":"traceutil/trace.go:171","msg":"trace[934656888] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"123.778302ms","start":"2026-04-20T11:51:25.732125Z","end":"2026-04-20T11:51:25.855903Z","steps":["trace[934656888] 'process raft request' (duration: 123.721161ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.856043Z","caller":"traceutil/trace.go:171","msg":"trace[2030340201] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"134.375736ms","start":"2026-04-20T11:51:25.72165Z","end":"2026-04-20T11:51:25.856026Z","steps":["trace[2030340201] 'process raft request' (duration: 133.965555ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.856423Z","caller":"traceutil/trace.go:171","msg":"trace[513397330] transaction","detail":"{read_only:false; number_of_response:1; response_revision:502; }","duration":"132.808094ms","start":"2026-04-20T11:51:25.723604Z","end":"2026-04-20T11:51:25.856412Z","steps":["trace[513397330] 'process raft request' (duration: 132.122616ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:25.856587Z","caller":"traceutil/trace.go:171","msg":"trace[635693536] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"133.45081ms","start":"2026-04-20T11:51:25.723126Z","end":"2026-04-20T11:51:25.856577Z","steps":["trace[635693536] 'process raft request' (duration: 132.552146ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:51:31.256313Z","caller":"traceutil/trace.go:171","msg":"trace[304683682] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"169.454754ms","start":"2026-04-20T11:51:31.086819Z","end":"2026-04-20T11:51:31.256274Z","steps":["trace[304683682] 'process raft request' (duration: 166.731411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:51:32.605072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.824209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T11:51:32.605198Z","caller":"traceutil/trace.go:171","msg":"trace[1290363615] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:598; }","duration":"310.060486ms","start":"2026-04-20T11:51:32.295116Z","end":"2026-04-20T11:51:32.605177Z","steps":["trace[1290363615] 'range keys from in-memory index tree' (duration: 309.603184ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:51:32.605247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:51:32.2951Z","time spent":"310.135827ms","remote":"127.0.0.1:56836","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-20T11:51:32.714047Z","caller":"traceutil/trace.go:171","msg":"trace[242060758] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"401.748748ms","start":"2026-04-20T11:51:32.312281Z","end":"2026-04-20T11:51:32.714029Z","steps":["trace[242060758] 'process raft request' (duration: 401.08147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:51:32.714541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:51:32.312252Z","time spent":"401.850151ms","remote":"127.0.0.1:56658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:51:32.724716Z","caller":"traceutil/trace.go:171","msg":"trace[2135956658] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"384.744753ms","start":"2026-04-20T11:51:32.339947Z","end":"2026-04-20T11:51:32.724692Z","steps":["trace[2135956658] 'process raft request' (duration: 384.473746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:51:32.724843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:51:32.339935Z","time spent":"384.843657ms","remote":"127.0.0.1:56836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:51:32.724754Z","caller":"traceutil/trace.go:171","msg":"trace[1152952053] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:615; }","duration":"101.181038ms","start":"2026-04-20T11:51:32.623554Z","end":"2026-04-20T11:51:32.724735Z","steps":["trace[1152952053] 'read index received' (duration: 89.734071ms)","trace[1152952053] 'applied index is now lower than readState.Index' (duration: 11.446077ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:51:32.725047Z","caller":"traceutil/trace.go:171","msg":"trace[310737357] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"115.378777ms","start":"2026-04-20T11:51:32.609659Z","end":"2026-04-20T11:51:32.725038Z","steps":["trace[310737357] 'process raft request' (duration: 114.874203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:51:32.725268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.731622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-20T11:51:32.725311Z","caller":"traceutil/trace.go:171","msg":"trace[1820285754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"101.802674ms","start":"2026-04-20T11:51:32.623497Z","end":"2026-04-20T11:51:32.725299Z","steps":["trace[1820285754] 'agreement among raft nodes before linearized reading' (duration: 101.699991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:51:48.298461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.906704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T11:51:48.298555Z","caller":"traceutil/trace.go:171","msg":"trace[1989024810] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:762; }","duration":"300.017287ms","start":"2026-04-20T11:51:47.998519Z","end":"2026-04-20T11:51:48.298537Z","steps":["trace[1989024810] 'range keys from in-memory index tree' (duration: 299.613087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:51:48.298599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:51:47.998421Z","time spent":"300.168611ms","remote":"127.0.0.1:56836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-20T11:52:23.479481Z","caller":"traceutil/trace.go:171","msg":"trace[858273971] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"129.44156ms","start":"2026-04-20T11:52:23.350001Z","end":"2026-04-20T11:52:23.479443Z","steps":["trace[858273971] 'process raft request' (duration: 129.207083ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:52:23.654864Z","caller":"traceutil/trace.go:171","msg":"trace[758097458] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"158.223617ms","start":"2026-04-20T11:52:23.496594Z","end":"2026-04-20T11:52:23.654817Z","steps":["trace[758097458] 'process raft request' (duration: 134.025702ms)","trace[758097458] 'compare' (duration: 24.0064ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:52:23.827277Z","caller":"traceutil/trace.go:171","msg":"trace[636338486] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"124.054326ms","start":"2026-04-20T11:52:23.702885Z","end":"2026-04-20T11:52:23.826939Z","steps":["trace[636338486] 'process raft request' (duration: 95.399323ms)","trace[636338486] 'compare' (duration: 28.478369ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:52:45.437802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.413906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:52:45.438053Z","caller":"traceutil/trace.go:171","msg":"trace[769622178] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"262.27777ms","start":"2026-04-20T11:52:45.175741Z","end":"2026-04-20T11:52:45.438019Z","steps":["trace[769622178] 'process raft request' (duration: 140.406522ms)","trace[769622178] 'compare' (duration: 121.266632ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:52:45.438182Z","caller":"traceutil/trace.go:171","msg":"trace[222136275] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"261.571152ms","start":"2026-04-20T11:52:45.176576Z","end":"2026-04-20T11:52:45.438148Z","steps":["trace[222136275] 'process raft request' (duration: 261.354006ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:52:45.863563Z","caller":"traceutil/trace.go:171","msg":"trace[1986523061] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"140.564286ms","start":"2026-04-20T11:52:45.722979Z","end":"2026-04-20T11:52:45.863543Z","steps":["trace[1986523061] 'process raft request' (duration: 77.254669ms)","trace[1986523061] 'compare' (duration: 63.141763ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:52:59.443186Z","caller":"traceutil/trace.go:171","msg":"trace[761249253] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"207.402277ms","start":"2026-04-20T11:52:59.23575Z","end":"2026-04-20T11:52:59.443153Z","steps":["trace[761249253] 'process raft request' (duration: 207.241893ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:53:15.000718Z","caller":"traceutil/trace.go:171","msg":"trace[1619297590] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"146.627808ms","start":"2026-04-20T11:53:14.854066Z","end":"2026-04-20T11:53:15.000694Z","steps":["trace[1619297590] 'process raft request' (duration: 131.153395ms)","trace[1619297590] 'compare' (duration: 15.391171ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:53:19.837941Z","caller":"traceutil/trace.go:171","msg":"trace[1819237473] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"111.185153ms","start":"2026-04-20T11:53:19.726716Z","end":"2026-04-20T11:53:19.837901Z","steps":["trace[1819237473] 'process raft request' (duration: 110.799413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:20.308813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.053203ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:53:20.308993Z","caller":"traceutil/trace.go:171","msg":"trace[375744363] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"467.126729ms","start":"2026-04-20T11:53:19.841829Z","end":"2026-04-20T11:53:20.308955Z","steps":["trace[375744363] 'process raft request' (duration: 341.82658ms)","trace[375744363] 'compare' (duration: 124.673533ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:53:20.309093Z","caller":"traceutil/trace.go:171","msg":"trace[1623538561] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1295; }","duration":"234.51654ms","start":"2026-04-20T11:53:20.074545Z","end":"2026-04-20T11:53:20.309062Z","steps":["trace[1623538561] 'read index received' (duration: 109.109418ms)","trace[1623538561] 'applied index is now lower than readState.Index' (duration: 125.404582ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:53:20.309194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:53:19.841807Z","time spent":"467.285884ms","remote":"127.0.0.1:56836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:53:20.309032Z","caller":"traceutil/trace.go:171","msg":"trace[1611236363] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"203.829702ms","start":"2026-04-20T11:53:20.105182Z","end":"2026-04-20T11:53:20.309012Z","steps":["trace[1611236363] 'process raft request' (duration: 203.76566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:20.309459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.88477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T11:53:20.309568Z","caller":"traceutil/trace.go:171","msg":"trace[1712973937] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:1255; }","duration":"235.052995ms","start":"2026-04-20T11:53:20.074489Z","end":"2026-04-20T11:53:20.309542Z","steps":["trace[1712973937] 'agreement among raft nodes before linearized reading' (duration: 234.688545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:20.338727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.851116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-04-20T11:53:20.338825Z","caller":"traceutil/trace.go:171","msg":"trace[835645076] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1256; }","duration":"190.98317ms","start":"2026-04-20T11:53:20.14782Z","end":"2026-04-20T11:53:20.338804Z","steps":["trace[835645076] 'agreement among raft nodes before linearized reading' (duration: 190.759084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:21.049122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.849356ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T11:53:21.049693Z","caller":"traceutil/trace.go:171","msg":"trace[286978808] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"705.890083ms","start":"2026-04-20T11:53:20.343768Z","end":"2026-04-20T11:53:21.049658Z","steps":["trace[286978808] 'process raft request' (duration: 66.292487ms)","trace[286978808] 'compare' (duration: 638.515818ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:53:21.049819Z","caller":"traceutil/trace.go:171","msg":"trace[717420797] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1299; }","duration":"552.593117ms","start":"2026-04-20T11:53:20.497206Z","end":"2026-04-20T11:53:21.049799Z","steps":["trace[717420797] 'read index received' (duration: 110.232308ms)","trace[717420797] 'applied index is now lower than readState.Index' (duration: 442.356799ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:53:21.049985Z","caller":"traceutil/trace.go:171","msg":"trace[591084143] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"689.132807ms","start":"2026-04-20T11:53:20.360805Z","end":"2026-04-20T11:53:21.049938Z","steps":["trace[591084143] 'process raft request' (duration: 688.676355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:21.050237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:53:20.360794Z","time spent":"689.325992ms","remote":"127.0.0.1:56590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:53:21.050305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.08312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:53:21.050015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:53:20.343749Z","time spent":"706.053047ms","remote":"127.0.0.1:56836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T11:53:21.050405Z","caller":"traceutil/trace.go:171","msg":"trace[1101432797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1258; }","duration":"553.228835ms","start":"2026-04-20T11:53:20.497151Z","end":"2026-04-20T11:53:21.05038Z","steps":["trace[1101432797] 'agreement among raft nodes before linearized reading' (duration: 553.017759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:21.050507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:53:20.497133Z","time spent":"553.312596ms","remote":"127.0.0.1:56558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T11:53:21.143176Z","caller":"traceutil/trace.go:171","msg":"trace[1952756097] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"558.773232ms","start":"2026-04-20T11:53:20.584372Z","end":"2026-04-20T11:53:21.143145Z","steps":["trace[1952756097] 'process raft request' (duration: 558.599387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:21.143366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:53:20.584348Z","time spent":"558.924036ms","remote":"127.0.0.1:56836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:53:21.143475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.95423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T11:53:21.143566Z","caller":"traceutil/trace.go:171","msg":"trace[767176799] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1259; }","duration":"295.110006ms","start":"2026-04-20T11:53:20.848434Z","end":"2026-04-20T11:53:21.143544Z","steps":["trace[767176799] 'agreement among raft nodes before linearized reading' (duration: 294.784167ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:53:29.495178Z","caller":"traceutil/trace.go:171","msg":"trace[330285832] linearizableReadLoop","detail":"{readStateIndex:1356; appliedIndex:1355; }","duration":"133.990123ms","start":"2026-04-20T11:53:29.361165Z","end":"2026-04-20T11:53:29.495155Z","steps":["trace[330285832] 'read index received' (duration: 133.85428ms)","trace[330285832] 'applied index is now lower than readState.Index' (duration: 134.763µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:53:29.495208Z","caller":"traceutil/trace.go:171","msg":"trace[1513218496] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"278.147968ms","start":"2026-04-20T11:53:29.217042Z","end":"2026-04-20T11:53:29.49519Z","steps":["trace[1513218496] 'process raft request' (duration: 277.982484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:29.495328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.156338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:53:29.495394Z","caller":"traceutil/trace.go:171","msg":"trace[98879659] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1312; }","duration":"134.281271ms","start":"2026-04-20T11:53:29.361098Z","end":"2026-04-20T11:53:29.495379Z","steps":["trace[98879659] 'agreement among raft nodes before linearized reading' (duration: 134.162778ms)"],"step_count":1}