{"level":"warn","ts":"2026-05-14T11:12:28.806489Z","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-14T11:12:28.806593Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116: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-14T11:12:28.806682Z","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-14T11:12:28.806697Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-05-14T11:12:28.806728Z","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-14T11:12:28.807421Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-05-14T11:12:28.807506Z","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.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116: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-14T11:12:28.812044Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.320316ms"} {"level":"info","ts":"2026-05-14T11:12:28.818745Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-05-14T11:12:28.818836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-05-14T11:12:28.818861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-05-14T11:12:28.818871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-14T11:12:28.818886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-05-14T11:12:28.81893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-05-14T11:12:28.826296Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-14T11:12:28.827403Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-14T11:12:28.82997Z","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-14T11:12:28.832036Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-14T11:12:28.832237Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-14T11:12:28.834878Z","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-14T11:12:28.835037Z","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-14T11:12:28.835053Z","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-14T11:12:28.835465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-05-14T11:12:28.835608Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-05-14T11:12:28.842851Z","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-14T11:12:28.842931Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-05-14T11:12:28.842955Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-05-14T11:12:28.843083Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-14T11:12:28.843144Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-14T11:12:29.419937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-05-14T11:12:29.420067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-14T11:12:29.42013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-05-14T11:12:29.420148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-05-14T11:12:29.420155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-05-14T11:12:29.4202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-05-14T11:12:29.420209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-05-14T11:12:29.421319Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T11:12:29.42147Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-05-14T11:12:29.421533Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T11:12:29.421679Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T11:12:29.424762Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-14T11:12:29.425014Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T11:12:29.425215Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T11:12:29.42526Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T11:12:29.425648Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-05-14T11:12:29.426565Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-14T11:12:29.426636Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-05-14T11:12:59.775856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.325272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T11:12:59.77611Z","caller":"traceutil/trace.go:171","msg":"trace[680236365] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"227.804782ms","start":"2026-05-14T11:12:59.548285Z","end":"2026-05-14T11:12:59.77609Z","steps":["trace[680236365] 'process raft request' (duration: 227.697969ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:12:59.776396Z","caller":"traceutil/trace.go:171","msg":"trace[801215050] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"228.139781ms","start":"2026-05-14T11:12:59.548218Z","end":"2026-05-14T11:12:59.776357Z","steps":["trace[801215050] 'process raft request' (duration: 107.667196ms)","trace[801215050] 'compare' (duration: 119.146257ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T11:12:59.802781Z","caller":"traceutil/trace.go:171","msg":"trace[58402032] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"249.275231ms","start":"2026-05-14T11:12:59.55348Z","end":"2026-05-14T11:12:59.802755Z","steps":["trace[58402032] 'process raft request' (duration: 249.087265ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:12:59.802818Z","caller":"traceutil/trace.go:171","msg":"trace[965445760] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"247.247393ms","start":"2026-05-14T11:12:59.555548Z","end":"2026-05-14T11:12:59.802796Z","steps":["trace[965445760] 'process raft request' (duration: 247.137739ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:12:59.803118Z","caller":"traceutil/trace.go:171","msg":"trace[345064760] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"246.340967ms","start":"2026-05-14T11:12:59.556743Z","end":"2026-05-14T11:12:59.803083Z","steps":["trace[345064760] 'process raft request' (duration: 246.007457ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:12:59.803259Z","caller":"traceutil/trace.go:171","msg":"trace[1566722167] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"243.221537ms","start":"2026-05-14T11:12:59.560019Z","end":"2026-05-14T11:12:59.80324Z","steps":["trace[1566722167] 'process raft request' (duration: 242.888588ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:12:59.80372Z","caller":"traceutil/trace.go:171","msg":"trace[1564387529] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"241.289521ms","start":"2026-05-14T11:12:59.562412Z","end":"2026-05-14T11:12:59.803702Z","steps":["trace[1564387529] 'process raft request' (duration: 241.026304ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:12:59.803936Z","caller":"traceutil/trace.go:171","msg":"trace[74778065] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"222.047655ms","start":"2026-05-14T11:12:59.581873Z","end":"2026-05-14T11:12:59.803921Z","steps":["trace[74778065] 'process raft request' (duration: 221.750997ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:12:59.803985Z","caller":"traceutil/trace.go:171","msg":"trace[334401378] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"223.467267ms","start":"2026-05-14T11:12:59.580438Z","end":"2026-05-14T11:12:59.803905Z","steps":["trace[334401378] 'process raft request' (duration: 223.053055ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:12:59.804052Z","caller":"traceutil/trace.go:171","msg":"trace[236983074] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"215.775344ms","start":"2026-05-14T11:12:59.588251Z","end":"2026-05-14T11:12:59.804026Z","steps":["trace[236983074] 'process raft request' (duration: 215.585609ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:12:59.816344Z","caller":"traceutil/trace.go:171","msg":"trace[106823375] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"126.777207ms","start":"2026-05-14T11:12:59.689554Z","end":"2026-05-14T11:12:59.816331Z","steps":["trace[106823375] 'process raft request' (duration: 126.688835ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:13:05.964119Z","caller":"traceutil/trace.go:171","msg":"trace[1392799039] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"100.591983ms","start":"2026-05-14T11:13:05.863503Z","end":"2026-05-14T11:13:05.964095Z","steps":["trace[1392799039] 'read index received' (duration: 99.79884ms)","trace[1392799039] 'applied index is now lower than readState.Index' (duration: 792.493µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T11:13:05.964192Z","caller":"traceutil/trace.go:171","msg":"trace[1371264681] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"150.968856ms","start":"2026-05-14T11:13:05.813195Z","end":"2026-05-14T11:13:05.964164Z","steps":["trace[1371264681] 'process raft request' (duration: 150.343448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T11:13:05.964279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.757177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T11:13:05.964352Z","caller":"traceutil/trace.go:171","msg":"trace[1469667770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"100.88373ms","start":"2026-05-14T11:13:05.863449Z","end":"2026-05-14T11:13:05.964333Z","steps":["trace[1469667770] 'agreement among raft nodes before linearized reading' (duration: 100.732076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T11:13:06.435158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.974108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T11:13:06.435228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.324263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5gtsx\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-14T11:13:06.43525Z","caller":"traceutil/trace.go:171","msg":"trace[1917501733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"470.135483ms","start":"2026-05-14T11:13:05.965092Z","end":"2026-05-14T11:13:06.435228Z","steps":["trace[1917501733] 'range keys from in-memory index tree' (duration: 469.70131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T11:13:06.435277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.841227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T11:13:06.43531Z","caller":"traceutil/trace.go:171","msg":"trace[1026435385] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5gtsx; range_end:; response_count:1; response_revision:581; }","duration":"431.433216ms","start":"2026-05-14T11:13:06.003846Z","end":"2026-05-14T11:13:06.435279Z","steps":["trace[1026435385] 'range keys from in-memory index tree' (duration: 431.141328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T11:13:06.435298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T11:13:05.965078Z","time spent":"470.211815ms","remote":"127.0.0.1:51130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T11:13:06.435357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T11:13:06.003822Z","time spent":"431.524749ms","remote":"127.0.0.1:51288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-5gtsx\" "} {"level":"info","ts":"2026-05-14T11:13:06.435645Z","caller":"traceutil/trace.go:171","msg":"trace[1358510231] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"413.318983ms","start":"2026-05-14T11:13:06.02231Z","end":"2026-05-14T11:13:06.435629Z","steps":["trace[1358510231] 'process raft request' (duration: 232.023423ms)","trace[1358510231] 'compare' (duration: 180.58462ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T11:13:06.435737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T11:13:06.022286Z","time spent":"413.399766ms","remote":"127.0.0.1:51576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T11:13:27.240096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.130917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-tcdrl\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-14T11:13:27.240202Z","caller":"traceutil/trace.go:171","msg":"trace[497386746] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-tcdrl; range_end:; response_count:1; response_revision:760; }","duration":"111.291721ms","start":"2026-05-14T11:13:27.128892Z","end":"2026-05-14T11:13:27.240184Z","steps":["trace[497386746] 'range keys from in-memory index tree' (duration: 110.971661ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:13:27.444486Z","caller":"traceutil/trace.go:171","msg":"trace[367664754] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"169.403027ms","start":"2026-05-14T11:13:27.275054Z","end":"2026-05-14T11:13:27.444457Z","steps":["trace[367664754] 'read index received' (duration: 169.279334ms)","trace[367664754] 'applied index is now lower than readState.Index' (duration: 122.243µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T11:13:27.444541Z","caller":"traceutil/trace.go:171","msg":"trace[1974897322] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"196.720836ms","start":"2026-05-14T11:13:27.24779Z","end":"2026-05-14T11:13:27.444511Z","steps":["trace[1974897322] 'process raft request' (duration: 196.478039ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T11:13:27.44474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.663516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-14T11:13:27.444834Z","caller":"traceutil/trace.go:171","msg":"trace[1997258644] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:761; }","duration":"169.797439ms","start":"2026-05-14T11:13:27.275006Z","end":"2026-05-14T11:13:27.444803Z","steps":["trace[1997258644] 'agreement among raft nodes before linearized reading' (duration: 169.576633ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:02.169555Z","caller":"traceutil/trace.go:171","msg":"trace[1776823593] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"162.881655ms","start":"2026-05-14T11:14:02.006644Z","end":"2026-05-14T11:14:02.169526Z","steps":["trace[1776823593] 'process raft request' (duration: 162.71751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T11:14:02.475458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.844636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-14T11:14:02.475761Z","caller":"traceutil/trace.go:171","msg":"trace[1165418781] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:971; }","duration":"123.989062ms","start":"2026-05-14T11:14:02.351533Z","end":"2026-05-14T11:14:02.475522Z","steps":["trace[1165418781] 'range keys from in-memory index tree' (duration: 123.647111ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:02.523296Z","caller":"traceutil/trace.go:171","msg":"trace[1843977991] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"152.293459ms","start":"2026-05-14T11:14:02.370975Z","end":"2026-05-14T11:14:02.523268Z","steps":["trace[1843977991] 'process raft request' (duration: 152.124215ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:02.523504Z","caller":"traceutil/trace.go:171","msg":"trace[1253993115] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"152.504055ms","start":"2026-05-14T11:14:02.370975Z","end":"2026-05-14T11:14:02.523479Z","steps":["trace[1253993115] 'process raft request' (duration: 152.252938ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:25.855305Z","caller":"traceutil/trace.go:171","msg":"trace[1283313440] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"138.378536ms","start":"2026-05-14T11:14:25.7169Z","end":"2026-05-14T11:14:25.855279Z","steps":["trace[1283313440] 'process raft request' (duration: 138.204452ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:26.765218Z","caller":"traceutil/trace.go:171","msg":"trace[1479271884] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"157.248412ms","start":"2026-05-14T11:14:26.607947Z","end":"2026-05-14T11:14:26.765196Z","steps":["trace[1479271884] 'process raft request' (duration: 157.110448ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:27.680178Z","caller":"traceutil/trace.go:171","msg":"trace[1581466226] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"354.383317ms","start":"2026-05-14T11:14:27.325771Z","end":"2026-05-14T11:14:27.680154Z","steps":["trace[1581466226] 'process raft request' (duration: 354.250453ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T11:14:27.680331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T11:14:27.325763Z","time spent":"354.48704ms","remote":"127.0.0.1:51362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T11:14:28.476266Z","caller":"traceutil/trace.go:171","msg":"trace[1002745652] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"152.592658ms","start":"2026-05-14T11:14:28.32365Z","end":"2026-05-14T11:14:28.476243Z","steps":["trace[1002745652] 'process raft request' (duration: 152.460435ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:39.584077Z","caller":"traceutil/trace.go:171","msg":"trace[164515269] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"176.378135ms","start":"2026-05-14T11:14:39.407678Z","end":"2026-05-14T11:14:39.584056Z","steps":["trace[164515269] 'process raft request' (duration: 176.247101ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T11:14:41.237677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.799188ms","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-05-14T11:14:41.237734Z","caller":"traceutil/trace.go:171","msg":"trace[37873802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1149; }","duration":"246.900761ms","start":"2026-05-14T11:14:40.990823Z","end":"2026-05-14T11:14:41.237723Z","steps":["trace[37873802] 'range keys from in-memory index tree' (duration: 246.665855ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:57.775873Z","caller":"traceutil/trace.go:171","msg":"trace[745830529] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"310.663278ms","start":"2026-05-14T11:14:57.45809Z","end":"2026-05-14T11:14:57.768753Z","steps":["trace[745830529] 'process raft request' (duration: 254.275804ms)","trace[745830529] 'compare' (duration: 56.104146ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T11:14:57.776085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T11:14:57.458076Z","time spent":"317.910657ms","remote":"127.0.0.1:51288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11375,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T11:14:57.975988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.388751ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-14T11:14:57.976203Z","caller":"traceutil/trace.go:171","msg":"trace[830297304] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"200.568006ms","start":"2026-05-14T11:14:57.775619Z","end":"2026-05-14T11:14:57.976187Z","steps":["trace[830297304] 'process raft request' (duration: 200.468953ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:57.976268Z","caller":"traceutil/trace.go:171","msg":"trace[941247437] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1267; }","duration":"303.84365ms","start":"2026-05-14T11:14:57.672389Z","end":"2026-05-14T11:14:57.976232Z","steps":["trace[941247437] 'read index received' (duration: 39.994571ms)","trace[941247437] 'applied index is now lower than readState.Index' (duration: 263.843789ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T11:14:57.976554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.15409ms","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-14T11:14:57.976635Z","caller":"traceutil/trace.go:171","msg":"trace[38865809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1222; }","duration":"304.291694ms","start":"2026-05-14T11:14:57.672331Z","end":"2026-05-14T11:14:57.976623Z","steps":["trace[38865809] 'agreement among raft nodes before linearized reading' (duration: 304.038566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T11:14:57.976674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T11:14:57.672287Z","time spent":"304.378087ms","remote":"127.0.0.1:51362","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-14T11:14:58.028629Z","caller":"traceutil/trace.go:171","msg":"trace[1717097117] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"246.822519ms","start":"2026-05-14T11:14:57.781775Z","end":"2026-05-14T11:14:58.028598Z","steps":["trace[1717097117] 'process raft request' (duration: 246.685855ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:58.029198Z","caller":"traceutil/trace.go:171","msg":"trace[88646403] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"252.79626ms","start":"2026-05-14T11:14:57.776386Z","end":"2026-05-14T11:14:58.029182Z","steps":["trace[88646403] 'process raft request' (duration: 251.955206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T11:14:58.029691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.053424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T11:14:58.029749Z","caller":"traceutil/trace.go:171","msg":"trace[613351843] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1224; }","duration":"164.154707ms","start":"2026-05-14T11:14:57.865577Z","end":"2026-05-14T11:14:58.029732Z","steps":["trace[613351843] 'agreement among raft nodes before linearized reading' (duration: 164.061584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T11:14:58.029811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.062091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-14T11:14:58.029867Z","caller":"traceutil/trace.go:171","msg":"trace[2090256368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1224; }","duration":"209.144704ms","start":"2026-05-14T11:14:57.820705Z","end":"2026-05-14T11:14:58.02985Z","steps":["trace[2090256368] 'agreement among raft nodes before linearized reading' (duration: 208.970908ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:58.138931Z","caller":"traceutil/trace.go:171","msg":"trace[215241647] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"100.228616ms","start":"2026-05-14T11:14:58.038675Z","end":"2026-05-14T11:14:58.138904Z","steps":["trace[215241647] 'process raft request' (duration: 52.708437ms)","trace[215241647] 'compare' (duration: 47.342054ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T11:14:59.318447Z","caller":"traceutil/trace.go:171","msg":"trace[1803694447] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"158.373951ms","start":"2026-05-14T11:14:59.160039Z","end":"2026-05-14T11:14:59.318413Z","steps":["trace[1803694447] 'process raft request' (duration: 67.568405ms)","trace[1803694447] 'compare' (duration: 90.577159ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T11:14:59.497651Z","caller":"traceutil/trace.go:171","msg":"trace[338503698] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"171.281074ms","start":"2026-05-14T11:14:59.32635Z","end":"2026-05-14T11:14:59.497631Z","steps":["trace[338503698] 'process raft request' (duration: 160.436742ms)","trace[338503698] 'compare' (duration: 10.714088ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T11:14:59.497807Z","caller":"traceutil/trace.go:171","msg":"trace[2051648435] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"160.277767ms","start":"2026-05-14T11:14:59.337522Z","end":"2026-05-14T11:14:59.4978Z","steps":["trace[2051648435] 'process raft request' (duration: 160.07011ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T11:14:59.497819Z","caller":"traceutil/trace.go:171","msg":"trace[1822934992] linearizableReadLoop","detail":"{readStateIndex:1283; appliedIndex:1281; }","duration":"119.250636ms","start":"2026-05-14T11:14:59.378525Z","end":"2026-05-14T11:14:59.497776Z","steps":["trace[1822934992] 'read index received' (duration: 108.245109ms)","trace[1822934992] 'applied index is now lower than readState.Index' (duration: 11.002757ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T11:14:59.498229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.695018ms","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-05-14T11:14:59.498272Z","caller":"traceutil/trace.go:171","msg":"trace[2002831290] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1235; }","duration":"119.795571ms","start":"2026-05-14T11:14:59.378468Z","end":"2026-05-14T11:14:59.498264Z","steps":["trace[2002831290] 'agreement among raft nodes before linearized reading' (duration: 119.41787ms)"],"step_count":1}