{"level":"warn","ts":"2026-02-19T18:56:22.998715Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-19T18:56:22.998835Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244: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.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244: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-02-19T18:56:22.999038Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-19T18:56:22.999063Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-02-19T18:56:22.999094Z","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-02-19T18:56:22.99994Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]} {"level":"info","ts":"2026-02-19T18:56:23.000032Z","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.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244: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-02-19T18:56:23.00424Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.976826ms"} {"level":"info","ts":"2026-02-19T18:56:23.012511Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"} {"level":"info","ts":"2026-02-19T18:56:23.012624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"} {"level":"info","ts":"2026-02-19T18:56:23.012652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"} {"level":"info","ts":"2026-02-19T18:56:23.012668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-19T18:56:23.012678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"} {"level":"info","ts":"2026-02-19T18:56:23.012724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"warn","ts":"2026-02-19T18:56:23.019443Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-19T18:56:23.022424Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-19T18:56:23.023672Z","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-02-19T18:56:23.026532Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-19T18:56:23.026719Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-19T18:56:23.027217Z","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-02-19T18:56:23.02728Z","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-02-19T18:56:23.027291Z","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-02-19T18:56:23.029058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"info","ts":"2026-02-19T18:56:23.029302Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-02-19T18:56:23.031593Z","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-02-19T18:56:23.032993Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-19T18:56:23.03303Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-02-19T18:56:23.033896Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-02-19T18:56:23.033046Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-19T18:56:23.513955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"} {"level":"info","ts":"2026-02-19T18:56:23.514019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"} {"level":"info","ts":"2026-02-19T18:56:23.514034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"} {"level":"info","ts":"2026-02-19T18:56:23.51406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"} {"level":"info","ts":"2026-02-19T18:56:23.514081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-02-19T18:56:23.514112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"} {"level":"info","ts":"2026-02-19T18:56:23.514123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-02-19T18:56:23.51663Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T18:56:23.517673Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"} {"level":"info","ts":"2026-02-19T18:56:23.517743Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T18:56:23.517806Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T18:56:23.517887Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T18:56:23.51789Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T18:56:23.518032Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-19T18:56:23.518065Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-19T18:56:23.517941Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T18:56:23.520784Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"} {"level":"info","ts":"2026-02-19T18:56:23.520901Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-19T18:56:45.760906Z","caller":"traceutil/trace.go:171","msg":"trace[579612699] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"253.153202ms","start":"2026-02-19T18:56:45.507739Z","end":"2026-02-19T18:56:45.760892Z","steps":["trace[579612699] 'process raft request' (duration: 253.072341ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T18:56:45.760938Z","caller":"traceutil/trace.go:171","msg":"trace[1118125540] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:427; }","duration":"100.930144ms","start":"2026-02-19T18:56:45.659988Z","end":"2026-02-19T18:56:45.760918Z","steps":["trace[1118125540] 'read index received' (duration: 100.922914ms)","trace[1118125540] 'applied index is now lower than readState.Index' (duration: 6.09µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T18:56:45.761086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.087585ms","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-02-19T18:56:45.761138Z","caller":"traceutil/trace.go:171","msg":"trace[1284169948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:414; }","duration":"101.189396ms","start":"2026-02-19T18:56:45.659938Z","end":"2026-02-19T18:56:45.761128Z","steps":["trace[1284169948] 'agreement among raft nodes before linearized reading' (duration: 101.071485ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:56:46.058676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.247231ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T18:56:46.058791Z","caller":"traceutil/trace.go:171","msg":"trace[1560107334] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"293.881367ms","start":"2026-02-19T18:56:45.764891Z","end":"2026-02-19T18:56:46.058773Z","steps":["trace[1560107334] 'process raft request' (duration: 155.92156ms)","trace[1560107334] 'compare' (duration: 136.958149ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T18:56:46.189846Z","caller":"traceutil/trace.go:171","msg":"trace[1769457673] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"404.91006ms","start":"2026-02-19T18:56:45.784904Z","end":"2026-02-19T18:56:46.189814Z","steps":["trace[1769457673] 'process raft request' (duration: 401.602661ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:56:46.190035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:56:45.784876Z","time spent":"405.047561ms","remote":"127.0.0.1:51054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T18:56:54.389189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.732197ms","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-02-19T18:56:54.389226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.689586ms","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-02-19T18:56:54.389268Z","caller":"traceutil/trace.go:171","msg":"trace[462000551] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:469; }","duration":"171.853298ms","start":"2026-02-19T18:56:54.217398Z","end":"2026-02-19T18:56:54.389251Z","steps":["trace[462000551] 'range keys from in-memory index tree' (duration: 171.631736ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:56:54.389239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.610501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T18:56:54.389352Z","caller":"traceutil/trace.go:171","msg":"trace[1564293171] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:469; }","duration":"185.806903ms","start":"2026-02-19T18:56:54.203523Z","end":"2026-02-19T18:56:54.38933Z","steps":["trace[1564293171] 'range keys from in-memory index tree' (duration: 185.507249ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T18:56:54.389323Z","caller":"traceutil/trace.go:171","msg":"trace[3698298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:469; }","duration":"298.836628ms","start":"2026-02-19T18:56:54.09046Z","end":"2026-02-19T18:56:54.389297Z","steps":["trace[3698298] 'range keys from in-memory index tree' (duration: 298.564696ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T18:56:55.909944Z","caller":"traceutil/trace.go:171","msg":"trace[167690199] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"102.528744ms","start":"2026-02-19T18:56:55.807393Z","end":"2026-02-19T18:56:55.909921Z","steps":["trace[167690199] 'process raft request' (duration: 102.400333ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T18:56:56.795431Z","caller":"traceutil/trace.go:171","msg":"trace[950781091] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:489; }","duration":"387.645087ms","start":"2026-02-19T18:56:56.407758Z","end":"2026-02-19T18:56:56.795403Z","steps":["trace[950781091] 'read index received' (duration: 387.427366ms)","trace[950781091] 'applied index is now lower than readState.Index' (duration: 216.581µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T18:56:56.795733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.962511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-19T18:56:56.795794Z","caller":"traceutil/trace.go:171","msg":"trace[259166333] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:475; }","duration":"388.095551ms","start":"2026-02-19T18:56:56.407683Z","end":"2026-02-19T18:56:56.795779Z","steps":["trace[259166333] 'agreement among raft nodes before linearized reading' (duration: 387.827569ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:56:56.795838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:56:56.407654Z","time spent":"388.172692ms","remote":"127.0.0.1:51054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T18:56:56.795902Z","caller":"traceutil/trace.go:171","msg":"trace[1700222149] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"390.845903ms","start":"2026-02-19T18:56:56.405032Z","end":"2026-02-19T18:56:56.795878Z","steps":["trace[1700222149] 'process raft request' (duration: 390.229448ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:56:56.79602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:56:56.405015Z","time spent":"390.932135ms","remote":"127.0.0.1:51054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T18:56:59.871819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.717628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gtdjf\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-19T18:56:59.871903Z","caller":"traceutil/trace.go:171","msg":"trace[863138399] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gtdjf; range_end:; response_count:1; response_revision:508; }","duration":"399.854599ms","start":"2026-02-19T18:56:59.47203Z","end":"2026-02-19T18:56:59.871885Z","steps":["trace[863138399] 'range keys from in-memory index tree' (duration: 399.550306ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:56:59.871947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:56:59.472008Z","time spent":"399.929189ms","remote":"127.0.0.1:50968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16678,"request content":"key:\"/registry/pods/kube-system/cilium-gtdjf\" "} {"level":"info","ts":"2026-02-19T18:57:00.116852Z","caller":"traceutil/trace.go:171","msg":"trace[886990704] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:524; }","duration":"193.620113ms","start":"2026-02-19T18:56:59.923213Z","end":"2026-02-19T18:57:00.116834Z","steps":["trace[886990704] 'read index received' (duration: 193.491152ms)","trace[886990704] 'applied index is now lower than readState.Index' (duration: 127.911µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T18:57:00.116947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.729573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-19T18:57:00.116919Z","caller":"traceutil/trace.go:171","msg":"trace[1653387253] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"227.698782ms","start":"2026-02-19T18:56:59.889189Z","end":"2026-02-19T18:57:00.116888Z","steps":["trace[1653387253] 'process raft request' (duration: 227.514901ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T18:57:00.116971Z","caller":"traceutil/trace.go:171","msg":"trace[686732919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:509; }","duration":"193.796205ms","start":"2026-02-19T18:56:59.923168Z","end":"2026-02-19T18:57:00.116964Z","steps":["trace[686732919] 'agreement among raft nodes before linearized reading' (duration: 193.735764ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T18:57:00.244909Z","caller":"traceutil/trace.go:171","msg":"trace[1105411578] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"124.127224ms","start":"2026-02-19T18:57:00.120728Z","end":"2026-02-19T18:57:00.244856Z","steps":["trace[1105411578] 'process raft request' (duration: 86.754931ms)","trace[1105411578] 'compare' (duration: 37.05497ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T18:57:01.15987Z","caller":"traceutil/trace.go:171","msg":"trace[719656483] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"341.948084ms","start":"2026-02-19T18:57:00.817895Z","end":"2026-02-19T18:57:01.159843Z","steps":["trace[719656483] 'process raft request' (duration: 341.794733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:57:01.16004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:57:00.817884Z","time spent":"342.066625ms","remote":"127.0.0.1:51054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T18:57:01.173822Z","caller":"traceutil/trace.go:171","msg":"trace[179013911] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:527; }","duration":"319.442047ms","start":"2026-02-19T18:57:00.854362Z","end":"2026-02-19T18:57:01.173804Z","steps":["trace[179013911] 'read index received' (duration: 305.66669ms)","trace[179013911] 'applied index is now lower than readState.Index' (duration: 13.774257ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T18:57:01.173948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.580948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-19T18:57:01.173973Z","caller":"traceutil/trace.go:171","msg":"trace[1577099005] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:512; }","duration":"319.638959ms","start":"2026-02-19T18:57:00.854325Z","end":"2026-02-19T18:57:01.173964Z","steps":["trace[1577099005] 'agreement among raft nodes before linearized reading' (duration: 319.547758ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:57:01.173996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:57:00.854296Z","time spent":"319.694539ms","remote":"127.0.0.1:51054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-19T18:57:01.174157Z","caller":"traceutil/trace.go:171","msg":"trace[468243975] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"356.233886ms","start":"2026-02-19T18:57:00.817917Z","end":"2026-02-19T18:57:01.174151Z","steps":["trace[468243975] 'process raft request' (duration: 355.801803ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:57:01.174235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:57:00.817878Z","time spent":"356.295026ms","remote":"127.0.0.1:51054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T18:57:03.515156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:57:03.151887Z","time spent":"363.257454ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-19T18:57:03.515175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.231015236s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-19T18:57:03.515414Z","caller":"traceutil/trace.go:171","msg":"trace[360386710] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"1.311972392s","start":"2026-02-19T18:57:02.203411Z","end":"2026-02-19T18:57:03.515384Z","steps":["trace[360386710] 'read index received' (duration: 80.646094ms)","trace[360386710] 'applied index is now lower than readState.Index' (duration: 1.231323188s)"],"step_count":2} {"level":"warn","ts":"2026-02-19T18:57:03.515538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.312106724s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T18:57:03.515627Z","caller":"traceutil/trace.go:171","msg":"trace[1128067453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:513; }","duration":"1.312249135s","start":"2026-02-19T18:57:02.203358Z","end":"2026-02-19T18:57:03.515607Z","steps":["trace[1128067453] 'agreement among raft nodes before linearized reading' (duration: 1.312115104s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:57:03.515673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:57:02.203334Z","time spent":"1.312329575s","remote":"127.0.0.1:50772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-19T18:57:03.515697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.267424747s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-19T18:57:03.515739Z","caller":"traceutil/trace.go:171","msg":"trace[1054826050] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"1.267512558s","start":"2026-02-19T18:57:02.248212Z","end":"2026-02-19T18:57:03.515725Z","steps":["trace[1054826050] 'agreement among raft nodes before linearized reading' (duration: 1.267313026s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:57:03.515736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.050782ms","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-02-19T18:57:03.515782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:57:02.248194Z","time spent":"1.267579058s","remote":"127.0.0.1:51054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-19T18:57:03.515821Z","caller":"traceutil/trace.go:171","msg":"trace[420915311] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:513; }","duration":"320.173303ms","start":"2026-02-19T18:57:03.195626Z","end":"2026-02-19T18:57:03.515799Z","steps":["trace[420915311] 'agreement among raft nodes before linearized reading' (duration: 319.945952ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:57:03.515869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:57:03.195607Z","time spent":"320.252814ms","remote":"127.0.0.1:51054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T18:57:03.516031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.708186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-19T18:57:03.516089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.916738ms","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-02-19T18:57:03.516104Z","caller":"traceutil/trace.go:171","msg":"trace[860400703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:513; }","duration":"338.800277ms","start":"2026-02-19T18:57:03.177291Z","end":"2026-02-19T18:57:03.516091Z","steps":["trace[860400703] 'agreement among raft nodes before linearized reading' (duration: 338.640286ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T18:57:03.51612Z","caller":"traceutil/trace.go:171","msg":"trace[708588307] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:513; }","duration":"352.031949ms","start":"2026-02-19T18:57:03.164078Z","end":"2026-02-19T18:57:03.51611Z","steps":["trace[708588307] 'agreement among raft nodes before linearized reading' (duration: 351.914788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:57:03.516145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:57:03.17728Z","time spent":"338.853047ms","remote":"127.0.0.1:51054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-19T18:57:03.516155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:57:03.164057Z","time spent":"352.091699ms","remote":"127.0.0.1:51054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T18:57:05.872541Z","caller":"traceutil/trace.go:171","msg":"trace[935176490] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"236.081534ms","start":"2026-02-19T18:57:05.636426Z","end":"2026-02-19T18:57:05.872508Z","steps":["trace[935176490] 'process raft request' (duration: 235.879752ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T18:57:08.87723Z","caller":"traceutil/trace.go:171","msg":"trace[1940879350] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"210.07469ms","start":"2026-02-19T18:57:08.667115Z","end":"2026-02-19T18:57:08.87719Z","steps":["trace[1940879350] 'process raft request' (duration: 208.601069ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T18:57:47.58974Z","caller":"traceutil/trace.go:171","msg":"trace[1042918607] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"103.628313ms","start":"2026-02-19T18:57:47.48609Z","end":"2026-02-19T18:57:47.589718Z","steps":["trace[1042918607] 'process raft request' (duration: 90.625473ms)","trace[1042918607] 'compare' (duration: 12.908056ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T18:57:48.168128Z","caller":"traceutil/trace.go:171","msg":"trace[1684965346] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"283.457297ms","start":"2026-02-19T18:57:47.884634Z","end":"2026-02-19T18:57:48.168091Z","steps":["trace[1684965346] 'process raft request' (duration: 236.399694ms)","trace[1684965346] 'compare' (duration: 46.366997ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T18:57:48.225012Z","caller":"traceutil/trace.go:171","msg":"trace[2139966704] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:820; }","duration":"209.217493ms","start":"2026-02-19T18:57:48.015766Z","end":"2026-02-19T18:57:48.224983Z","steps":["trace[2139966704] 'read index received' (duration: 105.298282ms)","trace[2139966704] 'applied index is now lower than readState.Index' (duration: 103.917991ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T18:57:48.225126Z","caller":"traceutil/trace.go:171","msg":"trace[1461390493] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"337.490308ms","start":"2026-02-19T18:57:47.88759Z","end":"2026-02-19T18:57:48.22508Z","steps":["trace[1461390493] 'process raft request' (duration: 337.25878ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:57:48.225272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T18:57:47.887556Z","time spent":"337.640584ms","remote":"127.0.0.1:51054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T18:57:48.225259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.458451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T18:57:48.225405Z","caller":"traceutil/trace.go:171","msg":"trace[363942226] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:793; }","duration":"209.649178ms","start":"2026-02-19T18:57:48.015696Z","end":"2026-02-19T18:57:48.225345Z","steps":["trace[363942226] 'agreement among raft nodes before linearized reading' (duration: 209.42338ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T18:57:50.039325Z","caller":"traceutil/trace.go:171","msg":"trace[1017664711] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"124.917587ms","start":"2026-02-19T18:57:49.914373Z","end":"2026-02-19T18:57:50.039291Z","steps":["trace[1017664711] 'process raft request' (duration: 124.758471ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T18:57:54.136816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.631137ms","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-02-19T18:57:54.136962Z","caller":"traceutil/trace.go:171","msg":"trace[141830595] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:805; }","duration":"272.802163ms","start":"2026-02-19T18:57:53.86414Z","end":"2026-02-19T18:57:54.136942Z","steps":["trace[141830595] 'range keys from in-memory index tree' (duration: 272.444239ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T18:57:54.658618Z","caller":"traceutil/trace.go:171","msg":"trace[1869903052] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"280.242619ms","start":"2026-02-19T18:57:54.378345Z","end":"2026-02-19T18:57:54.658588Z","steps":["trace[1869903052] 'process raft request' (duration: 231.927923ms)","trace[1869903052] 'compare' (duration: 48.158591ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T18:58:36.300832Z","caller":"traceutil/trace.go:171","msg":"trace[26353377] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"270.836022ms","start":"2026-02-19T18:58:36.029953Z","end":"2026-02-19T18:58:36.300789Z","steps":["trace[26353377] 'process raft request' (duration: 270.670838ms)"],"step_count":1}