{"level":"warn","ts":"2026-03-20T05:26:17.904693Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T05:26:17.904805Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.225: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.225:2380","--initial-cluster=instance=https://199.204.45.225:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.225:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.225: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-03-20T05:26:17.904953Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T05:26:17.90497Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.225:2380"]} {"level":"info","ts":"2026-03-20T05:26:17.905007Z","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-03-20T05:26:17.905895Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.225:2379"]} {"level":"info","ts":"2026-03-20T05:26:17.906014Z","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.225:2380"],"listen-peer-urls":["https://199.204.45.225:2380"],"advertise-client-urls":["https://199.204.45.225:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.225:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.225: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-03-20T05:26:18.109906Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"203.562515ms"} {"level":"info","ts":"2026-03-20T05:26:18.127997Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e68635a2746608d1","cluster-id":"2a7f8712d7dbceef"} {"level":"info","ts":"2026-03-20T05:26:18.128092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 switched to configuration voters=()"} {"level":"info","ts":"2026-03-20T05:26:18.128117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 became follower at term 0"} {"level":"info","ts":"2026-03-20T05:26:18.128127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e68635a2746608d1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-20T05:26:18.128139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 became follower at term 1"} {"level":"info","ts":"2026-03-20T05:26:18.128175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 switched to configuration voters=(16611023247456471249)"} {"level":"warn","ts":"2026-03-20T05:26:18.134336Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-20T05:26:18.135812Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-20T05:26:18.136737Z","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-03-20T05:26:18.138755Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e68635a2746608d1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-20T05:26:18.139042Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e68635a2746608d1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-20T05:26:18.145501Z","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-03-20T05:26:18.145718Z","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-03-20T05:26:18.14575Z","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-03-20T05:26:18.146012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 switched to configuration voters=(16611023247456471249)"} {"level":"info","ts":"2026-03-20T05:26:18.146341Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2a7f8712d7dbceef","local-member-id":"e68635a2746608d1","added-peer-id":"e68635a2746608d1","added-peer-peer-urls":["https://199.204.45.225:2380"]} {"level":"info","ts":"2026-03-20T05:26:18.15095Z","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-03-20T05:26:18.151244Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.225:2380"} {"level":"info","ts":"2026-03-20T05:26:18.151321Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.225:2380"} {"level":"info","ts":"2026-03-20T05:26:18.151297Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e68635a2746608d1","initial-advertise-peer-urls":["https://199.204.45.225:2380"],"listen-peer-urls":["https://199.204.45.225:2380"],"advertise-client-urls":["https://199.204.45.225:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.225:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-20T05:26:18.151368Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-20T05:26:19.029109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 is starting a new election at term 1"} {"level":"info","ts":"2026-03-20T05:26:19.029235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-20T05:26:19.029285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 received MsgPreVoteResp from e68635a2746608d1 at term 1"} {"level":"info","ts":"2026-03-20T05:26:19.029316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 became candidate at term 2"} {"level":"info","ts":"2026-03-20T05:26:19.029333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 received MsgVoteResp from e68635a2746608d1 at term 2"} {"level":"info","ts":"2026-03-20T05:26:19.029356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e68635a2746608d1 became leader at term 2"} {"level":"info","ts":"2026-03-20T05:26:19.029378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e68635a2746608d1 elected leader e68635a2746608d1 at term 2"} {"level":"info","ts":"2026-03-20T05:26:19.030424Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e68635a2746608d1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.225:2379]}","request-path":"/0/members/e68635a2746608d1/attributes","cluster-id":"2a7f8712d7dbceef","publish-timeout":"7s"} {"level":"info","ts":"2026-03-20T05:26:19.030431Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T05:26:19.030441Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:26:19.030801Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T05:26:19.030868Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-20T05:26:19.030916Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-20T05:26:19.031844Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2a7f8712d7dbceef","local-member-id":"e68635a2746608d1","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:26:19.032075Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:26:19.032167Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:26:19.033925Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-20T05:26:19.036288Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.225:2379"} {"level":"warn","ts":"2026-03-20T05:26:23.317763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.664985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:26:23.317954Z","caller":"traceutil/trace.go:171","msg":"trace[897917309] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"165.405771ms","start":"2026-03-20T05:26:23.152533Z","end":"2026-03-20T05:26:23.317939Z","steps":["trace[897917309] 'process raft request' (duration: 12.148023ms)","trace[897917309] 'compare' (duration: 152.501403ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:24.037649Z","caller":"traceutil/trace.go:171","msg":"trace[1895536624] transaction","detail":"{read_only:false; response_revision:219; number_of_response:1; }","duration":"614.84012ms","start":"2026-03-20T05:26:23.422786Z","end":"2026-03-20T05:26:24.037626Z","steps":["trace[1895536624] 'process raft request' (duration: 614.70549ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:24.037775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:23.422754Z","time spent":"614.963289ms","remote":"127.0.0.1:51032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1944,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-20T05:26:25.002672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.587953ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-03-20T05:26:25.002832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:23.592984Z","time spent":"1.409819282s","remote":"127.0.0.1:51012","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-03-20T05:26:25.746413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.917882ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:26:25.746623Z","caller":"traceutil/trace.go:171","msg":"trace[1908748799] transaction","detail":"{read_only:false; response_revision:220; number_of_response:1; }","duration":"1.702162583s","start":"2026-03-20T05:26:24.044415Z","end":"2026-03-20T05:26:25.746578Z","steps":["trace[1908748799] 'process raft request' (duration: 1.485868802s)","trace[1908748799] 'compare' (duration: 215.711958ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:25.746665Z","caller":"traceutil/trace.go:171","msg":"trace[365967939] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"742.739071ms","start":"2026-03-20T05:26:25.003903Z","end":"2026-03-20T05:26:25.746642Z","steps":["trace[365967939] 'process raft request' (duration: 742.657876ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:25.746834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:24.044396Z","time spent":"1.702320824s","remote":"127.0.0.1:51250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":356,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-20T05:26:25.746923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:25.003875Z","time spent":"742.956707ms","remote":"127.0.0.1:51012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-20T05:26:25.74734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.330858517s","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-03-20T05:26:25.747393Z","caller":"traceutil/trace.go:171","msg":"trace[1051944908] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:221; }","duration":"1.330966985s","start":"2026-03-20T05:26:24.416414Z","end":"2026-03-20T05:26:25.747381Z","steps":["trace[1051944908] 'agreement among raft nodes before linearized reading' (duration: 1.33077494s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:25.747428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:24.416389Z","time spent":"1.331029769s","remote":"127.0.0.1:51192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-20T05:26:25.747847Z","caller":"traceutil/trace.go:171","msg":"trace[893499043] linearizableReadLoop","detail":"{readStateIndex:226; appliedIndex:224; }","duration":"1.330213649s","start":"2026-03-20T05:26:24.416465Z","end":"2026-03-20T05:26:25.746679Z","steps":["trace[893499043] 'read index received' (duration: 184.5941ms)","trace[893499043] 'applied index is now lower than readState.Index' (duration: 1.145615579s)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:25.748331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.325475614s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-20T05:26:25.748563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.112306849s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-03-20T05:26:25.748555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.365957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:26:25.748637Z","caller":"traceutil/trace.go:171","msg":"trace[60673573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:221; }","duration":"1.11243857s","start":"2026-03-20T05:26:24.636181Z","end":"2026-03-20T05:26:25.74862Z","steps":["trace[60673573] 'agreement among raft nodes before linearized reading' (duration: 1.112267447s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:25.748676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:24.636155Z","time spent":"1.112513225s","remote":"127.0.0.1:51192","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":"info","ts":"2026-03-20T05:26:25.748681Z","caller":"traceutil/trace.go:171","msg":"trace[135477265] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:221; }","duration":"721.570723ms","start":"2026-03-20T05:26:25.02708Z","end":"2026-03-20T05:26:25.748651Z","steps":["trace[135477265] 'agreement among raft nodes before linearized reading' (duration: 721.313813ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:25.748743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:25.027056Z","time spent":"721.673111ms","remote":"127.0.0.1:51074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"info","ts":"2026-03-20T05:26:25.748415Z","caller":"traceutil/trace.go:171","msg":"trace[278596710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:221; }","duration":"1.325624555s","start":"2026-03-20T05:26:24.422771Z","end":"2026-03-20T05:26:25.748396Z","steps":["trace[278596710] 'agreement among raft nodes before linearized reading' (duration: 1.325472094s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:25.749028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:24.422744Z","time spent":"1.326249831s","remote":"127.0.0.1:51192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-20T05:26:25.749159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.305524178s","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-03-20T05:26:25.749254Z","caller":"traceutil/trace.go:171","msg":"trace[1276085824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:221; }","duration":"1.306187888s","start":"2026-03-20T05:26:24.443045Z","end":"2026-03-20T05:26:25.749233Z","steps":["trace[1276085824] 'agreement among raft nodes before linearized reading' (duration: 1.305432042s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:25.749342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:24.443022Z","time spent":"1.306305816s","remote":"127.0.0.1:51192","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-03-20T05:26:27.469285Z","caller":"traceutil/trace.go:171","msg":"trace[2140776300] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"238.433711ms","start":"2026-03-20T05:26:27.230798Z","end":"2026-03-20T05:26:27.469231Z","steps":["trace[2140776300] 'process raft request' (duration: 238.234286ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:27.469368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.346418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-20T05:26:27.469442Z","caller":"traceutil/trace.go:171","msg":"trace[1209048366] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:299; }","duration":"205.459966ms","start":"2026-03-20T05:26:27.263961Z","end":"2026-03-20T05:26:27.469421Z","steps":["trace[1209048366] 'agreement among raft nodes before linearized reading' (duration: 205.339437ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:27.469202Z","caller":"traceutil/trace.go:171","msg":"trace[2041244324] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:307; }","duration":"156.766372ms","start":"2026-03-20T05:26:27.312409Z","end":"2026-03-20T05:26:27.469175Z","steps":["trace[2041244324] 'read index received' (duration: 156.540245ms)","trace[2041244324] 'applied index is now lower than readState.Index' (duration: 225.227µs)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:27.469987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.519923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-03-20T05:26:27.470047Z","caller":"traceutil/trace.go:171","msg":"trace[487502979] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:299; }","duration":"156.591349ms","start":"2026-03-20T05:26:27.313441Z","end":"2026-03-20T05:26:27.470032Z","steps":["trace[487502979] 'agreement among raft nodes before linearized reading' (duration: 156.506313ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:27.959138Z","caller":"traceutil/trace.go:171","msg":"trace[1610099273] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:319; }","duration":"146.803927ms","start":"2026-03-20T05:26:27.812305Z","end":"2026-03-20T05:26:27.959109Z","steps":["trace[1610099273] 'read index received' (duration: 121.91708ms)","trace[1610099273] 'applied index is now lower than readState.Index' (duration: 24.885787ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:27.959297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.962408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-20T05:26:27.959362Z","caller":"traceutil/trace.go:171","msg":"trace[1991027825] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:311; }","duration":"147.059735ms","start":"2026-03-20T05:26:27.812285Z","end":"2026-03-20T05:26:27.959345Z","steps":["trace[1991027825] 'agreement among raft nodes before linearized reading' (duration: 146.931506ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:27.959335Z","caller":"traceutil/trace.go:171","msg":"trace[1465546425] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"158.931982ms","start":"2026-03-20T05:26:27.800339Z","end":"2026-03-20T05:26:27.959271Z","steps":["trace[1465546425] 'process raft request' (duration: 134.004252ms)","trace[1465546425] 'compare' (duration: 24.665631ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:30.839061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.832488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:26:30.839505Z","caller":"traceutil/trace.go:171","msg":"trace[171916798] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"215.787454ms","start":"2026-03-20T05:26:30.623665Z","end":"2026-03-20T05:26:30.839453Z","steps":["trace[171916798] 'process raft request' (duration: 68.183478ms)","trace[171916798] 'compare' (duration: 146.669826ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:30.845343Z","caller":"traceutil/trace.go:171","msg":"trace[1277392851] linearizableReadLoop","detail":"{readStateIndex:346; appliedIndex:343; }","duration":"181.048981ms","start":"2026-03-20T05:26:30.664274Z","end":"2026-03-20T05:26:30.845323Z","steps":["trace[1277392851] 'read index received' (duration: 27.657093ms)","trace[1277392851] 'applied index is now lower than readState.Index' (duration: 153.390928ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:30.845421Z","caller":"traceutil/trace.go:171","msg":"trace[1301630762] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"211.483333ms","start":"2026-03-20T05:26:30.633922Z","end":"2026-03-20T05:26:30.845405Z","steps":["trace[1301630762] 'process raft request' (duration: 211.243125ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:30.845476Z","caller":"traceutil/trace.go:171","msg":"trace[448037726] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"182.059317ms","start":"2026-03-20T05:26:30.663387Z","end":"2026-03-20T05:26:30.845446Z","steps":["trace[448037726] 'process raft request' (duration: 181.886594ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:30.845685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.030239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-03-20T05:26:30.845721Z","caller":"traceutil/trace.go:171","msg":"trace[657089605] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:337; }","duration":"131.105065ms","start":"2026-03-20T05:26:30.714604Z","end":"2026-03-20T05:26:30.84571Z","steps":["trace[657089605] 'agreement among raft nodes before linearized reading' (duration: 130.938192ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:30.846043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.761815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-03-20T05:26:30.846148Z","caller":"traceutil/trace.go:171","msg":"trace[53001947] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:337; }","duration":"181.909706ms","start":"2026-03-20T05:26:30.664221Z","end":"2026-03-20T05:26:30.84613Z","steps":["trace[53001947] 'agreement among raft nodes before linearized reading' (duration: 181.235056ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.06223Z","caller":"traceutil/trace.go:171","msg":"trace[401724141] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"156.098793ms","start":"2026-03-20T05:26:30.906109Z","end":"2026-03-20T05:26:31.062207Z","steps":["trace[401724141] 'process raft request' (duration: 97.898806ms)","trace[401724141] 'compare' (duration: 58.039256ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:31.062575Z","caller":"traceutil/trace.go:171","msg":"trace[928598832] linearizableReadLoop","detail":"{readStateIndex:357; appliedIndex:354; }","duration":"148.027861ms","start":"2026-03-20T05:26:30.914526Z","end":"2026-03-20T05:26:31.062554Z","steps":["trace[928598832] 'read index received' (duration: 89.319886ms)","trace[928598832] 'applied index is now lower than readState.Index' (duration: 58.707155ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:31.062737Z","caller":"traceutil/trace.go:171","msg":"trace[1552710072] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"154.792016ms","start":"2026-03-20T05:26:30.907905Z","end":"2026-03-20T05:26:31.062697Z","steps":["trace[1552710072] 'process raft request' (duration: 154.556598ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:31.062906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.351126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-03-20T05:26:31.062952Z","caller":"traceutil/trace.go:171","msg":"trace[824841604] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"155.635059ms","start":"2026-03-20T05:26:30.90728Z","end":"2026-03-20T05:26:31.062915Z","steps":["trace[824841604] 'process raft request' (duration: 154.887703ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.063027Z","caller":"traceutil/trace.go:171","msg":"trace[2123117852] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:348; }","duration":"148.485366ms","start":"2026-03-20T05:26:30.914515Z","end":"2026-03-20T05:26:31.063Z","steps":["trace[2123117852] 'agreement among raft nodes before linearized reading' (duration: 148.212076ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.240615Z","caller":"traceutil/trace.go:171","msg":"trace[41368456] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"116.212943ms","start":"2026-03-20T05:26:31.124373Z","end":"2026-03-20T05:26:31.240586Z","steps":["trace[41368456] 'process raft request' (duration: 65.347403ms)","trace[41368456] 'compare' (duration: 50.497672ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:31.24075Z","caller":"traceutil/trace.go:171","msg":"trace[1159734154] linearizableReadLoop","detail":"{readStateIndex:364; appliedIndex:361; }","duration":"111.670043ms","start":"2026-03-20T05:26:31.129045Z","end":"2026-03-20T05:26:31.240715Z","steps":["trace[1159734154] 'read index received' (duration: 60.741959ms)","trace[1159734154] 'applied index is now lower than readState.Index' (duration: 50.926564ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:31.240894Z","caller":"traceutil/trace.go:171","msg":"trace[55982129] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"111.748079ms","start":"2026-03-20T05:26:31.129119Z","end":"2026-03-20T05:26:31.240867Z","steps":["trace[55982129] 'process raft request' (duration: 111.518532ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.240951Z","caller":"traceutil/trace.go:171","msg":"trace[1730212203] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"116.120415ms","start":"2026-03-20T05:26:31.124748Z","end":"2026-03-20T05:26:31.240869Z","steps":["trace[1730212203] 'process raft request' (duration: 115.700243ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.240979Z","caller":"traceutil/trace.go:171","msg":"trace[1274338575] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"115.302604ms","start":"2026-03-20T05:26:31.125637Z","end":"2026-03-20T05:26:31.240939Z","steps":["trace[1274338575] 'process raft request' (duration: 114.874482ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:31.241225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.145009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-03-20T05:26:31.241344Z","caller":"traceutil/trace.go:171","msg":"trace[1688088489] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:356; }","duration":"112.29666ms","start":"2026-03-20T05:26:31.12903Z","end":"2026-03-20T05:26:31.241326Z","steps":["trace[1688088489] 'agreement among raft nodes before linearized reading' (duration: 111.847696ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:31.241141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.845201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-03-20T05:26:31.241421Z","caller":"traceutil/trace.go:171","msg":"trace[1711628703] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:356; }","duration":"109.254962ms","start":"2026-03-20T05:26:31.132151Z","end":"2026-03-20T05:26:31.241406Z","steps":["trace[1711628703] 'agreement among raft nodes before linearized reading' (duration: 108.767985ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.41057Z","caller":"traceutil/trace.go:171","msg":"trace[1743328297] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"161.144578ms","start":"2026-03-20T05:26:31.249375Z","end":"2026-03-20T05:26:31.410519Z","steps":["trace[1743328297] 'process raft request' (duration: 146.309367ms)","trace[1743328297] 'compare' (duration: 14.650407ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:31.413726Z","caller":"traceutil/trace.go:171","msg":"trace[825436329] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"160.23076ms","start":"2026-03-20T05:26:31.253474Z","end":"2026-03-20T05:26:31.413705Z","steps":["trace[825436329] 'process raft request' (duration: 160.014994ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.413892Z","caller":"traceutil/trace.go:171","msg":"trace[40015974] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"160.424934ms","start":"2026-03-20T05:26:31.25346Z","end":"2026-03-20T05:26:31.413885Z","steps":["trace[40015974] 'process raft request' (duration: 159.904415ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.413958Z","caller":"traceutil/trace.go:171","msg":"trace[1624719519] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"116.561888ms","start":"2026-03-20T05:26:31.297325Z","end":"2026-03-20T05:26:31.413887Z","steps":["trace[1624719519] 'process raft request' (duration: 116.499093ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.414179Z","caller":"traceutil/trace.go:171","msg":"trace[1537818736] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"117.185906ms","start":"2026-03-20T05:26:31.296976Z","end":"2026-03-20T05:26:31.414162Z","steps":["trace[1537818736] 'process raft request' (duration: 116.633985ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.41423Z","caller":"traceutil/trace.go:171","msg":"trace[2030348282] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"122.57674ms","start":"2026-03-20T05:26:31.291645Z","end":"2026-03-20T05:26:31.414222Z","steps":["trace[2030348282] 'process raft request' (duration: 121.903779ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:31.414266Z","caller":"traceutil/trace.go:171","msg":"trace[283897982] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"117.065116ms","start":"2026-03-20T05:26:31.297195Z","end":"2026-03-20T05:26:31.41426Z","steps":["trace[283897982] 'process raft request' (duration: 116.551368ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:32.210228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.676552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3819"} {"level":"warn","ts":"2026-03-20T05:26:32.210195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.991932ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:26:32.210422Z","caller":"traceutil/trace.go:171","msg":"trace[1181600203] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:376; }","duration":"696.902529ms","start":"2026-03-20T05:26:31.513444Z","end":"2026-03-20T05:26:32.210347Z","steps":["trace[1181600203] 'range keys from in-memory index tree' (duration: 696.559122ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:32.210476Z","caller":"traceutil/trace.go:171","msg":"trace[247649873] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:376; }","duration":"553.305515ms","start":"2026-03-20T05:26:31.657147Z","end":"2026-03-20T05:26:32.210452Z","steps":["trace[247649873] 'range keys from in-memory index tree' (duration: 552.929055ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:32.210494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:31.513423Z","time spent":"697.05358ms","remote":"127.0.0.1:51434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3842,"request content":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" "} {"level":"warn","ts":"2026-03-20T05:26:32.210953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.825998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:26:32.211053Z","caller":"traceutil/trace.go:171","msg":"trace[527242718] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"696.486237ms","start":"2026-03-20T05:26:31.514544Z","end":"2026-03-20T05:26:32.21103Z","steps":["trace[527242718] 'process raft request' (duration: 131.487646ms)","trace[527242718] 'compare' (duration: 564.249275ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:26:32.211193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:31.514529Z","time spent":"696.642839ms","remote":"127.0.0.1:51392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:26:32.291323Z","caller":"traceutil/trace.go:171","msg":"trace[1198799683] linearizableReadLoop","detail":"{readStateIndex:387; appliedIndex:385; }","duration":"691.560447ms","start":"2026-03-20T05:26:31.599726Z","end":"2026-03-20T05:26:32.291287Z","steps":["trace[1198799683] 'read index received' (duration: 46.323119ms)","trace[1198799683] 'applied index is now lower than readState.Index' (duration: 645.236458ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:26:32.291454Z","caller":"traceutil/trace.go:171","msg":"trace[1089818546] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"772.752678ms","start":"2026-03-20T05:26:31.518671Z","end":"2026-03-20T05:26:32.291424Z","steps":["trace[1089818546] 'process raft request' (duration: 772.452545ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:32.291515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.759023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-03-20T05:26:32.291572Z","caller":"traceutil/trace.go:171","msg":"trace[821602686] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:378; }","duration":"691.85306ms","start":"2026-03-20T05:26:31.599709Z","end":"2026-03-20T05:26:32.291562Z","steps":["trace[821602686] 'agreement among raft nodes before linearized reading' (duration: 691.72503ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:32.291608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:31.599646Z","time spent":"691.951467ms","remote":"127.0.0.1:51134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":208,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-03-20T05:26:32.291617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:31.518648Z","time spent":"772.874538ms","remote":"127.0.0.1:51124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4451,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T05:26:32.291616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.373921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.225\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-03-20T05:26:32.291635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.122017ms","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-03-20T05:26:32.291711Z","caller":"traceutil/trace.go:171","msg":"trace[759069199] range","detail":"{range_begin:/registry/masterleases/199.204.45.225; range_end:; response_count:1; response_revision:378; }","duration":"316.531473ms","start":"2026-03-20T05:26:31.975161Z","end":"2026-03-20T05:26:32.291692Z","steps":["trace[759069199] 'agreement among raft nodes before linearized reading' (duration: 316.365991ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:32.291736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.839865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-20T05:26:32.291748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:31.975137Z","time spent":"316.603159ms","remote":"127.0.0.1:50968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.225\" "} {"level":"info","ts":"2026-03-20T05:26:32.291739Z","caller":"traceutil/trace.go:171","msg":"trace[489057799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:378; }","duration":"493.299522ms","start":"2026-03-20T05:26:31.798413Z","end":"2026-03-20T05:26:32.291713Z","steps":["trace[489057799] 'agreement among raft nodes before linearized reading' (duration: 493.092786ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:32.291785Z","caller":"traceutil/trace.go:171","msg":"trace[790642796] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:378; }","duration":"281.942803ms","start":"2026-03-20T05:26:32.009829Z","end":"2026-03-20T05:26:32.291771Z","steps":["trace[790642796] 'agreement among raft nodes before linearized reading' (duration: 281.848416ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:32.291808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:31.798338Z","time spent":"493.455183ms","remote":"127.0.0.1:51192","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":"warn","ts":"2026-03-20T05:26:32.291824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.046143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-03-20T05:26:32.291818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.297958ms","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-03-20T05:26:32.291911Z","caller":"traceutil/trace.go:171","msg":"trace[354330487] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:378; }","duration":"476.432537ms","start":"2026-03-20T05:26:31.815468Z","end":"2026-03-20T05:26:32.291901Z","steps":["trace[354330487] 'agreement among raft nodes before linearized reading' (duration: 476.248324ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:32.291914Z","caller":"traceutil/trace.go:171","msg":"trace[1356720910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:378; }","duration":"483.190154ms","start":"2026-03-20T05:26:31.808702Z","end":"2026-03-20T05:26:32.291892Z","steps":["trace[1356720910] 'agreement among raft nodes before linearized reading' (duration: 483.031672ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:26:32.291949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:31.815451Z","time spent":"476.490211ms","remote":"127.0.0.1:51192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-20T05:26:32.291966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:26:31.808674Z","time spent":"483.281291ms","remote":"127.0.0.1:51192","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":"info","ts":"2026-03-20T05:26:33.654159Z","caller":"traceutil/trace.go:171","msg":"trace[1991082169] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"117.166181ms","start":"2026-03-20T05:26:33.536979Z","end":"2026-03-20T05:26:33.654145Z","steps":["trace[1991082169] 'process raft request' (duration: 113.687739ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:26:53.418427Z","caller":"traceutil/trace.go:171","msg":"trace[1322825538] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"160.886366ms","start":"2026-03-20T05:26:53.25746Z","end":"2026-03-20T05:26:53.418347Z","steps":["trace[1322825538] 'process raft request' (duration: 160.668999ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:27:05.709296Z","caller":"traceutil/trace.go:171","msg":"trace[1346135815] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"147.747744ms","start":"2026-03-20T05:27:05.561524Z","end":"2026-03-20T05:27:05.709272Z","steps":["trace[1346135815] 'process raft request' (duration: 146.046031ms)"],"step_count":1}