{"level":"warn","ts":"2026-04-07T05:50:28.797998Z","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-07T05:50:28.798137Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89: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.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-07T05:50:28.798236Z","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-07T05:50:28.798251Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-04-07T05:50:28.798278Z","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-07T05:50:28.799042Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-04-07T05:50:28.799129Z","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.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-07T05:50:28.804928Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.487684ms"} {"level":"info","ts":"2026-04-07T05:50:28.81968Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-04-07T05:50:28.819783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T05:50:28.819807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-04-07T05:50:28.821341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T05:50:28.821356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-04-07T05:50:28.821412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-04-07T05:50:28.830696Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T05:50:28.83197Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T05:50:28.833635Z","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-07T05:50:28.835699Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T05:50:28.836452Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T05:50:28.836626Z","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-07T05:50:28.837473Z","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-07T05:50:28.837557Z","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-07T05:50:28.838111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-04-07T05:50:28.838366Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-04-07T05:50:28.851133Z","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-07T05:50:28.851174Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-04-07T05:50:28.851234Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-04-07T05:50:28.851327Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T05:50:28.851394Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T05:50:29.822221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T05:50:29.822283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T05:50:29.82232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-04-07T05:50:29.822341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-04-07T05:50:29.822359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-04-07T05:50:29.822378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-04-07T05:50:29.822394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-04-07T05:50:29.823285Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:50:29.824122Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:50:29.824115Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T05:50:29.82425Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:50:29.824634Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T05:50:29.824838Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T05:50:29.824763Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:50:29.82511Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:50:29.825224Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:50:29.827937Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T05:50:29.828853Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-04-07T05:50:38.828502Z","caller":"traceutil/trace.go:171","msg":"trace[1556590938] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"116.42501ms","start":"2026-04-07T05:50:38.712013Z","end":"2026-04-07T05:50:38.828438Z","steps":["trace[1556590938] 'process raft request' (duration: 102.19993ms)","trace[1556590938] 'compare' (duration: 14.010818ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:50:53.675965Z","caller":"traceutil/trace.go:171","msg":"trace[338108017] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"209.301444ms","start":"2026-04-07T05:50:53.466635Z","end":"2026-04-07T05:50:53.675936Z","steps":["trace[338108017] 'process raft request' (duration: 209.141651ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:50:59.985351Z","caller":"traceutil/trace.go:171","msg":"trace[1406953139] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"278.505027ms","start":"2026-04-07T05:50:59.706822Z","end":"2026-04-07T05:50:59.985327Z","steps":["trace[1406953139] 'process raft request' (duration: 278.351896ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:00.003281Z","caller":"traceutil/trace.go:171","msg":"trace[1109582093] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"215.842287ms","start":"2026-04-07T05:50:59.787414Z","end":"2026-04-07T05:51:00.003256Z","steps":["trace[1109582093] 'process raft request' (duration: 215.444323ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:00.003369Z","caller":"traceutil/trace.go:171","msg":"trace[2109725353] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:483; }","duration":"121.284226ms","start":"2026-04-07T05:50:59.882062Z","end":"2026-04-07T05:51:00.003346Z","steps":["trace[2109725353] 'read index received' (duration: 103.241171ms)","trace[2109725353] 'applied index is now lower than readState.Index' (duration: 18.042345ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:51:00.003494Z","caller":"traceutil/trace.go:171","msg":"trace[622236883] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"219.606961ms","start":"2026-04-07T05:50:59.783883Z","end":"2026-04-07T05:51:00.00349Z","steps":["trace[622236883] 'process raft request' (duration: 218.878424ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:00.00358Z","caller":"traceutil/trace.go:171","msg":"trace[1876169011] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"216.233029ms","start":"2026-04-07T05:50:59.787342Z","end":"2026-04-07T05:51:00.003575Z","steps":["trace[1876169011] 'process raft request' (duration: 215.456712ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:00.003583Z","caller":"traceutil/trace.go:171","msg":"trace[1526375608] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"215.21436ms","start":"2026-04-07T05:50:59.78833Z","end":"2026-04-07T05:51:00.003544Z","steps":["trace[1526375608] 'process raft request' (duration: 214.585374ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:00.003761Z","caller":"traceutil/trace.go:171","msg":"trace[2039952308] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"212.700638ms","start":"2026-04-07T05:50:59.791048Z","end":"2026-04-07T05:51:00.003749Z","steps":["trace[2039952308] 'process raft request' (duration: 211.905141ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:00.003835Z","caller":"traceutil/trace.go:171","msg":"trace[799279089] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"207.54758ms","start":"2026-04-07T05:50:59.796281Z","end":"2026-04-07T05:51:00.003828Z","steps":["trace[799279089] 'process raft request' (duration: 206.751083ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:00.003927Z","caller":"traceutil/trace.go:171","msg":"trace[770337242] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"206.783804ms","start":"2026-04-07T05:50:59.797101Z","end":"2026-04-07T05:51:00.003885Z","steps":["trace[770337242] 'process raft request' (duration: 205.980536ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:00.003982Z","caller":"traceutil/trace.go:171","msg":"trace[2058953774] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"185.830963ms","start":"2026-04-07T05:50:59.818092Z","end":"2026-04-07T05:51:00.003923Z","steps":["trace[2058953774] 'process raft request' (duration: 185.100736ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:00.004368Z","caller":"traceutil/trace.go:171","msg":"trace[418354982] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"213.253982ms","start":"2026-04-07T05:50:59.791068Z","end":"2026-04-07T05:51:00.004322Z","steps":["trace[418354982] 'process raft request' (duration: 211.92289ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:00.00345Z","caller":"traceutil/trace.go:171","msg":"trace[223089603] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"225.774396ms","start":"2026-04-07T05:50:59.777668Z","end":"2026-04-07T05:51:00.003442Z","steps":["trace[223089603] 'process raft request' (duration: 224.956569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:00.004497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.408993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:51:00.003477Z","caller":"traceutil/trace.go:171","msg":"trace[443966305] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"221.516398ms","start":"2026-04-07T05:50:59.781955Z","end":"2026-04-07T05:51:00.003471Z","steps":["trace[443966305] 'process raft request' (duration: 220.773451ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:00.004603Z","caller":"traceutil/trace.go:171","msg":"trace[2146546366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:483; }","duration":"112.545975ms","start":"2026-04-07T05:50:59.89204Z","end":"2026-04-07T05:51:00.004586Z","steps":["trace[2146546366] 'agreement among raft nodes before linearized reading' (duration: 112.368163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:00.004962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.89312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T05:51:00.005011Z","caller":"traceutil/trace.go:171","msg":"trace[880966080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:483; }","duration":"122.99741ms","start":"2026-04-07T05:50:59.882002Z","end":"2026-04-07T05:51:00.004999Z","steps":["trace[880966080] 'agreement among raft nodes before linearized reading' (duration: 122.270124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:01.403906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.485136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570096"} {"level":"info","ts":"2026-04-07T05:51:01.404008Z","caller":"traceutil/trace.go:171","msg":"trace[1337853746] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:545; }","duration":"222.616767ms","start":"2026-04-07T05:51:01.181372Z","end":"2026-04-07T05:51:01.403989Z","steps":["trace[1337853746] 'range keys from in-memory index tree' (duration: 222.229282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:01.403906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.313112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-04-07T05:51:01.404153Z","caller":"traceutil/trace.go:171","msg":"trace[1191725383] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:545; }","duration":"265.584455ms","start":"2026-04-07T05:51:01.138537Z","end":"2026-04-07T05:51:01.404121Z","steps":["trace[1191725383] 'range keys from in-memory index tree' (duration: 264.907478ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:01.504055Z","caller":"traceutil/trace.go:171","msg":"trace[464839455] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"293.602516ms","start":"2026-04-07T05:51:01.210436Z","end":"2026-04-07T05:51:01.504039Z","steps":["trace[464839455] 'process raft request' (duration: 293.132282ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:06.427136Z","caller":"traceutil/trace.go:171","msg":"trace[1369573722] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"386.956284ms","start":"2026-04-07T05:51:06.040167Z","end":"2026-04-07T05:51:06.427123Z","steps":["trace[1369573722] 'process raft request' (duration: 326.898517ms)","trace[1369573722] 'compare' (duration: 59.471763ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:51:06.427439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.736961ms","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-04-07T05:51:06.427518Z","caller":"traceutil/trace.go:171","msg":"trace[1328692409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:579; }","duration":"380.848041ms","start":"2026-04-07T05:51:06.04665Z","end":"2026-04-07T05:51:06.427498Z","steps":["trace[1328692409] 'agreement among raft nodes before linearized reading' (duration: 380.71913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:06.427562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:06.046632Z","time spent":"380.920812ms","remote":"127.0.0.1:40234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T05:51:06.427087Z","caller":"traceutil/trace.go:171","msg":"trace[1475868273] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"380.379157ms","start":"2026-04-07T05:51:06.046683Z","end":"2026-04-07T05:51:06.427062Z","steps":["trace[1475868273] 'read index received' (duration: 320.351569ms)","trace[1475868273] 'applied index is now lower than readState.Index' (duration: 60.026598ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:51:06.427924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:06.040134Z","time spent":"387.056027ms","remote":"127.0.0.1:40234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:51:06.463181Z","caller":"traceutil/trace.go:171","msg":"trace[616348722] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"360.389062ms","start":"2026-04-07T05:51:06.102754Z","end":"2026-04-07T05:51:06.463143Z","steps":["trace[616348722] 'process raft request' (duration: 359.860497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:06.463229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.288898ms","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-04-07T05:51:06.463293Z","caller":"traceutil/trace.go:171","msg":"trace[481768822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"412.366069ms","start":"2026-04-07T05:51:06.050908Z","end":"2026-04-07T05:51:06.463274Z","steps":["trace[481768822] 'agreement among raft nodes before linearized reading' (duration: 412.187567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:06.463332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:06.050902Z","time spent":"412.422889ms","remote":"127.0.0.1:40234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T05:51:06.463426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:06.102711Z","time spent":"360.550753ms","remote":"127.0.0.1:40054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:51:07.381386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.446861ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:51:07.381639Z","caller":"traceutil/trace.go:171","msg":"trace[1650212441] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:596; }","duration":"776.524629ms","start":"2026-04-07T05:51:06.605101Z","end":"2026-04-07T05:51:07.381626Z","steps":["trace[1650212441] 'read index received' (duration: 359.706087ms)","trace[1650212441] 'applied index is now lower than readState.Index' (duration: 416.817642ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:51:07.381633Z","caller":"traceutil/trace.go:171","msg":"trace[1103442067] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"950.37907ms","start":"2026-04-07T05:51:06.431223Z","end":"2026-04-07T05:51:07.381602Z","steps":["trace[1103442067] 'process raft request' (duration: 108.446105ms)","trace[1103442067] 'compare' (duration: 841.29492ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:51:07.381725Z","caller":"traceutil/trace.go:171","msg":"trace[142361936] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"857.024187ms","start":"2026-04-07T05:51:06.524692Z","end":"2026-04-07T05:51:07.381716Z","steps":["trace[142361936] 'process raft request' (duration: 856.896776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:07.381734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:06.431196Z","time spent":"950.495451ms","remote":"127.0.0.1:40234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:51:07.381777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:06.524666Z","time spent":"857.080478ms","remote":"127.0.0.1:43948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:51:07.381774Z","caller":"traceutil/trace.go:171","msg":"trace[1044102543] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"914.849417ms","start":"2026-04-07T05:51:06.46689Z","end":"2026-04-07T05:51:07.381739Z","steps":["trace[1044102543] 'process raft request' (duration: 914.619006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:07.381844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.170037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:51:07.381899Z","caller":"traceutil/trace.go:171","msg":"trace[1266530828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"625.274718ms","start":"2026-04-07T05:51:06.756607Z","end":"2026-04-07T05:51:07.381882Z","steps":["trace[1266530828] 'agreement among raft nodes before linearized reading' (duration: 625.125757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:07.38191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:06.466867Z","time spent":"914.971358ms","remote":"127.0.0.1:40234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:51:07.381934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:06.756577Z","time spent":"625.349829ms","remote":"127.0.0.1:39942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T05:51:07.381921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.815072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rsnq6\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-07T05:51:07.381983Z","caller":"traceutil/trace.go:171","msg":"trace[1257220462] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rsnq6; range_end:; response_count:1; response_revision:583; }","duration":"776.876512ms","start":"2026-04-07T05:51:06.605086Z","end":"2026-04-07T05:51:07.381962Z","steps":["trace[1257220462] 'agreement among raft nodes before linearized reading' (duration: 776.65923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:07.382022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:06.605041Z","time spent":"776.972552ms","remote":"127.0.0.1:40162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-rsnq6\" "} {"level":"warn","ts":"2026-04-07T05:51:08.893161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.348667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:51:08.893336Z","caller":"traceutil/trace.go:171","msg":"trace[1060908598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"138.589019ms","start":"2026-04-07T05:51:08.754701Z","end":"2026-04-07T05:51:08.89329Z","steps":["trace[1060908598] 'range keys from in-memory index tree' (duration: 138.257547ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:21.995811Z","caller":"traceutil/trace.go:171","msg":"trace[553763013] linearizableReadLoop","detail":"{readStateIndex:762; appliedIndex:761; }","duration":"238.121482ms","start":"2026-04-07T05:51:21.75764Z","end":"2026-04-07T05:51:21.995762Z","steps":["trace[553763013] 'read index received' (duration: 237.914712ms)","trace[553763013] 'applied index is now lower than readState.Index' (duration: 205.82µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:51:21.99595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.29464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:51:21.995981Z","caller":"traceutil/trace.go:171","msg":"trace[1250634936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:742; }","duration":"238.388615ms","start":"2026-04-07T05:51:21.757583Z","end":"2026-04-07T05:51:21.995972Z","steps":["trace[1250634936] 'agreement among raft nodes before linearized reading' (duration: 238.307781ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:21.996199Z","caller":"traceutil/trace.go:171","msg":"trace[1650836737] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"291.269568ms","start":"2026-04-07T05:51:21.704905Z","end":"2026-04-07T05:51:21.996174Z","steps":["trace[1650836737] 'process raft request' (duration: 290.686011ms)"],"step_count":1}