{"level":"warn","ts":"2026-05-29T05:50:16.374881Z","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-29T05:50:16.374994Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23: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.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-29T05:50:16.375142Z","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-29T05:50:16.375159Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-05-29T05:50:16.375216Z","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-29T05:50:16.375911Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-05-29T05:50:16.376003Z","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.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-29T05:50:16.380653Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.406649ms"} {"level":"info","ts":"2026-05-29T05:50:16.387045Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-05-29T05:50:16.387171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-05-29T05:50:16.387201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-05-29T05:50:16.387212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-29T05:50:16.38723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-05-29T05:50:16.387292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-05-29T05:50:16.392823Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-29T05:50:16.394637Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-29T05:50:16.396002Z","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-29T05:50:16.399266Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-29T05:50:16.400279Z","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-29T05:50:16.400391Z","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-29T05:50:16.400413Z","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-29T05:50:16.400553Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-29T05:50:16.401332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-05-29T05:50:16.4015Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-05-29T05:50:16.407439Z","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-29T05:50:16.407575Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-05-29T05:50:16.4076Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-05-29T05:50:16.407672Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-29T05:50:16.407712Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-29T05:50:16.688108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-05-29T05:50:16.688189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-29T05:50:16.688241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-05-29T05:50:16.688264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-05-29T05:50:16.688281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-05-29T05:50:16.688302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-05-29T05:50:16.688322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-05-29T05:50:16.68907Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:50:16.689811Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T05:50:16.689803Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-05-29T05:50:16.689932Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T05:50:16.690349Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-29T05:50:16.690451Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-29T05:50:16.692924Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-05-29T05:50:16.693705Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:50:16.694369Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:50:16.694395Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:50:16.694089Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-29T05:50:18.818677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.581546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-29T05:50:18.819027Z","caller":"traceutil/trace.go:171","msg":"trace[278157348] linearizableReadLoop","detail":"{readStateIndex:22; appliedIndex:15; }","duration":"544.571776ms","start":"2026-05-29T05:50:18.274435Z","end":"2026-05-29T05:50:18.819007Z","steps":["trace[278157348] 'read index received' (duration: 178.105752ms)","trace[278157348] 'applied index is now lower than readState.Index' (duration: 366.465194ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:50:18.819103Z","caller":"traceutil/trace.go:171","msg":"trace[1361490163] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"605.126978ms","start":"2026-05-29T05:50:18.213967Z","end":"2026-05-29T05:50:18.819094Z","steps":["trace[1361490163] 'process raft request' (duration: 604.960994ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:18.81909Z","caller":"traceutil/trace.go:171","msg":"trace[410341779] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"605.104277ms","start":"2026-05-29T05:50:18.213963Z","end":"2026-05-29T05:50:18.819067Z","steps":["trace[410341779] 'process raft request' (duration: 604.925633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.819164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.213944Z","time spent":"605.193299ms","remote":"127.0.0.1:43248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:50:18.819242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.213943Z","time spent":"605.21619ms","remote":"127.0.0.1:43156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:50:18.819393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.73103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-29T05:50:18.819514Z","caller":"traceutil/trace.go:171","msg":"trace[122090571] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:18; }","duration":"598.883532ms","start":"2026-05-29T05:50:18.220598Z","end":"2026-05-29T05:50:18.819481Z","steps":["trace[122090571] 'agreement among raft nodes before linearized reading' (duration: 598.599997ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.819573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.22059Z","time spent":"598.970844ms","remote":"127.0.0.1:42820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-29T05:50:18.819597Z","caller":"traceutil/trace.go:171","msg":"trace[1809405515] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"605.586486ms","start":"2026-05-29T05:50:18.214Z","end":"2026-05-29T05:50:18.819586Z","steps":["trace[1809405515] 'process raft request' (duration: 604.949914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.819649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.21397Z","time spent":"605.656928ms","remote":"127.0.0.1:43248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:50:18.819412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.634179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-st97d\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-05-29T05:50:18.819696Z","caller":"traceutil/trace.go:171","msg":"trace[736594542] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"605.067676ms","start":"2026-05-29T05:50:18.214614Z","end":"2026-05-29T05:50:18.819682Z","steps":["trace[736594542] 'process raft request' (duration: 604.358792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.819775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.214606Z","time spent":"605.139888ms","remote":"127.0.0.1:43248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:50:18.819785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.220246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T05:50:18.819817Z","caller":"traceutil/trace.go:171","msg":"trace[2129970285] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:18; }","duration":"579.291677ms","start":"2026-05-29T05:50:18.240515Z","end":"2026-05-29T05:50:18.819807Z","steps":["trace[2129970285] 'agreement among raft nodes before linearized reading' (duration: 578.591223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.819843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.240502Z","time spent":"579.336828ms","remote":"127.0.0.1:42820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"info","ts":"2026-05-29T05:50:18.819705Z","caller":"traceutil/trace.go:171","msg":"trace[2089981313] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-st97d; range_end:; response_count:1; response_revision:18; }","duration":"606.946704ms","start":"2026-05-29T05:50:18.212742Z","end":"2026-05-29T05:50:18.819688Z","steps":["trace[2089981313] 'agreement among raft nodes before linearized reading' (duration: 606.498435ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:18.819813Z","caller":"traceutil/trace.go:171","msg":"trace[1140386533] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"607.118708ms","start":"2026-05-29T05:50:18.212562Z","end":"2026-05-29T05:50:18.81968Z","steps":["trace[1140386533] 'process raft request' (duration: 240.058313ms)","trace[1140386533] 'compare' (duration: 365.406202ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:50:18.818943Z","caller":"traceutil/trace.go:171","msg":"trace[677526182] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"606.346683ms","start":"2026-05-29T05:50:18.212564Z","end":"2026-05-29T05:50:18.81891Z","steps":["trace[677526182] 'process raft request' (duration: 606.232661ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:18.819437Z","caller":"traceutil/trace.go:171","msg":"trace[971212548] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"605.573196ms","start":"2026-05-29T05:50:18.213806Z","end":"2026-05-29T05:50:18.819379Z","steps":["trace[971212548] 'process raft request' (duration: 605.023195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.819886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.212732Z","time spent":"607.139139ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":880,"request content":"key:\"/registry/certificatesigningrequests/csr-st97d\" "} {"level":"warn","ts":"2026-05-29T05:50:18.819986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.212536Z","time spent":"607.426505ms","remote":"127.0.0.1:42820","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:50:18.820297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.213795Z","time spent":"606.419374ms","remote":"127.0.0.1:43248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:50:18.820086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.212534Z","time spent":"607.431535ms","remote":"127.0.0.1:42820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T05:50:18.941175Z","caller":"traceutil/trace.go:171","msg":"trace[1177856276] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"114.682624ms","start":"2026-05-29T05:50:18.826473Z","end":"2026-05-29T05:50:18.941156Z","steps":["trace[1177856276] 'process raft request' (duration: 114.658663ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:18.941424Z","caller":"traceutil/trace.go:171","msg":"trace[937007560] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"118.805677ms","start":"2026-05-29T05:50:18.822576Z","end":"2026-05-29T05:50:18.941382Z","steps":["trace[937007560] 'process raft request' (duration: 118.428829ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:18.941556Z","caller":"traceutil/trace.go:171","msg":"trace[208325801] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"116.270927ms","start":"2026-05-29T05:50:18.825181Z","end":"2026-05-29T05:50:18.941452Z","steps":["trace[208325801] 'process raft request' (duration: 115.851857ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:18.941649Z","caller":"traceutil/trace.go:171","msg":"trace[1448009999] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"115.257265ms","start":"2026-05-29T05:50:18.826384Z","end":"2026-05-29T05:50:18.941642Z","steps":["trace[1448009999] 'process raft request' (duration: 114.726054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.941692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.384494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-05-29T05:50:18.941654Z","caller":"traceutil/trace.go:171","msg":"trace[405377045] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"663.19517ms","start":"2026-05-29T05:50:18.278426Z","end":"2026-05-29T05:50:18.941621Z","steps":["trace[405377045] 'process raft request' (duration: 641.872429ms)","trace[405377045] 'compare' (duration: 20.462603ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:50:18.941825Z","caller":"traceutil/trace.go:171","msg":"trace[2092279947] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:22; }","duration":"122.469731ms","start":"2026-05-29T05:50:18.819063Z","end":"2026-05-29T05:50:18.941533Z","steps":["trace[2092279947] 'read index received' (duration: 101.248893ms)","trace[2092279947] 'applied index is now lower than readState.Index' (duration: 21.217898ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:50:18.941874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.463072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-29T05:50:18.941905Z","caller":"traceutil/trace.go:171","msg":"trace[24357444] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:26; }","duration":"298.559403ms","start":"2026-05-29T05:50:18.643338Z","end":"2026-05-29T05:50:18.941897Z","steps":["trace[24357444] 'agreement among raft nodes before linearized reading' (duration: 298.474112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.942008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.278409Z","time spent":"663.418744ms","remote":"127.0.0.1:43248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:50:18.942141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.807388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-29T05:50:18.942168Z","caller":"traceutil/trace.go:171","msg":"trace[1808071447] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"116.149124ms","start":"2026-05-29T05:50:18.825975Z","end":"2026-05-29T05:50:18.942124Z","steps":["trace[1808071447] 'process raft request' (duration: 115.084992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.942194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.712817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T05:50:18.942207Z","caller":"traceutil/trace.go:171","msg":"trace[1215399904] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:26; }","duration":"118.912329ms","start":"2026-05-29T05:50:18.823277Z","end":"2026-05-29T05:50:18.942189Z","steps":["trace[1215399904] 'agreement among raft nodes before linearized reading' (duration: 118.803127ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:50:18.94224Z","caller":"traceutil/trace.go:171","msg":"trace[1540180893] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:26; }","duration":"587.788089ms","start":"2026-05-29T05:50:18.354436Z","end":"2026-05-29T05:50:18.942224Z","steps":["trace[1540180893] 'agreement among raft nodes before linearized reading' (duration: 587.721557ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.942297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.35442Z","time spent":"587.86679ms","remote":"127.0.0.1:42972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-05-29T05:50:18.94179Z","caller":"traceutil/trace.go:171","msg":"trace[1841467805] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26; }","duration":"662.571687ms","start":"2026-05-29T05:50:18.279197Z","end":"2026-05-29T05:50:18.941769Z","steps":["trace[1841467805] 'agreement among raft nodes before linearized reading' (duration: 662.348642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.942418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.279167Z","time spent":"663.21573ms","remote":"127.0.0.1:42884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3513,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-05-29T05:50:18.941658Z","caller":"traceutil/trace.go:171","msg":"trace[531782539] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"655.834011ms","start":"2026-05-29T05:50:18.285675Z","end":"2026-05-29T05:50:18.941509Z","steps":["trace[531782539] 'process raft request' (duration: 655.254038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.942615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.364368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T05:50:18.942694Z","caller":"traceutil/trace.go:171","msg":"trace[765741582] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:26; }","duration":"117.46282ms","start":"2026-05-29T05:50:18.825213Z","end":"2026-05-29T05:50:18.942675Z","steps":["trace[765741582] 'agreement among raft nodes before linearized reading' (duration: 117.364128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:50:18.942886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:50:18.285658Z","time spent":"656.932273ms","remote":"127.0.0.1:42884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T05:50:18.943078Z","caller":"traceutil/trace.go:171","msg":"trace[1680807906] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"117.084512ms","start":"2026-05-29T05:50:18.82598Z","end":"2026-05-29T05:50:18.943065Z","steps":["trace[1680807906] 'process raft request' (duration: 115.111672ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:00.808715Z","caller":"traceutil/trace.go:171","msg":"trace[1667943527] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"289.637606ms","start":"2026-05-29T05:51:00.51905Z","end":"2026-05-29T05:51:00.808687Z","steps":["trace[1667943527] 'read index received' (duration: 288.737608ms)","trace[1667943527] 'applied index is now lower than readState.Index' (duration: 899.128µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:51:00.808753Z","caller":"traceutil/trace.go:171","msg":"trace[1817931366] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"354.335468ms","start":"2026-05-29T05:51:00.454395Z","end":"2026-05-29T05:51:00.808731Z","steps":["trace[1817931366] 'process raft request' (duration: 353.564802ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:51:00.808902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:51:00.454361Z","time spent":"354.44742ms","remote":"127.0.0.1:42802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:51:00.80904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.5288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zbv4p\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-05-29T05:51:00.809074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.027964ms","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-29T05:51:00.809117Z","caller":"traceutil/trace.go:171","msg":"trace[1403734691] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zbv4p; range_end:; response_count:1; response_revision:634; }","duration":"274.626082ms","start":"2026-05-29T05:51:00.53447Z","end":"2026-05-29T05:51:00.809096Z","steps":["trace[1403734691] 'agreement among raft nodes before linearized reading' (duration: 274.490149ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:00.809109Z","caller":"traceutil/trace.go:171","msg":"trace[1013417104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"290.065485ms","start":"2026-05-29T05:51:00.519034Z","end":"2026-05-29T05:51:00.8091Z","steps":["trace[1013417104] 'agreement among raft nodes before linearized reading' (duration: 289.775149ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:51:50.108277Z","caller":"traceutil/trace.go:171","msg":"trace[1677725469] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"102.355863ms","start":"2026-05-29T05:51:50.005893Z","end":"2026-05-29T05:51:50.108249Z","steps":["trace[1677725469] 'process raft request' (duration: 102.123458ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:16.044038Z","caller":"traceutil/trace.go:171","msg":"trace[707937786] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"144.631917ms","start":"2026-05-29T05:52:15.899367Z","end":"2026-05-29T05:52:16.043999Z","steps":["trace[707937786] 'process raft request' (duration: 144.450573ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:31.833989Z","caller":"traceutil/trace.go:171","msg":"trace[389628982] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"169.636153ms","start":"2026-05-29T05:52:31.664323Z","end":"2026-05-29T05:52:31.833959Z","steps":["trace[389628982] 'process raft request' (duration: 169.304546ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:31.833988Z","caller":"traceutil/trace.go:171","msg":"trace[1857325994] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1243; }","duration":"150.977596ms","start":"2026-05-29T05:52:31.682967Z","end":"2026-05-29T05:52:31.833944Z","steps":["trace[1857325994] 'read index received' (duration: 150.494196ms)","trace[1857325994] 'applied index is now lower than readState.Index' (duration: 470.85µs)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:52:31.83422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.217421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:52:31.834319Z","caller":"traceutil/trace.go:171","msg":"trace[590211340] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1196; }","duration":"151.335544ms","start":"2026-05-29T05:52:31.68296Z","end":"2026-05-29T05:52:31.834295Z","steps":["trace[590211340] 'agreement among raft nodes before linearized reading' (duration: 151.14663ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:47.706055Z","caller":"traceutil/trace.go:171","msg":"trace[792671448] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1304; }","duration":"214.537463ms","start":"2026-05-29T05:52:47.491485Z","end":"2026-05-29T05:52:47.706023Z","steps":["trace[792671448] 'read index received' (duration: 214.159096ms)","trace[792671448] 'applied index is now lower than readState.Index' (duration: 377.017µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:52:47.706237Z","caller":"traceutil/trace.go:171","msg":"trace[379817988] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"215.228776ms","start":"2026-05-29T05:52:47.490959Z","end":"2026-05-29T05:52:47.706188Z","steps":["trace[379817988] 'process raft request' (duration: 214.828028ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:47.706413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.88861ms","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-29T05:52:47.706459Z","caller":"traceutil/trace.go:171","msg":"trace[1613894015] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1254; }","duration":"215.017912ms","start":"2026-05-29T05:52:47.491426Z","end":"2026-05-29T05:52:47.706444Z","steps":["trace[1613894015] 'agreement among raft nodes before linearized reading' (duration: 214.799318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:52:47.706715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.406193ms","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-29T05:52:47.706762Z","caller":"traceutil/trace.go:171","msg":"trace[1756944356] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1254; }","duration":"105.511866ms","start":"2026-05-29T05:52:47.601236Z","end":"2026-05-29T05:52:47.706748Z","steps":["trace[1756944356] 'agreement among raft nodes before linearized reading' (duration: 105.24263ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:47.816234Z","caller":"traceutil/trace.go:171","msg":"trace[1261923377] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"102.743189ms","start":"2026-05-29T05:52:47.71348Z","end":"2026-05-29T05:52:47.816223Z","steps":["trace[1261923377] 'process raft request' (duration: 102.571575ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:47.816154Z","caller":"traceutil/trace.go:171","msg":"trace[1331980901] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"104.051746ms","start":"2026-05-29T05:52:47.712035Z","end":"2026-05-29T05:52:47.816086Z","steps":["trace[1331980901] 'process raft request' (duration: 101.021674ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:48.737828Z","caller":"traceutil/trace.go:171","msg":"trace[1830988139] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"233.866633ms","start":"2026-05-29T05:52:48.503914Z","end":"2026-05-29T05:52:48.73778Z","steps":["trace[1830988139] 'process raft request' (duration: 233.419095ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:49.226889Z","caller":"traceutil/trace.go:171","msg":"trace[765241095] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"151.923765ms","start":"2026-05-29T05:52:49.074908Z","end":"2026-05-29T05:52:49.226831Z","steps":["trace[765241095] 'process raft request' (duration: 151.725901ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:52:49.415712Z","caller":"traceutil/trace.go:171","msg":"trace[1266014860] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"183.902662ms","start":"2026-05-29T05:52:49.231786Z","end":"2026-05-29T05:52:49.415688Z","steps":["trace[1266014860] 'process raft request' (duration: 177.046504ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:53:02.947433Z","caller":"traceutil/trace.go:171","msg":"trace[2009651960] linearizableReadLoop","detail":"{readStateIndex:1422; appliedIndex:1421; }","duration":"136.303836ms","start":"2026-05-29T05:53:02.811095Z","end":"2026-05-29T05:53:02.947399Z","steps":["trace[2009651960] 'read index received' (duration: 135.906477ms)","trace[2009651960] 'applied index is now lower than readState.Index' (duration: 395.789µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:53:02.94755Z","caller":"traceutil/trace.go:171","msg":"trace[844227431] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"159.441205ms","start":"2026-05-29T05:53:02.788016Z","end":"2026-05-29T05:53:02.947457Z","steps":["trace[844227431] 'process raft request' (duration: 159.16663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:02.947743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.623472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-29T05:53:02.947787Z","caller":"traceutil/trace.go:171","msg":"trace[150643130] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1368; }","duration":"136.748005ms","start":"2026-05-29T05:53:02.811025Z","end":"2026-05-29T05:53:02.947773Z","steps":["trace[150643130] 'agreement among raft nodes before linearized reading' (duration: 136.540821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:53:03.299233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.907306ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:53:03.300176Z","caller":"traceutil/trace.go:171","msg":"trace[671100602] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"322.582457ms","start":"2026-05-29T05:53:02.977551Z","end":"2026-05-29T05:53:03.300134Z","steps":["trace[671100602] 'process raft request' (duration: 193.240842ms)","trace[671100602] 'compare' (duration: 127.764753ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:53:03.300326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:53:02.977523Z","time spent":"322.71462ms","remote":"127.0.0.1:42972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}