{"level":"warn","ts":"2026-04-15T07:06:22.167485Z","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-15T07:06:22.167556Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.221: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://162.253.55.221:2380","--initial-cluster=instance=https://162.253.55.221:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.221:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.221: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-15T07:06:22.16761Z","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-15T07:06:22.167622Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.221:2380"]} {"level":"info","ts":"2026-04-15T07:06:22.167639Z","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-15T07:06:22.168273Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.221:2379"]} {"level":"info","ts":"2026-04-15T07:06:22.168347Z","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://162.253.55.221:2380"],"listen-peer-urls":["https://162.253.55.221:2380"],"advertise-client-urls":["https://162.253.55.221:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.221:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.221: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-15T07:06:22.172594Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.066581ms"} {"level":"info","ts":"2026-04-15T07:06:22.180389Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c187bdee547e8fd1","cluster-id":"ee7528b898b8b18e"} {"level":"info","ts":"2026-04-15T07:06:22.180451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-15T07:06:22.18047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became follower at term 0"} {"level":"info","ts":"2026-04-15T07:06:22.180484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c187bdee547e8fd1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-15T07:06:22.180492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became follower at term 1"} {"level":"info","ts":"2026-04-15T07:06:22.180523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 switched to configuration voters=(13945323602493476817)"} {"level":"warn","ts":"2026-04-15T07:06:22.190707Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-15T07:06:22.193828Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-15T07:06:22.195461Z","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-15T07:06:22.19794Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c187bdee547e8fd1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-15T07:06:22.198116Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c187bdee547e8fd1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-15T07:06:22.198254Z","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-15T07:06:22.198362Z","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-15T07:06:22.198437Z","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-15T07:06:22.200547Z","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-15T07:06:22.200739Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c187bdee547e8fd1","initial-advertise-peer-urls":["https://162.253.55.221:2380"],"listen-peer-urls":["https://162.253.55.221:2380"],"advertise-client-urls":["https://162.253.55.221:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.221:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-15T07:06:22.200767Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-15T07:06:22.200798Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.221:2380"} {"level":"info","ts":"2026-04-15T07:06:22.200845Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.221:2380"} {"level":"info","ts":"2026-04-15T07:06:22.202721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 switched to configuration voters=(13945323602493476817)"} {"level":"info","ts":"2026-04-15T07:06:22.202824Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ee7528b898b8b18e","local-member-id":"c187bdee547e8fd1","added-peer-id":"c187bdee547e8fd1","added-peer-peer-urls":["https://162.253.55.221:2380"]} {"level":"info","ts":"2026-04-15T07:06:22.281474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-15T07:06:22.281541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-15T07:06:22.281576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 received MsgPreVoteResp from c187bdee547e8fd1 at term 1"} {"level":"info","ts":"2026-04-15T07:06:22.281593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became candidate at term 2"} {"level":"info","ts":"2026-04-15T07:06:22.28164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 received MsgVoteResp from c187bdee547e8fd1 at term 2"} {"level":"info","ts":"2026-04-15T07:06:22.281655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c187bdee547e8fd1 became leader at term 2"} {"level":"info","ts":"2026-04-15T07:06:22.281673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c187bdee547e8fd1 elected leader c187bdee547e8fd1 at term 2"} {"level":"info","ts":"2026-04-15T07:06:22.282507Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:06:22.283168Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T07:06:22.283265Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T07:06:22.283161Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c187bdee547e8fd1","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.221:2379]}","request-path":"/0/members/c187bdee547e8fd1/attributes","cluster-id":"ee7528b898b8b18e","publish-timeout":"7s"} {"level":"info","ts":"2026-04-15T07:06:22.283662Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-15T07:06:22.283947Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-15T07:06:22.284401Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ee7528b898b8b18e","local-member-id":"c187bdee547e8fd1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:06:22.28493Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:06:22.284986Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T07:06:22.28644Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.221:2379"} {"level":"info","ts":"2026-04-15T07:06:22.287008Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-15T07:06:28.48937Z","caller":"traceutil/trace.go:171","msg":"trace[17067423] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:301; }","duration":"218.425532ms","start":"2026-04-15T07:06:28.270924Z","end":"2026-04-15T07:06:28.48935Z","steps":["trace[17067423] 'read index received' (duration: 218.32651ms)","trace[17067423] 'applied index is now lower than readState.Index' (duration: 98.332µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:06:28.489469Z","caller":"traceutil/trace.go:171","msg":"trace[1341721195] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"235.558354ms","start":"2026-04-15T07:06:28.253857Z","end":"2026-04-15T07:06:28.489415Z","steps":["trace[1341721195] 'process raft request' (duration: 235.36042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:06:28.489535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.589086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:06:28.48966Z","caller":"traceutil/trace.go:171","msg":"trace[1322551515] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:292; }","duration":"218.769841ms","start":"2026-04-15T07:06:28.270868Z","end":"2026-04-15T07:06:28.489638Z","steps":["trace[1322551515] 'agreement among raft nodes before linearized reading' (duration: 218.576486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:06:28.877862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.052854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T07:06:28.877932Z","caller":"traceutil/trace.go:171","msg":"trace[1076740149] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"384.075877ms","start":"2026-04-15T07:06:28.493845Z","end":"2026-04-15T07:06:28.877921Z","steps":["trace[1076740149] 'process raft request' (duration: 98.699855ms)","trace[1076740149] 'compare' (duration: 284.971672ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:06:28.877962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:06:28.493826Z","time spent":"384.124437ms","remote":"127.0.0.1:36948","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-15T07:06:28.885917Z","caller":"traceutil/trace.go:171","msg":"trace[148933072] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"391.699846ms","start":"2026-04-15T07:06:28.494192Z","end":"2026-04-15T07:06:28.885892Z","steps":["trace[148933072] 'process raft request' (duration: 391.530252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:06:28.88617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:06:28.494157Z","time spent":"391.825738ms","remote":"127.0.0.1:36948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T07:06:28.88619Z","caller":"traceutil/trace.go:171","msg":"trace[3886776] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"386.446103ms","start":"2026-04-15T07:06:28.499729Z","end":"2026-04-15T07:06:28.886175Z","steps":["trace[3886776] 'process raft request' (duration: 386.092434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:06:28.886499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:06:28.49971Z","time spent":"386.518094ms","remote":"127.0.0.1:36886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4119,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T07:06:48.594534Z","caller":"traceutil/trace.go:171","msg":"trace[1020154000] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"112.830176ms","start":"2026-04-15T07:06:48.48167Z","end":"2026-04-15T07:06:48.5945Z","steps":["trace[1020154000] 'process raft request' (duration: 112.699023ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:06:48.594604Z","caller":"traceutil/trace.go:171","msg":"trace[1415275499] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"103.340659ms","start":"2026-04-15T07:06:48.491227Z","end":"2026-04-15T07:06:48.594568Z","steps":["trace[1415275499] 'process raft request' (duration: 103.215416ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:06:54.83144Z","caller":"traceutil/trace.go:171","msg":"trace[790444815] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"130.641049ms","start":"2026-04-15T07:06:54.700759Z","end":"2026-04-15T07:06:54.8314Z","steps":["trace[790444815] 'process raft request' (duration: 129.812062ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:06:55.134483Z","caller":"traceutil/trace.go:171","msg":"trace[1707669923] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"118.82861ms","start":"2026-04-15T07:06:55.015637Z","end":"2026-04-15T07:06:55.134466Z","steps":["trace[1707669923] 'read index received' (duration: 105.085434ms)","trace[1707669923] 'applied index is now lower than readState.Index' (duration: 13.742376ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:06:55.134515Z","caller":"traceutil/trace.go:171","msg":"trace[1771904240] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"227.3528ms","start":"2026-04-15T07:06:54.907125Z","end":"2026-04-15T07:06:55.134477Z","steps":["trace[1771904240] 'process raft request' (duration: 213.621913ms)","trace[1771904240] 'compare' (duration: 13.468992ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:06:55.134642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.942349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-15T07:06:55.134643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.006813ms","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-15T07:06:55.134661Z","caller":"traceutil/trace.go:171","msg":"trace[11732323] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:606; }","duration":"113.01182ms","start":"2026-04-15T07:06:55.021643Z","end":"2026-04-15T07:06:55.134655Z","steps":["trace[11732323] 'agreement among raft nodes before linearized reading' (duration: 112.918438ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:06:55.134699Z","caller":"traceutil/trace.go:171","msg":"trace[1470788580] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:606; }","duration":"119.045504ms","start":"2026-04-15T07:06:55.01562Z","end":"2026-04-15T07:06:55.134665Z","steps":["trace[1470788580] 'agreement among raft nodes before linearized reading' (duration: 118.913972ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:06:55.316079Z","caller":"traceutil/trace.go:171","msg":"trace[1529840130] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:622; }","duration":"172.428611ms","start":"2026-04-15T07:06:55.143628Z","end":"2026-04-15T07:06:55.316057Z","steps":["trace[1529840130] 'read index received' (duration: 131.856863ms)","trace[1529840130] 'applied index is now lower than readState.Index' (duration: 40.570878ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:06:55.316172Z","caller":"traceutil/trace.go:171","msg":"trace[45653816] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"175.02792ms","start":"2026-04-15T07:06:55.141111Z","end":"2026-04-15T07:06:55.316139Z","steps":["trace[45653816] 'process raft request' (duration: 134.35347ms)","trace[45653816] 'compare' (duration: 40.409505ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:06:55.316589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.93992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:06:55.316725Z","caller":"traceutil/trace.go:171","msg":"trace[168579293] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:608; }","duration":"173.067913ms","start":"2026-04-15T07:06:55.14358Z","end":"2026-04-15T07:06:55.316648Z","steps":["trace[168579293] 'agreement among raft nodes before linearized reading' (duration: 172.662906ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:06:55.316897Z","caller":"traceutil/trace.go:171","msg":"trace[199988197] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"175.396596ms","start":"2026-04-15T07:06:55.141484Z","end":"2026-04-15T07:06:55.316881Z","steps":["trace[199988197] 'process raft request' (duration: 174.537641ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:06:56.531789Z","caller":"traceutil/trace.go:171","msg":"trace[1445857516] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"100.944111ms","start":"2026-04-15T07:06:56.430818Z","end":"2026-04-15T07:06:56.531762Z","steps":["trace[1445857516] 'process raft request' (duration: 91.298492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:06:56.54336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.972067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T07:06:56.543565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.888493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:06:56.543629Z","caller":"traceutil/trace.go:171","msg":"trace[1894392920] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:632; }","duration":"106.012035ms","start":"2026-04-15T07:06:56.437604Z","end":"2026-04-15T07:06:56.543616Z","steps":["trace[1894392920] 'agreement among raft nodes before linearized reading' (duration: 105.878153ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:06:56.543636Z","caller":"traceutil/trace.go:171","msg":"trace[774783446] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"110.145563ms","start":"2026-04-15T07:06:56.433446Z","end":"2026-04-15T07:06:56.543592Z","steps":["trace[774783446] 'process raft request' (duration: 109.605613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:06:56.54374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.861528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:06:56.543821Z","caller":"traceutil/trace.go:171","msg":"trace[682012763] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:632; }","duration":"108.96147ms","start":"2026-04-15T07:06:56.43484Z","end":"2026-04-15T07:06:56.543801Z","steps":["trace[682012763] 'agreement among raft nodes before linearized reading' (duration: 108.820097ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:06:56.543773Z","caller":"traceutil/trace.go:171","msg":"trace[437765920] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"108.051673ms","start":"2026-04-15T07:06:56.435713Z","end":"2026-04-15T07:06:56.543764Z","steps":["trace[437765920] 'process raft request' (duration: 107.476903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:06:56.543882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.895853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:06:56.543928Z","caller":"traceutil/trace.go:171","msg":"trace[565477089] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:632; }","duration":"105.949994ms","start":"2026-04-15T07:06:56.437968Z","end":"2026-04-15T07:06:56.543918Z","steps":["trace[565477089] 'agreement among raft nodes before linearized reading' (duration: 105.451065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:06:56.544061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.868653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:06:56.544132Z","caller":"traceutil/trace.go:171","msg":"trace[79061900] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:632; }","duration":"111.13617ms","start":"2026-04-15T07:06:56.432306Z","end":"2026-04-15T07:06:56.543442Z","steps":["trace[79061900] 'agreement among raft nodes before linearized reading' (duration: 110.945167ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:06:56.545814Z","caller":"traceutil/trace.go:171","msg":"trace[42758497] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:632; }","duration":"106.24254ms","start":"2026-04-15T07:06:56.437935Z","end":"2026-04-15T07:06:56.544178Z","steps":["trace[42758497] 'agreement among raft nodes before linearized reading' (duration: 105.69037ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:07:10.562004Z","caller":"traceutil/trace.go:171","msg":"trace[892509611] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:793; }","duration":"114.680804ms","start":"2026-04-15T07:07:10.447308Z","end":"2026-04-15T07:07:10.561988Z","steps":["trace[892509611] 'read index received' (duration: 114.525111ms)","trace[892509611] 'applied index is now lower than readState.Index' (duration: 154.893µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:07:10.562115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.799827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:07:10.562136Z","caller":"traceutil/trace.go:171","msg":"trace[1129580716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:774; }","duration":"114.853777ms","start":"2026-04-15T07:07:10.447276Z","end":"2026-04-15T07:07:10.56213Z","steps":["trace[1129580716] 'agreement among raft nodes before linearized reading' (duration: 114.786726ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:07:10.562374Z","caller":"traceutil/trace.go:171","msg":"trace[1085583716] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"144.654557ms","start":"2026-04-15T07:07:10.417677Z","end":"2026-04-15T07:07:10.562332Z","steps":["trace[1085583716] 'process raft request' (duration: 144.20094ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:07:10.757921Z","caller":"traceutil/trace.go:171","msg":"trace[1370223076] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"164.579792ms","start":"2026-04-15T07:07:10.593314Z","end":"2026-04-15T07:07:10.757894Z","steps":["trace[1370223076] 'process raft request' (duration: 164.296088ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:08:32.99045Z","caller":"traceutil/trace.go:171","msg":"trace[1994993546] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"221.078667ms","start":"2026-04-15T07:08:32.769333Z","end":"2026-04-15T07:08:32.990412Z","steps":["trace[1994993546] 'process raft request' (duration: 181.439274ms)","trace[1994993546] 'compare' (duration: 39.504282ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:08:33.894573Z","caller":"traceutil/trace.go:171","msg":"trace[1726025068] linearizableReadLoop","detail":"{readStateIndex:1181; appliedIndex:1180; }","duration":"137.205636ms","start":"2026-04-15T07:08:33.757347Z","end":"2026-04-15T07:08:33.894553Z","steps":["trace[1726025068] 'read index received' (duration: 137.024644ms)","trace[1726025068] 'applied index is now lower than readState.Index' (duration: 179.872µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:08:33.894631Z","caller":"traceutil/trace.go:171","msg":"trace[129580704] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"140.551498ms","start":"2026-04-15T07:08:33.754052Z","end":"2026-04-15T07:08:33.894604Z","steps":["trace[129580704] 'process raft request' (duration: 140.382077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:08:33.89476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.387667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-15T07:08:33.894847Z","caller":"traceutil/trace.go:171","msg":"trace[139300085] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1143; }","duration":"137.53204ms","start":"2026-04-15T07:08:33.757295Z","end":"2026-04-15T07:08:33.894827Z","steps":["trace[139300085] 'agreement among raft nodes before linearized reading' (duration: 137.341378ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:12:57.370422Z","caller":"traceutil/trace.go:171","msg":"trace[477899890] transaction","detail":"{read_only:false; response_revision:2012; number_of_response:1; }","duration":"244.445916ms","start":"2026-04-15T07:12:57.125945Z","end":"2026-04-15T07:12:57.370391Z","steps":["trace[477899890] 'process raft request' (duration: 210.611785ms)","trace[477899890] 'compare' (duration: 33.620706ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:13:28.415121Z","caller":"traceutil/trace.go:171","msg":"trace[2138279440] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"139.948476ms","start":"2026-04-15T07:13:28.275149Z","end":"2026-04-15T07:13:28.415098Z","steps":["trace[2138279440] 'process raft request' (duration: 139.426453ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:13:29.029669Z","caller":"traceutil/trace.go:171","msg":"trace[370846188] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"185.651809ms","start":"2026-04-15T07:13:28.843984Z","end":"2026-04-15T07:13:29.029635Z","steps":["trace[370846188] 'process raft request' (duration: 127.743922ms)","trace[370846188] 'compare' (duration: 57.684422ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:13:29.029809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.762211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T07:13:29.029899Z","caller":"traceutil/trace.go:171","msg":"trace[665982791] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:2203; }","duration":"168.914625ms","start":"2026-04-15T07:13:28.860968Z","end":"2026-04-15T07:13:29.029883Z","steps":["trace[665982791] 'agreement among raft nodes before linearized reading' (duration: 168.7273ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:13:29.029661Z","caller":"traceutil/trace.go:171","msg":"trace[266983711] linearizableReadLoop","detail":"{readStateIndex:2302; appliedIndex:2301; }","duration":"168.592497ms","start":"2026-04-15T07:13:28.861017Z","end":"2026-04-15T07:13:29.02961Z","steps":["trace[266983711] 'read index received' (duration: 110.643109ms)","trace[266983711] 'applied index is now lower than readState.Index' (duration: 57.948308ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:13:29.292618Z","caller":"traceutil/trace.go:171","msg":"trace[441254503] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"201.542223ms","start":"2026-04-15T07:13:29.091051Z","end":"2026-04-15T07:13:29.292593Z","steps":["trace[441254503] 'process raft request' (duration: 201.445411ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T07:13:29.29266Z","caller":"traceutil/trace.go:171","msg":"trace[1438758481] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"257.961154ms","start":"2026-04-15T07:13:29.034624Z","end":"2026-04-15T07:13:29.292585Z","steps":["trace[1438758481] 'process raft request' (duration: 191.667524ms)","trace[1438758481] 'compare' (duration: 65.816128ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:13:44.598252Z","caller":"traceutil/trace.go:171","msg":"trace[489308316] transaction","detail":"{read_only:false; response_revision:2322; number_of_response:1; }","duration":"101.853026ms","start":"2026-04-15T07:13:44.496375Z","end":"2026-04-15T07:13:44.598228Z","steps":["trace[489308316] 'process raft request' (duration: 101.623721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:13:44.975691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.989711ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T07:13:44.976007Z","caller":"traceutil/trace.go:171","msg":"trace[187711504] linearizableReadLoop","detail":"{readStateIndex:2425; appliedIndex:2424; }","duration":"337.808189ms","start":"2026-04-15T07:13:44.638182Z","end":"2026-04-15T07:13:44.97599Z","steps":["trace[187711504] 'read index received' (duration: 104.382308ms)","trace[187711504] 'applied index is now lower than readState.Index' (duration: 233.424371ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T07:13:44.976102Z","caller":"traceutil/trace.go:171","msg":"trace[1543833670] transaction","detail":"{read_only:false; response_revision:2323; number_of_response:1; }","duration":"374.190147ms","start":"2026-04-15T07:13:44.601901Z","end":"2026-04-15T07:13:44.976091Z","steps":["trace[1543833670] 'process raft request' (duration: 140.716485ms)","trace[1543833670] 'compare' (duration: 232.617322ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T07:13:44.976167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:13:44.601882Z","time spent":"374.249568ms","remote":"127.0.0.1:36948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T07:13:44.976361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.151737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-15T07:13:44.976479Z","caller":"traceutil/trace.go:171","msg":"trace[1251951509] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2323; }","duration":"338.28026ms","start":"2026-04-15T07:13:44.638145Z","end":"2026-04-15T07:13:44.976426Z","steps":["trace[1251951509] 'agreement among raft nodes before linearized reading' (duration: 337.990223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T07:13:44.97658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T07:13:44.638131Z","time spent":"338.414054ms","remote":"127.0.0.1:36948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}