{"level":"warn","ts":"2026-02-17T19:16:41.485276Z","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-17T19:16:41.485507Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157: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.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-17T19:16:41.485623Z","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-17T19:16:41.485657Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-02-17T19:16:41.485709Z","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-17T19:16:41.486457Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-02-17T19:16:41.486603Z","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":2,"max-cpu-available":2,"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.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-17T19:16:41.490722Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.837955ms"} {"level":"info","ts":"2026-02-17T19:16:41.525016Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-02-17T19:16:41.525092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T19:16:41.525112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-02-17T19:16:41.525124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T19:16:41.525132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-02-17T19:16:41.525168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-02-17T19:16:41.53309Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T19:16:41.542573Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T19:16:41.5546Z","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-17T19:16:41.578208Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T19:16:41.607274Z","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-17T19:16:41.607674Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T19:16:41.607764Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T19:16:41.607895Z","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-17T19:16:41.608009Z","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-17T19:16:41.608056Z","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-17T19:16:41.608215Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-02-17T19:16:41.608248Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-02-17T19:16:41.611522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-02-17T19:16:41.616352Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T19:16:41.616541Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-02-17T19:16:42.528987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T19:16:42.529033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T19:16:42.529058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-02-17T19:16:42.529075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-02-17T19:16:42.529084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-02-17T19:16:42.529093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-02-17T19:16:42.529102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-02-17T19:16:42.539382Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T19:16:42.539537Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T19:16:42.539977Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T19:16:42.540168Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T19:16:42.551456Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T19:16:42.551559Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T19:16:42.551659Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T19:16:42.552181Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T19:16:42.557067Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-02-17T19:16:42.566197Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T19:16:42.566269Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T19:16:55.063718Z","caller":"traceutil/trace.go:171","msg":"trace[1993596221] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"189.420686ms","start":"2026-02-17T19:16:54.874275Z","end":"2026-02-17T19:16:55.063696Z","steps":["trace[1993596221] 'process raft request' (duration: 189.221175ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:16:59.187266Z","caller":"traceutil/trace.go:171","msg":"trace[509154300] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"198.720512ms","start":"2026-02-17T19:16:58.988529Z","end":"2026-02-17T19:16:59.187249Z","steps":["trace[509154300] 'process raft request' (duration: 158.619186ms)","trace[509154300] 'compare' (duration: 40.036106ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:16:59.478025Z","caller":"traceutil/trace.go:171","msg":"trace[1365328594] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"285.337671ms","start":"2026-02-17T19:16:59.192656Z","end":"2026-02-17T19:16:59.477994Z","steps":["trace[1365328594] 'process raft request' (duration: 285.281411ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:16:59.4783Z","caller":"traceutil/trace.go:171","msg":"trace[1925798339] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"286.369588ms","start":"2026-02-17T19:16:59.191923Z","end":"2026-02-17T19:16:59.478292Z","steps":["trace[1925798339] 'process raft request' (duration: 210.437296ms)","trace[1925798339] 'compare' (duration: 75.437329ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:16:59.92298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.295997ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:16:59.923058Z","caller":"traceutil/trace.go:171","msg":"trace[700575219] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"437.670679ms","start":"2026-02-17T19:16:59.485373Z","end":"2026-02-17T19:16:59.923044Z","steps":["trace[700575219] 'process raft request' (duration: 146.944868ms)","trace[700575219] 'compare' (duration: 290.064205ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:16:59.923097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:59.48536Z","time spent":"437.718289ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4015,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:16:59.92552Z","caller":"traceutil/trace.go:171","msg":"trace[1323967921] linearizableReadLoop","detail":"{readStateIndex:442; appliedIndex:437; }","duration":"297.954344ms","start":"2026-02-17T19:16:59.627556Z","end":"2026-02-17T19:16:59.92551Z","steps":["trace[1323967921] 'read index received' (duration: 4.767626ms)","trace[1323967921] 'applied index is now lower than readState.Index' (duration: 293.186008ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:16:59.9256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.040375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:16:59.925619Z","caller":"traceutil/trace.go:171","msg":"trace[1063948552] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:430; }","duration":"298.098585ms","start":"2026-02-17T19:16:59.627513Z","end":"2026-02-17T19:16:59.925612Z","steps":["trace[1063948552] 'agreement among raft nodes before linearized reading' (duration: 298.035785ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:16:59.926863Z","caller":"traceutil/trace.go:171","msg":"trace[500733454] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"439.822904ms","start":"2026-02-17T19:16:59.487031Z","end":"2026-02-17T19:16:59.926854Z","steps":["trace[500733454] 'process raft request' (duration: 438.368723ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:16:59.926917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:59.487024Z","time spent":"439.867494ms","remote":"127.0.0.1:48218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3773,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:16:59.927109Z","caller":"traceutil/trace.go:171","msg":"trace[388839168] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"439.3581ms","start":"2026-02-17T19:16:59.487743Z","end":"2026-02-17T19:16:59.927101Z","steps":["trace[388839168] 'process raft request' (duration: 437.704178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:16:59.92716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:59.487737Z","time spent":"439.396781ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:16:59.927431Z","caller":"traceutil/trace.go:171","msg":"trace[1549401195] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"439.17867ms","start":"2026-02-17T19:16:59.488242Z","end":"2026-02-17T19:16:59.927421Z","steps":["trace[1549401195] 'process raft request' (duration: 437.227955ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:16:59.927482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:59.488236Z","time spent":"439.22366ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:16:59.927669Z","caller":"traceutil/trace.go:171","msg":"trace[2099253792] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"438.02304ms","start":"2026-02-17T19:16:59.489636Z","end":"2026-02-17T19:16:59.927659Z","steps":["trace[2099253792] 'process raft request' (duration: 435.852474ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:16:59.92772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:59.489628Z","time spent":"438.068001ms","remote":"127.0.0.1:48218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3782,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:00.312917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.225326ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:17:00.312995Z","caller":"traceutil/trace.go:171","msg":"trace[1701411676] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"375.30066ms","start":"2026-02-17T19:16:59.937681Z","end":"2026-02-17T19:17:00.312982Z","steps":["trace[1701411676] 'process raft request' (duration: 266.949004ms)","trace[1701411676] 'compare' (duration: 108.007723ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:00.313038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:59.93765Z","time spent":"375.36812ms","remote":"127.0.0.1:48218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3818,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:00.3534Z","caller":"traceutil/trace.go:171","msg":"trace[1266778538] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:442; }","duration":"414.285956ms","start":"2026-02-17T19:16:59.939096Z","end":"2026-02-17T19:17:00.353382Z","steps":["trace[1266778538] 'read index received' (duration: 265.414183ms)","trace[1266778538] 'applied index is now lower than readState.Index' (duration: 148.870813ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:00.353497Z","caller":"traceutil/trace.go:171","msg":"trace[879852793] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"410.555798ms","start":"2026-02-17T19:16:59.942934Z","end":"2026-02-17T19:17:00.353489Z","steps":["trace[879852793] 'process raft request' (duration: 410.420697ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:00.353458Z","caller":"traceutil/trace.go:171","msg":"trace[534995724] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"414.350056ms","start":"2026-02-17T19:16:59.939053Z","end":"2026-02-17T19:17:00.353403Z","steps":["trace[534995724] 'process raft request' (duration: 414.193215ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:00.353566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:59.942925Z","time spent":"410.590658ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":689,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T19:17:00.353697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:59.939041Z","time spent":"414.501778ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3991,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:00.353789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.680819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:00.353812Z","caller":"traceutil/trace.go:171","msg":"trace[1481688637] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:433; }","duration":"414.719329ms","start":"2026-02-17T19:16:59.939086Z","end":"2026-02-17T19:17:00.353806Z","steps":["trace[1481688637] 'agreement among raft nodes before linearized reading' (duration: 414.657088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:00.353827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:59.939083Z","time spent":"414.740939ms","remote":"127.0.0.1:47738","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-17T19:17:00.353922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.952151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7237"} {"level":"info","ts":"2026-02-17T19:17:00.353937Z","caller":"traceutil/trace.go:171","msg":"trace[308184016] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:433; }","duration":"410.973051ms","start":"2026-02-17T19:16:59.942958Z","end":"2026-02-17T19:17:00.353931Z","steps":["trace[308184016] 'agreement among raft nodes before linearized reading' (duration: 410.942421ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:00.353953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:59.942955Z","time spent":"410.994731ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7259,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-02-17T19:17:00.354115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.625974ms","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-17T19:17:00.354136Z","caller":"traceutil/trace.go:171","msg":"trace[1005596139] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:433; }","duration":"346.671865ms","start":"2026-02-17T19:17:00.007458Z","end":"2026-02-17T19:17:00.35413Z","steps":["trace[1005596139] 'agreement among raft nodes before linearized reading' (duration: 346.624315ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:00.354153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:00.007443Z","time spent":"346.705425ms","remote":"127.0.0.1:47990","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-17T19:17:00.354303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.187659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4173"} {"level":"info","ts":"2026-02-17T19:17:00.354321Z","caller":"traceutil/trace.go:171","msg":"trace[1202620423] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:433; }","duration":"408.24909ms","start":"2026-02-17T19:16:59.946068Z","end":"2026-02-17T19:17:00.354317Z","steps":["trace[1202620423] 'agreement among raft nodes before linearized reading' (duration: 408.20929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:00.354334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:16:59.946045Z","time spent":"408.286691ms","remote":"127.0.0.1:48178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4195,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-02-17T19:17:00.829237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.489108ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:17:00.829336Z","caller":"traceutil/trace.go:171","msg":"trace[433830858] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"468.094707ms","start":"2026-02-17T19:17:00.361226Z","end":"2026-02-17T19:17:00.82932Z","steps":["trace[433830858] 'process raft request' (duration: 62.458588ms)","trace[433830858] 'compare' (duration: 405.344777ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:00.829375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:00.361198Z","time spent":"468.162028ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":721,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:17:01.019694Z","caller":"traceutil/trace.go:171","msg":"trace[1913610702] linearizableReadLoop","detail":"{readStateIndex:450; appliedIndex:446; }","duration":"430.36376ms","start":"2026-02-17T19:17:00.58931Z","end":"2026-02-17T19:17:01.019673Z","steps":["trace[1913610702] 'read index received' (duration: 407.398852ms)","trace[1913610702] 'applied index is now lower than readState.Index' (duration: 22.964048ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:01.021993Z","caller":"traceutil/trace.go:171","msg":"trace[2017915797] transaction","detail":"{read_only:false; number_of_response:1; response_revision:435; }","duration":"651.301212ms","start":"2026-02-17T19:17:00.370677Z","end":"2026-02-17T19:17:01.021979Z","steps":["trace[2017915797] 'process raft request' (duration: 626.089938ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.022157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:00.370655Z","time spent":"651.384923ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":55,"response count":0,"response size":40,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-02-17T19:17:01.022458Z","caller":"traceutil/trace.go:171","msg":"trace[1739175243] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"645.818492ms","start":"2026-02-17T19:17:00.376628Z","end":"2026-02-17T19:17:01.022447Z","steps":["trace[1739175243] 'process raft request' (duration: 642.907341ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.022546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:00.376612Z","time spent":"645.898093ms","remote":"127.0.0.1:48218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3818,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:01.022744Z","caller":"traceutil/trace.go:171","msg":"trace[996256126] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"642.329935ms","start":"2026-02-17T19:17:00.380404Z","end":"2026-02-17T19:17:01.022734Z","steps":["trace[996256126] 'process raft request' (duration: 639.179582ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.022802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:00.380387Z","time spent":"642.387797ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:01.022912Z","caller":"traceutil/trace.go:171","msg":"trace[363835475] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"639.545055ms","start":"2026-02-17T19:17:00.383359Z","end":"2026-02-17T19:17:01.022904Z","steps":["trace[363835475] 'process raft request' (duration: 636.278212ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.022964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:00.383336Z","time spent":"639.603146ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7222,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:01.023153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.837065ms","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-17T19:17:01.023207Z","caller":"traceutil/trace.go:171","msg":"trace[1144442948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:438; }","duration":"433.930115ms","start":"2026-02-17T19:17:00.589266Z","end":"2026-02-17T19:17:01.023196Z","steps":["trace[1144442948] 'agreement among raft nodes before linearized reading' (duration: 433.823795ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.023243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:00.589244Z","time spent":"433.991877ms","remote":"127.0.0.1:47990","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":"warn","ts":"2026-02-17T19:17:01.023481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.107077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T19:17:01.023528Z","caller":"traceutil/trace.go:171","msg":"trace[911761492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:438; }","duration":"434.170508ms","start":"2026-02-17T19:17:00.589347Z","end":"2026-02-17T19:17:01.023518Z","steps":["trace[911761492] 'agreement among raft nodes before linearized reading' (duration: 434.096787ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.023579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:00.589342Z","time spent":"434.218958ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T19:17:01.023931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.965385ms","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-17T19:17:01.023969Z","caller":"traceutil/trace.go:171","msg":"trace[178487485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:438; }","duration":"333.038415ms","start":"2026-02-17T19:17:00.690923Z","end":"2026-02-17T19:17:01.023961Z","steps":["trace[178487485] 'agreement among raft nodes before linearized reading' (duration: 332.974104ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.023994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:00.6909Z","time spent":"333.089395ms","remote":"127.0.0.1:47990","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":"warn","ts":"2026-02-17T19:17:01.456555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.616679ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:17:01.456667Z","caller":"traceutil/trace.go:171","msg":"trace[1308477656] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"414.090639ms","start":"2026-02-17T19:17:01.042558Z","end":"2026-02-17T19:17:01.456649Z","steps":["trace[1308477656] 'process raft request' (duration: 112.051587ms)","trace[1308477656] 'compare' (duration: 301.384257ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:01.456745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.042551Z","time spent":"414.170269ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3541,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:17:01.458722Z","caller":"traceutil/trace.go:171","msg":"trace[412722684] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"415.869582ms","start":"2026-02-17T19:17:01.042842Z","end":"2026-02-17T19:17:01.458711Z","steps":["trace[412722684] 'process raft request' (duration: 414.412861ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.458786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.042839Z","time spent":"415.913983ms","remote":"127.0.0.1:47990","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-17T19:17:01.458958Z","caller":"traceutil/trace.go:171","msg":"trace[597780399] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"416.140775ms","start":"2026-02-17T19:17:01.042806Z","end":"2026-02-17T19:17:01.458947Z","steps":["trace[597780399] 'process raft request' (duration: 414.390612ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.459004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.042802Z","time spent":"416.178065ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:01.459298Z","caller":"traceutil/trace.go:171","msg":"trace[969731195] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"416.429256ms","start":"2026-02-17T19:17:01.042862Z","end":"2026-02-17T19:17:01.459291Z","steps":["trace[969731195] 'process raft request' (duration: 414.415481ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.459334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.042859Z","time spent":"416.456276ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:01.459456Z","caller":"traceutil/trace.go:171","msg":"trace[1427046948] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"413.625926ms","start":"2026-02-17T19:17:01.045825Z","end":"2026-02-17T19:17:01.45945Z","steps":["trace[1427046948] 'process raft request' (duration: 411.4762ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.459491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.045818Z","time spent":"413.654007ms","remote":"127.0.0.1:48218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3782,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:01.461234Z","caller":"traceutil/trace.go:171","msg":"trace[1604660584] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"414.354751ms","start":"2026-02-17T19:17:01.046868Z","end":"2026-02-17T19:17:01.461223Z","steps":["trace[1604660584] 'process raft request' (duration: 410.467212ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.461301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.046861Z","time spent":"414.399471ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:17:01.464079Z","caller":"traceutil/trace.go:171","msg":"trace[1992266324] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"417.127011ms","start":"2026-02-17T19:17:01.046941Z","end":"2026-02-17T19:17:01.464068Z","steps":["trace[1992266324] 'process raft request' (duration: 415.480559ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.464274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.046938Z","time spent":"417.176142ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:17:01.464571Z","caller":"traceutil/trace.go:171","msg":"trace[1408259358] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"417.650765ms","start":"2026-02-17T19:17:01.046912Z","end":"2026-02-17T19:17:01.464563Z","steps":["trace[1408259358] 'process raft request' (duration: 410.451182ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.464627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.046909Z","time spent":"417.689865ms","remote":"127.0.0.1:48178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:01.464999Z","caller":"traceutil/trace.go:171","msg":"trace[1248871377] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"413.407044ms","start":"2026-02-17T19:17:01.051581Z","end":"2026-02-17T19:17:01.464988Z","steps":["trace[1248871377] 'process raft request' (duration: 410.898995ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:01.465084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.051574Z","time spent":"413.450484ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7030,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:02.152994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.464234ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-02-17T19:17:02.15324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.946234ms","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-02-17T19:17:02.153325Z","caller":"traceutil/trace.go:171","msg":"trace[97432865] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:447; }","duration":"349.030825ms","start":"2026-02-17T19:17:01.804276Z","end":"2026-02-17T19:17:02.153307Z","steps":["trace[97432865] 'range keys from in-memory index tree' (duration: 348.936924ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:02.153429Z","caller":"traceutil/trace.go:171","msg":"trace[1638130814] linearizableReadLoop","detail":"{readStateIndex:460; appliedIndex:451; }","duration":"992.798989ms","start":"2026-02-17T19:17:01.1606Z","end":"2026-02-17T19:17:02.153399Z","steps":["trace[1638130814] 'read index received' (duration: 296.567333ms)","trace[1638130814] 'applied index is now lower than readState.Index' (duration: 696.229546ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:02.153565Z","caller":"traceutil/trace.go:171","msg":"trace[882081396] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"691.534902ms","start":"2026-02-17T19:17:01.462021Z","end":"2026-02-17T19:17:02.153556Z","steps":["trace[882081396] 'process raft request' (duration: 691.073099ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:02.153676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.461989Z","time spent":"691.599322ms","remote":"127.0.0.1:48218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3818,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:03.539229Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084572873,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:03.891719Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.294065701s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T19:17:05.161735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000087294s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-17T19:17:05.161811Z","caller":"traceutil/trace.go:171","msg":"trace[1556330629] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000212085s","start":"2026-02-17T19:17:03.161581Z","end":"2026-02-17T19:17:05.161793Z","steps":["trace[1556330629] 'agreement among raft nodes before linearized reading' (duration: 2.000118844s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.161877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:03.161557Z","time spent":"2.000294416s","remote":"127.0.0.1:47738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/17 19:17:05 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T19:17:05.432691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.272077714s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:05.432753Z","caller":"traceutil/trace.go:171","msg":"trace[1528128353] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:448; }","duration":"4.272170544s","start":"2026-02-17T19:17:01.160567Z","end":"2026-02-17T19:17:05.432738Z","steps":["trace[1528128353] 'agreement among raft nodes before linearized reading' (duration: 992.928189ms)","trace[1528128353] 'range keys from in-memory index tree' (duration: 3.279148385s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:05.432782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.160539Z","time spent":"4.272236015s","remote":"127.0.0.1:47748","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-17T19:17:05.436714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.544743204s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:17:05.436954Z","caller":"traceutil/trace.go:171","msg":"trace[1169350213] transaction","detail":"{read_only:false; number_of_response:1; response_revision:452; }","duration":"3.958494417s","start":"2026-02-17T19:17:01.478447Z","end":"2026-02-17T19:17:05.436942Z","steps":["trace[1169350213] 'process raft request' (duration: 3.958442346s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.437026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.478437Z","time spent":"3.958552997s","remote":"127.0.0.1:48178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":45,"response count":0,"response size":4206,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:05.437168Z","caller":"traceutil/trace.go:171","msg":"trace[579577824] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"3.971645323s","start":"2026-02-17T19:17:01.465514Z","end":"2026-02-17T19:17:05.437159Z","steps":["trace[579577824] 'process raft request' (duration: 2.426413496s)","trace[579577824] 'compare' (duration: 1.541464051s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:05.437205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.465503Z","time spent":"3.971687224s","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:17:05.437355Z","caller":"traceutil/trace.go:171","msg":"trace[649033635] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"3.966151723s","start":"2026-02-17T19:17:01.471196Z","end":"2026-02-17T19:17:05.437348Z","steps":["trace[649033635] 'process raft request' (duration: 3.965577739s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.437396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.471181Z","time spent":"3.966195313s","remote":"127.0.0.1:48218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3782,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:05.437471Z","caller":"traceutil/trace.go:171","msg":"trace[2090686446] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"3.966202803s","start":"2026-02-17T19:17:01.471262Z","end":"2026-02-17T19:17:05.437465Z","steps":["trace[2090686446] 'process raft request' (duration: 3.965564809s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.43955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.471257Z","time spent":"3.966231284s","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:17:05.440154Z","caller":"traceutil/trace.go:171","msg":"trace[1166811332] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"3.966771666s","start":"2026-02-17T19:17:01.473371Z","end":"2026-02-17T19:17:05.440143Z","steps":["trace[1166811332] 'process raft request' (duration: 3.963484403s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.440201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:01.473362Z","time spent":"3.966814587s","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4015,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:05.47547Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.58361739s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T19:17:05.476321Z","caller":"traceutil/trace.go:171","msg":"trace[530572863] linearizableReadLoop","detail":"{readStateIndex:467; appliedIndex:461; }","duration":"2.438175674s","start":"2026-02-17T19:17:03.038124Z","end":"2026-02-17T19:17:05.476299Z","steps":["trace[530572863] 'read index received' (duration: 853.813289ms)","trace[530572863] 'applied index is now lower than readState.Index' (duration: 1.584361305s)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:05.476405Z","caller":"traceutil/trace.go:171","msg":"trace[2005465398] transaction","detail":"{read_only:false; number_of_response:1; response_revision:452; }","duration":"3.314276473s","start":"2026-02-17T19:17:02.162117Z","end":"2026-02-17T19:17:05.476394Z","steps":["trace[2005465398] 'process raft request' (duration: 3.31394688s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.476525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:02.162088Z","time spent":"3.314344203s","remote":"127.0.0.1:48218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":56,"response count":0,"response size":3866,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:05.477373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.439242341s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-17T19:17:05.477646Z","caller":"traceutil/trace.go:171","msg":"trace[1771047562] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:452; }","duration":"2.439368401s","start":"2026-02-17T19:17:03.038052Z","end":"2026-02-17T19:17:05.477421Z","steps":["trace[1771047562] 'agreement among raft nodes before linearized reading' (duration: 2.438788908s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.477949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:03.038017Z","time spent":"2.439677984s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T19:17:05.482032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.008494163s","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-17T19:17:05.482077Z","caller":"traceutil/trace.go:171","msg":"trace[1020739275] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:455; }","duration":"2.008596255s","start":"2026-02-17T19:17:03.473471Z","end":"2026-02-17T19:17:05.482067Z","steps":["trace[1020739275] 'agreement among raft nodes before linearized reading' (duration: 2.008516444s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.483534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:03.473442Z","time spent":"2.009989354s","remote":"127.0.0.1:47990","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-17T19:17:05.485075Z","caller":"traceutil/trace.go:171","msg":"trace[572352671] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"807.553403ms","start":"2026-02-17T19:17:04.677506Z","end":"2026-02-17T19:17:05.485059Z","steps":["trace[572352671] 'process raft request' (duration: 804.27671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.485319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:04.677482Z","time spent":"807.632203ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:05.485617Z","caller":"traceutil/trace.go:171","msg":"trace[1626331850] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"319.119614ms","start":"2026-02-17T19:17:05.166487Z","end":"2026-02-17T19:17:05.485606Z","steps":["trace[1626331850] 'process raft request' (duration: 315.371917ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.485801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:05.166466Z","time spent":"319.182394ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T19:17:05.487646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.71656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:05.487832Z","caller":"traceutil/trace.go:171","msg":"trace[1778155758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:455; }","duration":"318.778112ms","start":"2026-02-17T19:17:05.168902Z","end":"2026-02-17T19:17:05.48768Z","steps":["trace[1778155758] 'agreement among raft nodes before linearized reading' (duration: 318.714091ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.487874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:05.168894Z","time spent":"318.970783ms","remote":"127.0.0.1:47748","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-17T19:17:05.488322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.01079216s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T19:17:05.488358Z","caller":"traceutil/trace.go:171","msg":"trace[2082052383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:455; }","duration":"2.01084873s","start":"2026-02-17T19:17:03.477501Z","end":"2026-02-17T19:17:05.488349Z","steps":["trace[2082052383] 'agreement among raft nodes before linearized reading' (duration: 2.01078845s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.489977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:03.477491Z","time spent":"2.012477952s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T19:17:05.490257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.013868422s","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-17T19:17:05.490281Z","caller":"traceutil/trace.go:171","msg":"trace[989564968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:455; }","duration":"2.013912162s","start":"2026-02-17T19:17:03.476362Z","end":"2026-02-17T19:17:05.490274Z","steps":["trace[989564968] 'agreement among raft nodes before linearized reading' (duration: 2.013869682s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:05.490364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:03.476351Z","time spent":"2.014006832s","remote":"127.0.0.1:47990","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-17T19:17:07.641449Z","caller":"traceutil/trace.go:171","msg":"trace[304030430] linearizableReadLoop","detail":"{readStateIndex:479; appliedIndex:478; }","duration":"131.088939ms","start":"2026-02-17T19:17:07.51034Z","end":"2026-02-17T19:17:07.641429Z","steps":["trace[304030430] 'read index received' (duration: 130.963318ms)","trace[304030430] 'applied index is now lower than readState.Index' (duration: 125.041µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:07.641531Z","caller":"traceutil/trace.go:171","msg":"trace[646861708] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"138.994613ms","start":"2026-02-17T19:17:07.502531Z","end":"2026-02-17T19:17:07.641526Z","steps":["trace[646861708] 'process raft request' (duration: 138.807832ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:07.641715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.519037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T19:17:07.641796Z","caller":"traceutil/trace.go:171","msg":"trace[953301157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:463; }","duration":"129.613967ms","start":"2026-02-17T19:17:07.512167Z","end":"2026-02-17T19:17:07.641781Z","steps":["trace[953301157] 'agreement among raft nodes before linearized reading' (duration: 129.483796ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:07.641846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.490861ms","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-17T19:17:07.641869Z","caller":"traceutil/trace.go:171","msg":"trace[823545664] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:463; }","duration":"131.547302ms","start":"2026-02-17T19:17:07.510315Z","end":"2026-02-17T19:17:07.641862Z","steps":["trace[823545664] 'agreement among raft nodes before linearized reading' (duration: 131.493011ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:07.641931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.735358ms","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-17T19:17:07.641942Z","caller":"traceutil/trace.go:171","msg":"trace[252771245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:463; }","duration":"129.752148ms","start":"2026-02-17T19:17:07.512186Z","end":"2026-02-17T19:17:07.641938Z","steps":["trace[252771245] 'agreement among raft nodes before linearized reading' (duration: 129.730838ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:09.888205Z","caller":"traceutil/trace.go:171","msg":"trace[773129560] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"199.44659ms","start":"2026-02-17T19:17:09.688715Z","end":"2026-02-17T19:17:09.888162Z","steps":["trace[773129560] 'process raft request' (duration: 199.268289ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:09.888682Z","caller":"traceutil/trace.go:171","msg":"trace[1362507693] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"196.171457ms","start":"2026-02-17T19:17:09.692496Z","end":"2026-02-17T19:17:09.888667Z","steps":["trace[1362507693] 'process raft request' (duration: 196.147027ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:09.888852Z","caller":"traceutil/trace.go:171","msg":"trace[1035173131] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"196.400998ms","start":"2026-02-17T19:17:09.692446Z","end":"2026-02-17T19:17:09.888847Z","steps":["trace[1035173131] 'process raft request' (duration: 196.142467ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:12.009636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.522759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-17T19:17:12.009662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.466586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-17T19:17:12.009709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.699474ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-17T19:17:12.009776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.524516ms","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-17T19:17:12.010294Z","caller":"traceutil/trace.go:171","msg":"trace[1262208558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:472; }","duration":"117.04663ms","start":"2026-02-17T19:17:11.893236Z","end":"2026-02-17T19:17:12.010283Z","steps":["trace[1262208558] 'range keys from in-memory index tree' (duration: 116.490175ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:12.009958Z","caller":"traceutil/trace.go:171","msg":"trace[383439187] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:472; }","duration":"115.828471ms","start":"2026-02-17T19:17:11.894052Z","end":"2026-02-17T19:17:12.00988Z","steps":["trace[383439187] 'range keys from in-memory index tree' (duration: 115.426449ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:12.010119Z","caller":"traceutil/trace.go:171","msg":"trace[91675041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:472; }","duration":"116.905448ms","start":"2026-02-17T19:17:11.893133Z","end":"2026-02-17T19:17:12.010038Z","steps":["trace[91675041] 'range keys from in-memory index tree' (duration: 116.377775ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:12.010739Z","caller":"traceutil/trace.go:171","msg":"trace[491926674] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:472; }","duration":"207.724842ms","start":"2026-02-17T19:17:11.803003Z","end":"2026-02-17T19:17:12.010728Z","steps":["trace[491926674] 'range keys from in-memory index tree' (duration: 206.693724ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:16.404924Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084572997,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T19:17:16.838016Z","caller":"traceutil/trace.go:171","msg":"trace[1046401761] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.034120486s","start":"2026-02-17T19:17:15.803871Z","end":"2026-02-17T19:17:16.837992Z","steps":["trace[1046401761] 'process raft request' (duration: 1.033989275s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:16.83816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:15.803858Z","time spent":"1.034229116s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:18.164333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000234442s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-17T19:17:18.164411Z","caller":"traceutil/trace.go:171","msg":"trace[274942627] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000348203s","start":"2026-02-17T19:17:16.164046Z","end":"2026-02-17T19:17:18.164395Z","steps":["trace[274942627] 'agreement among raft nodes before linearized reading' (duration: 2.000250772s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:18.164454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:16.164033Z","time spent":"2.000411503s","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T19:17:18.193711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.049119ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:17:18.193808Z","caller":"traceutil/trace.go:171","msg":"trace[440483744] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:531; }","duration":"2.289624982s","start":"2026-02-17T19:17:15.904166Z","end":"2026-02-17T19:17:18.193791Z","steps":["trace[440483744] 'read index received' (duration: 935.319674ms)","trace[440483744] 'applied index is now lower than readState.Index' (duration: 1.354304308s)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:18.194109Z","caller":"traceutil/trace.go:171","msg":"trace[1768568365] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"2.369560657s","start":"2026-02-17T19:17:15.824533Z","end":"2026-02-17T19:17:18.194093Z","steps":["trace[1768568365] 'process raft request' (duration: 1.765043155s)","trace[1768568365] 'compare' (duration: 603.937268ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:18.194207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:15.824508Z","time spent":"2.369639007s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:18.194372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.290204036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T19:17:18.194397Z","caller":"traceutil/trace.go:171","msg":"trace[597315769] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:515; }","duration":"2.290248786s","start":"2026-02-17T19:17:15.904141Z","end":"2026-02-17T19:17:18.19439Z","steps":["trace[597315769] 'agreement among raft nodes before linearized reading' (duration: 2.290203185s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:18.194416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:15.904126Z","time spent":"2.290285396s","remote":"127.0.0.1:47750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.157\" "} {"level":"warn","ts":"2026-02-17T19:17:18.19458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.168003548s","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-17T19:17:18.194603Z","caller":"traceutil/trace.go:171","msg":"trace[1083642857] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"2.168049579s","start":"2026-02-17T19:17:16.026548Z","end":"2026-02-17T19:17:18.194597Z","steps":["trace[1083642857] 'agreement among raft nodes before linearized reading' (duration: 2.167963258s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:18.194622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:16.026534Z","time spent":"2.168083089s","remote":"127.0.0.1:47990","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":"warn","ts":"2026-02-17T19:17:18.194842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.367998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4019"} {"level":"info","ts":"2026-02-17T19:17:18.194868Z","caller":"traceutil/trace.go:171","msg":"trace[1789092625] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:515; }","duration":"848.397169ms","start":"2026-02-17T19:17:17.346465Z","end":"2026-02-17T19:17:18.194862Z","steps":["trace[1789092625] 'agreement among raft nodes before linearized reading' (duration: 848.353218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:18.194889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:17.346403Z","time spent":"848.481759ms","remote":"127.0.0.1:47902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4041,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-17T19:17:18.194977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.141641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:18.194999Z","caller":"traceutil/trace.go:171","msg":"trace[1694505470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"980.209332ms","start":"2026-02-17T19:17:17.214784Z","end":"2026-02-17T19:17:18.194993Z","steps":["trace[1694505470] 'agreement among raft nodes before linearized reading' (duration: 980.179772ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:18.195017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:17.214765Z","time spent":"980.249433ms","remote":"127.0.0.1:47748","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-17T19:17:18.195197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.139246156s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-17T19:17:18.195221Z","caller":"traceutil/trace.go:171","msg":"trace[480713391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"2.139293766s","start":"2026-02-17T19:17:16.055922Z","end":"2026-02-17T19:17:18.195216Z","steps":["trace[480713391] 'agreement among raft nodes before linearized reading' (duration: 2.139162325s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:18.19524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:16.055909Z","time spent":"2.139326946s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T19:17:18.195336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.165559722s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-17T19:17:18.195358Z","caller":"traceutil/trace.go:171","msg":"trace[1429818042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"2.165591082s","start":"2026-02-17T19:17:16.029761Z","end":"2026-02-17T19:17:18.195352Z","steps":["trace[1429818042] 'agreement among raft nodes before linearized reading' (duration: 2.165555161s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:18.195379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:16.029756Z","time spent":"2.165616582s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T19:17:25.454225Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573090,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:25.955184Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573090,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:26.456246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573090,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:26.957386Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573090,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:27.457863Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573090,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:27.95889Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573090,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:28.161259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000143988s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-17T19:17:28.161313Z","caller":"traceutil/trace.go:171","msg":"trace[137747306] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000230631s","start":"2026-02-17T19:17:26.161069Z","end":"2026-02-17T19:17:28.1613Z","steps":["trace[137747306] 'agreement among raft nodes before linearized reading' (duration: 2.000159457s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:28.161353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:26.161056Z","time spent":"2.000287244s","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T19:17:28.459355Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573090,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:28.942383Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.944095616s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T19:17:28.942725Z","caller":"traceutil/trace.go:171","msg":"trace[12926344] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"4.075155034s","start":"2026-02-17T19:17:24.867552Z","end":"2026-02-17T19:17:28.942707Z","steps":["trace[12926344] 'process raft request' (duration: 4.075038648s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:28.943073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:24.867519Z","time spent":"4.075486788s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:29.212134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000751539s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-17T19:17:29.212189Z","caller":"traceutil/trace.go:171","msg":"trace[1679724582] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000856404s","start":"2026-02-17T19:17:27.211319Z","end":"2026-02-17T19:17:29.212175Z","steps":["trace[1679724582] 'agreement among raft nodes before linearized reading' (duration: 2.00078322s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:29.21223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:27.211306Z","time spent":"2.000918777s","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T19:17:30.127359Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.184844476s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T19:17:30.162132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000533804s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-17T19:17:30.162288Z","caller":"traceutil/trace.go:171","msg":"trace[352513538] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000711683s","start":"2026-02-17T19:17:28.161545Z","end":"2026-02-17T19:17:30.162257Z","steps":["trace[352513538] 'agreement among raft nodes before linearized reading' (duration: 2.000541715s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:30.162349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:28.161537Z","time spent":"2.000800688s","remote":"127.0.0.1:47738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T19:17:31.256497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.00034647s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-17T19:17:31.256576Z","caller":"traceutil/trace.go:171","msg":"trace[400525359] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000464374s","start":"2026-02-17T19:17:26.256089Z","end":"2026-02-17T19:17:31.256553Z","steps":["trace[400525359] 'agreement among raft nodes before linearized reading' (duration: 5.00036889s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:31.256673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:26.256075Z","time spent":"5.000540707s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T19:17:31.907733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.536292ms","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-02-17T19:17:31.907883Z","caller":"traceutil/trace.go:171","msg":"trace[995373170] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:560; }","duration":"105.697569ms","start":"2026-02-17T19:17:31.802164Z","end":"2026-02-17T19:17:31.907862Z","steps":["trace[995373170] 'range keys from in-memory index tree' (duration: 105.519301ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:31.911047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.774104948s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:17:31.911715Z","caller":"traceutil/trace.go:171","msg":"trace[1056111365] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"2.696135942s","start":"2026-02-17T19:17:29.215564Z","end":"2026-02-17T19:17:31.911699Z","steps":["trace[1056111365] 'process raft request' (duration: 2.696083069s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:31.912146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:29.215547Z","time spent":"2.696215296s","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:17:31.91257Z","caller":"traceutil/trace.go:171","msg":"trace[968148835] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"3.48162463s","start":"2026-02-17T19:17:28.430927Z","end":"2026-02-17T19:17:31.912552Z","steps":["trace[968148835] 'process raft request' (duration: 1.703059691s)","trace[968148835] 'compare' (duration: 1.77352971s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:31.912888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:28.430909Z","time spent":"3.481738005s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:31.913334Z","caller":"traceutil/trace.go:171","msg":"trace[1068590727] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"3.376246946s","start":"2026-02-17T19:17:28.537073Z","end":"2026-02-17T19:17:31.91332Z","steps":["trace[1068590727] 'process raft request' (duration: 3.374048621s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:31.91341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:28.537056Z","time spent":"3.376318289s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:31.914338Z","caller":"traceutil/trace.go:171","msg":"trace[2075976915] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:579; }","duration":"6.965792659s","start":"2026-02-17T19:17:24.948531Z","end":"2026-02-17T19:17:31.914324Z","steps":["trace[2075976915] 'read index received' (duration: 3.995068936s)","trace[2075976915] 'applied index is now lower than readState.Index' (duration: 2.970722463s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:31.914705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.966161037s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hmwtf\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-17T19:17:31.915545Z","caller":"traceutil/trace.go:171","msg":"trace[2089489961] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hmwtf; range_end:; response_count:1; response_revision:563; }","duration":"6.967037757s","start":"2026-02-17T19:17:24.94849Z","end":"2026-02-17T19:17:31.915528Z","steps":["trace[2089489961] 'agreement among raft nodes before linearized reading' (duration: 6.966109073s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:31.91564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:24.948443Z","time spent":"6.967185502s","remote":"127.0.0.1:47906","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-hmwtf\" "} {"level":"warn","ts":"2026-02-17T19:17:31.914755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.973492259s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T19:17:31.915986Z","caller":"traceutil/trace.go:171","msg":"trace[1277912416] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:563; }","duration":"5.974731667s","start":"2026-02-17T19:17:25.941244Z","end":"2026-02-17T19:17:31.915975Z","steps":["trace[1277912416] 'agreement among raft nodes before linearized reading' (duration: 5.973383303s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:31.916086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:25.941202Z","time spent":"5.974870111s","remote":"127.0.0.1:47750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.157\" "} {"level":"warn","ts":"2026-02-17T19:17:31.916245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.208244ms","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-17T19:17:31.916745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.584671016s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T19:17:31.916847Z","caller":"traceutil/trace.go:171","msg":"trace[1386090416] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:563; }","duration":"970.419214ms","start":"2026-02-17T19:17:30.945864Z","end":"2026-02-17T19:17:31.916283Z","steps":["trace[1386090416] 'agreement among raft nodes before linearized reading' (duration: 969.489511ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:31.922284Z","caller":"traceutil/trace.go:171","msg":"trace[1469808563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:563; }","duration":"5.590228739s","start":"2026-02-17T19:17:26.332043Z","end":"2026-02-17T19:17:31.922271Z","steps":["trace[1469808563] 'agreement among raft nodes before linearized reading' (duration: 5.584670815s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:31.922403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:26.33203Z","time spent":"5.590359174s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T19:17:31.917006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.634033941s","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-17T19:17:31.922493Z","caller":"traceutil/trace.go:171","msg":"trace[1797092037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:563; }","duration":"5.639554402s","start":"2026-02-17T19:17:26.28293Z","end":"2026-02-17T19:17:31.922484Z","steps":["trace[1797092037] 'agreement among raft nodes before linearized reading' (duration: 5.634004949s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:31.922523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:26.282915Z","time spent":"5.639602093s","remote":"127.0.0.1:47990","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":"warn","ts":"2026-02-17T19:17:31.917137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.748797539s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:31.922587Z","caller":"traceutil/trace.go:171","msg":"trace[690067101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"1.754271208s","start":"2026-02-17T19:17:30.168311Z","end":"2026-02-17T19:17:31.922582Z","steps":["trace[690067101] 'agreement among raft nodes before linearized reading' (duration: 1.748804288s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:31.922601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:30.168295Z","time spent":"1.754303129s","remote":"127.0.0.1:47748","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-17T19:17:31.922339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:30.945851Z","time spent":"976.479291ms","remote":"127.0.0.1:47990","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-17T19:17:32.28643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.047207ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-02-17T19:17:32.286505Z","caller":"traceutil/trace.go:171","msg":"trace[1149240642] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:582; }","duration":"361.997304ms","start":"2026-02-17T19:17:31.924495Z","end":"2026-02-17T19:17:32.286492Z","steps":["trace[1149240642] 'read index received' (duration: 102.963508ms)","trace[1149240642] 'applied index is now lower than readState.Index' (duration: 259.032766ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:32.286554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.91997Z","time spent":"366.57799ms","remote":"127.0.0.1:47750","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-17T19:17:32.286676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.172752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:32.28669Z","caller":"traceutil/trace.go:171","msg":"trace[1102026073] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"362.215844ms","start":"2026-02-17T19:17:31.924469Z","end":"2026-02-17T19:17:32.286685Z","steps":["trace[1102026073] 'agreement among raft nodes before linearized reading' (duration: 362.180963ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:32.286704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.924461Z","time spent":"362.239375ms","remote":"127.0.0.1:47738","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-17T19:17:32.787304Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573103,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:33.287807Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573103,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:33.788683Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573103,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:34.289515Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573103,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:34.293044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000401864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-17T19:17:34.293122Z","caller":"traceutil/trace.go:171","msg":"trace[1342407798] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00053591s","start":"2026-02-17T19:17:32.292568Z","end":"2026-02-17T19:17:34.293104Z","steps":["trace[1342407798] 'agreement among raft nodes before linearized reading' (duration: 2.000433095s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:34.293168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:32.292555Z","time spent":"2.000603673s","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/17 19:17:34 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T19:17:34.789741Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573103,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:35.290381Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573103,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:35.791535Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084573103,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T19:17:35.820613Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.79308504s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T19:17:35.821248Z","caller":"traceutil/trace.go:171","msg":"trace[522715663] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"3.890308804s","start":"2026-02-17T19:17:31.930918Z","end":"2026-02-17T19:17:35.821227Z","steps":["trace[522715663] 'process raft request' (duration: 3.89020974s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:35.821416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.930913Z","time spent":"3.890399799s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:35.821666Z","caller":"traceutil/trace.go:171","msg":"trace[731717203] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"3.890782546s","start":"2026-02-17T19:17:31.93087Z","end":"2026-02-17T19:17:35.821652Z","steps":["trace[731717203] 'process raft request' (duration: 3.890119857s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:35.821752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.930859Z","time spent":"3.890831558s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:35.821896Z","caller":"traceutil/trace.go:171","msg":"trace[1648491648] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"3.889957675s","start":"2026-02-17T19:17:31.931915Z","end":"2026-02-17T19:17:35.821873Z","steps":["trace[1648491648] 'process raft request' (duration: 3.889275705s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:35.822053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.931909Z","time spent":"3.89004618s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:35.822129Z","caller":"traceutil/trace.go:171","msg":"trace[1320552288] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"3.889968986s","start":"2026-02-17T19:17:31.932146Z","end":"2026-02-17T19:17:35.822114Z","steps":["trace[1320552288] 'process raft request' (duration: 3.88938047s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:35.822227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.932136Z","time spent":"3.890021698s","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:36.084224Z","caller":"traceutil/trace.go:171","msg":"trace[607058445] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"3.796860664s","start":"2026-02-17T19:17:32.287346Z","end":"2026-02-17T19:17:36.084206Z","steps":["trace[607058445] 'process raft request' (duration: 3.767579628s)","trace[607058445] 'compare' (duration: 28.666829ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:36.084315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:32.287333Z","time spent":"3.796932818s","remote":"127.0.0.1:47750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:36.222384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.593031ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-02-17T19:17:36.222501Z","caller":"traceutil/trace.go:171","msg":"trace[1259425730] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:583; }","duration":"3.93596409s","start":"2026-02-17T19:17:32.286518Z","end":"2026-02-17T19:17:36.222482Z","steps":["trace[1259425730] 'read index received' (duration: 3.534427361s)","trace[1259425730] 'applied index is now lower than readState.Index' (duration: 401.535069ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:36.222789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.297713552s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18951ebce9a5c12e\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-02-17T19:17:36.222833Z","caller":"traceutil/trace.go:171","msg":"trace[232976887] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18951ebce9a5c12e; range_end:; response_count:1; response_revision:568; }","duration":"4.297782365s","start":"2026-02-17T19:17:31.925029Z","end":"2026-02-17T19:17:36.222811Z","steps":["trace[232976887] 'agreement among raft nodes before linearized reading' (duration: 4.297595277s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.222901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:31.925005Z","time spent":"4.29788658s","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":796,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18951ebce9a5c12e\" "} {"level":"warn","ts":"2026-02-17T19:17:36.223085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.965397754s","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-17T19:17:36.223136Z","caller":"traceutil/trace.go:171","msg":"trace[1085737236] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:568; }","duration":"2.965486008s","start":"2026-02-17T19:17:33.257637Z","end":"2026-02-17T19:17:36.223123Z","steps":["trace[1085737236] 'agreement among raft nodes before linearized reading' (duration: 2.965327821s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.223161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:33.257624Z","time spent":"2.965532951s","remote":"127.0.0.1:47990","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":"warn","ts":"2026-02-17T19:17:36.223344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.930151462s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-17T19:17:36.223397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.988675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-17T19:17:36.223413Z","caller":"traceutil/trace.go:171","msg":"trace[1290643969] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:568; }","duration":"138.021307ms","start":"2026-02-17T19:17:36.085387Z","end":"2026-02-17T19:17:36.223408Z","steps":["trace[1290643969] 'agreement among raft nodes before linearized reading' (duration: 137.989335ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:36.223408Z","caller":"traceutil/trace.go:171","msg":"trace[1273832871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:568; }","duration":"1.930233645s","start":"2026-02-17T19:17:34.29316Z","end":"2026-02-17T19:17:36.223393Z","steps":["trace[1273832871] 'agreement among raft nodes before linearized reading' (duration: 1.930155032s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.223463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:34.293145Z","time spent":"1.930310729s","remote":"127.0.0.1:47738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} 2026/02/17 19:17:36 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-02-17T19:17:36.408822Z","caller":"traceutil/trace.go:171","msg":"trace[1670386563] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:590; }","duration":"130.781774ms","start":"2026-02-17T19:17:36.278024Z","end":"2026-02-17T19:17:36.408805Z","steps":["trace[1670386563] 'read index received' (duration: 84.346792ms)","trace[1670386563] 'applied index is now lower than readState.Index' (duration: 46.434212ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:36.408917Z","caller":"traceutil/trace.go:171","msg":"trace[1680257822] transaction","detail":"{read_only:false; number_of_response:1; response_revision:570; }","duration":"148.712062ms","start":"2026-02-17T19:17:36.260192Z","end":"2026-02-17T19:17:36.408904Z","steps":["trace[1680257822] 'process raft request' (duration: 148.489422ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.409052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.805145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18951ebce9a5c12e\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-02-17T19:17:36.409146Z","caller":"traceutil/trace.go:171","msg":"trace[1967866799] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18951ebce9a5c12e; range_end:; response_count:1; response_revision:570; }","duration":"128.91795ms","start":"2026-02-17T19:17:36.280202Z","end":"2026-02-17T19:17:36.40912Z","steps":["trace[1967866799] 'agreement among raft nodes before linearized reading' (duration: 128.730931ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.409189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.961475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-02-17T19:17:36.409213Z","caller":"traceutil/trace.go:171","msg":"trace[517854432] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:570; }","duration":"173.006436ms","start":"2026-02-17T19:17:36.236199Z","end":"2026-02-17T19:17:36.409206Z","steps":["trace[517854432] 'agreement among raft nodes before linearized reading' (duration: 172.945694ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:36.409275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.745252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:36.409303Z","caller":"traceutil/trace.go:171","msg":"trace[43565361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"128.808376ms","start":"2026-02-17T19:17:36.28049Z","end":"2026-02-17T19:17:36.409299Z","steps":["trace[43565361] 'agreement among raft nodes before linearized reading' (duration: 128.769884ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:37.052051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.63269ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-02-17T19:17:37.052451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:36.416189Z","time spent":"636.258375ms","remote":"127.0.0.1:47750","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-17T19:17:37.12475Z","caller":"traceutil/trace.go:171","msg":"trace[1345849586] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"109.303206ms","start":"2026-02-17T19:17:37.015433Z","end":"2026-02-17T19:17:37.124736Z","steps":["trace[1345849586] 'process raft request' (duration: 109.199091ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:37.515389Z","caller":"traceutil/trace.go:171","msg":"trace[445709481] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"448.526516ms","start":"2026-02-17T19:17:37.066839Z","end":"2026-02-17T19:17:37.515366Z","steps":["trace[445709481] 'process raft request' (duration: 448.447093ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:37.515526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:37.066827Z","time spent":"448.62951ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16901,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:37.5158Z","caller":"traceutil/trace.go:171","msg":"trace[1825605527] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"460.503243ms","start":"2026-02-17T19:17:37.055283Z","end":"2026-02-17T19:17:37.515787Z","steps":["trace[1825605527] 'process raft request' (duration: 459.849295ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:37.515875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:37.055261Z","time spent":"460.571426ms","remote":"127.0.0.1:47750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:37.945444Z","caller":"traceutil/trace.go:171","msg":"trace[68325981] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"110.805012ms","start":"2026-02-17T19:17:37.834612Z","end":"2026-02-17T19:17:37.945417Z","steps":["trace[68325981] 'process raft request' (duration: 110.559412ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:38.257633Z","caller":"traceutil/trace.go:171","msg":"trace[990240002] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:598; }","duration":"238.431712ms","start":"2026-02-17T19:17:38.019185Z","end":"2026-02-17T19:17:38.257616Z","steps":["trace[990240002] 'read index received' (duration: 186.910338ms)","trace[990240002] 'applied index is now lower than readState.Index' (duration: 51.520824ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:38.257708Z","caller":"traceutil/trace.go:171","msg":"trace[1411096904] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"422.052838ms","start":"2026-02-17T19:17:37.835647Z","end":"2026-02-17T19:17:38.2577Z","steps":["trace[1411096904] 'process raft request' (duration: 370.44127ms)","trace[1411096904] 'compare' (duration: 51.400109ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:38.257748Z","caller":"traceutil/trace.go:171","msg":"trace[1748881462] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"422.031547ms","start":"2026-02-17T19:17:37.835693Z","end":"2026-02-17T19:17:38.257724Z","steps":["trace[1748881462] 'process raft request' (duration: 421.888891ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:38.257777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:37.835638Z","time spent":"422.086339ms","remote":"127.0.0.1:47990","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-17T19:17:38.257858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:37.835687Z","time spent":"422.1047ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:38.25792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.733265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4068"} {"level":"info","ts":"2026-02-17T19:17:38.257941Z","caller":"traceutil/trace.go:171","msg":"trace[1381737044] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:577; }","duration":"238.775817ms","start":"2026-02-17T19:17:38.019159Z","end":"2026-02-17T19:17:38.257935Z","steps":["trace[1381737044] 'agreement among raft nodes before linearized reading' (duration: 238.734045ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:38.258835Z","caller":"traceutil/trace.go:171","msg":"trace[2049264705] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"233.758058ms","start":"2026-02-17T19:17:38.025067Z","end":"2026-02-17T19:17:38.258825Z","steps":["trace[2049264705] 'process raft request' (duration: 233.597031ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:38.703886Z","caller":"traceutil/trace.go:171","msg":"trace[789271549] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"436.704666ms","start":"2026-02-17T19:17:38.266771Z","end":"2026-02-17T19:17:38.703476Z","steps":["trace[789271549] 'process raft request' (duration: 372.392246ms)","trace[789271549] 'compare' (duration: 64.215876ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:38.704012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:38.266758Z","time spent":"437.181967ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4347,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:40.35694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.843383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:40.357016Z","caller":"traceutil/trace.go:171","msg":"trace[1816639581] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"193.971968ms","start":"2026-02-17T19:17:40.163027Z","end":"2026-02-17T19:17:40.356999Z","steps":["trace[1816639581] 'range keys from in-memory index tree' (duration: 193.767329ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:40.521828Z","caller":"traceutil/trace.go:171","msg":"trace[222501321] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"155.356306ms","start":"2026-02-17T19:17:40.366449Z","end":"2026-02-17T19:17:40.521806Z","steps":["trace[222501321] 'process raft request' (duration: 155.21653ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:41.035791Z","caller":"traceutil/trace.go:171","msg":"trace[1892925037] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"669.296604ms","start":"2026-02-17T19:17:40.366474Z","end":"2026-02-17T19:17:41.03577Z","steps":["trace[1892925037] 'process raft request' (duration: 669.214811ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:41.035896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:40.36645Z","time spent":"669.394279ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:41.595289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:41.595402Z","caller":"traceutil/trace.go:171","msg":"trace[1662526673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"431.603706ms","start":"2026-02-17T19:17:41.163787Z","end":"2026-02-17T19:17:41.595391Z","steps":["trace[1662526673] 'range keys from in-memory index tree' (duration: 431.330606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:41.595425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:41.163769Z","time spent":"431.650649ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T19:17:42.221208Z","caller":"traceutil/trace.go:171","msg":"trace[342234049] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"183.825684ms","start":"2026-02-17T19:17:42.037359Z","end":"2026-02-17T19:17:42.221185Z","steps":["trace[342234049] 'process raft request' (duration: 183.704309ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:42.92341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.38228ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:17:42.923545Z","caller":"traceutil/trace.go:171","msg":"trace[1819048806] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:606; }","duration":"396.769357ms","start":"2026-02-17T19:17:42.526764Z","end":"2026-02-17T19:17:42.923533Z","steps":["trace[1819048806] 'read index received' (duration: 112.150707ms)","trace[1819048806] 'applied index is now lower than readState.Index' (duration: 284.61801ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:42.923671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.890602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-17T19:17:42.92369Z","caller":"traceutil/trace.go:171","msg":"trace[1850601733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"396.958805ms","start":"2026-02-17T19:17:42.526724Z","end":"2026-02-17T19:17:42.923683Z","steps":["trace[1850601733] 'agreement among raft nodes before linearized reading' (duration: 396.841771ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:42.923718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:42.526705Z","time spent":"397.007827ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-17T19:17:42.924441Z","caller":"traceutil/trace.go:171","msg":"trace[839264785] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"867.533709ms","start":"2026-02-17T19:17:42.056887Z","end":"2026-02-17T19:17:42.924421Z","steps":["trace[839264785] 'process raft request' (duration: 582.086724ms)","trace[839264785] 'compare' (duration: 284.297696ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:42.924499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:42.056869Z","time spent":"867.595802ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:42.924683Z","caller":"traceutil/trace.go:171","msg":"trace[554481543] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"798.125656ms","start":"2026-02-17T19:17:42.126544Z","end":"2026-02-17T19:17:42.924669Z","steps":["trace[554481543] 'process raft request' (duration: 796.929956ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:42.924723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:42.126528Z","time spent":"798.171968ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:42.925122Z","caller":"traceutil/trace.go:171","msg":"trace[849009692] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"705.961538ms","start":"2026-02-17T19:17:42.219103Z","end":"2026-02-17T19:17:42.925064Z","steps":["trace[849009692] 'process raft request' (duration: 704.401943ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:42.925162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:42.219085Z","time spent":"706.059343ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1524,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T19:17:43.305052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.236491ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:17:43.305145Z","caller":"traceutil/trace.go:171","msg":"trace[485673324] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"372.522906ms","start":"2026-02-17T19:17:42.932605Z","end":"2026-02-17T19:17:43.305128Z","steps":["trace[485673324] 'process raft request' (duration: 189.153309ms)","trace[485673324] 'compare' (duration: 182.966999ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:43.305216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:42.932593Z","time spent":"372.602479ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":749,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:17:43.305684Z","caller":"traceutil/trace.go:171","msg":"trace[1254683690] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:609; }","duration":"268.567284ms","start":"2026-02-17T19:17:43.037102Z","end":"2026-02-17T19:17:43.30567Z","steps":["trace[1254683690] 'read index received' (duration: 84.665905ms)","trace[1254683690] 'applied index is now lower than readState.Index' (duration: 183.900359ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:43.305865Z","caller":"traceutil/trace.go:171","msg":"trace[36033550] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"372.207072ms","start":"2026-02-17T19:17:42.933648Z","end":"2026-02-17T19:17:43.305855Z","steps":["trace[36033550] 'process raft request' (duration: 371.953602ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:43.305939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:42.933622Z","time spent":"372.275725ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:17:43.306146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.047153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hmwtf\" ","response":"range_response_count:1 size:16916"} {"level":"info","ts":"2026-02-17T19:17:43.308333Z","caller":"traceutil/trace.go:171","msg":"trace[934934985] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hmwtf; range_end:; response_count:1; response_revision:588; }","duration":"271.266985ms","start":"2026-02-17T19:17:43.037058Z","end":"2026-02-17T19:17:43.308325Z","steps":["trace[934934985] 'agreement among raft nodes before linearized reading' (duration: 269.003402ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:43.308009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.148297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-17T19:17:43.308443Z","caller":"traceutil/trace.go:171","msg":"trace[1646305678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:588; }","duration":"269.611996ms","start":"2026-02-17T19:17:43.038825Z","end":"2026-02-17T19:17:43.308437Z","steps":["trace[1646305678] 'agreement among raft nodes before linearized reading' (duration: 269.131757ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:43.308076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.801135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:43.30854Z","caller":"traceutil/trace.go:171","msg":"trace[917016391] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"146.299744ms","start":"2026-02-17T19:17:43.162235Z","end":"2026-02-17T19:17:43.308535Z","steps":["trace[917016391] 'agreement among raft nodes before linearized reading' (duration: 145.826335ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:43.563816Z","caller":"traceutil/trace.go:171","msg":"trace[1069064600] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"234.737825ms","start":"2026-02-17T19:17:43.329062Z","end":"2026-02-17T19:17:43.5638Z","steps":["trace[1069064600] 'process raft request' (duration: 234.681733ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:43.563997Z","caller":"traceutil/trace.go:171","msg":"trace[549267442] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"241.684479ms","start":"2026-02-17T19:17:43.322302Z","end":"2026-02-17T19:17:43.563986Z","steps":["trace[549267442] 'process raft request' (duration: 144.111684ms)","trace[549267442] 'compare' (duration: 97.109077ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:43.940377Z","caller":"traceutil/trace.go:171","msg":"trace[108469658] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"345.992901ms","start":"2026-02-17T19:17:43.594369Z","end":"2026-02-17T19:17:43.940362Z","steps":["trace[108469658] 'process raft request' (duration: 345.964169ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:43.940456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:43.594351Z","time spent":"346.069324ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":794,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:17:43.94086Z","caller":"traceutil/trace.go:171","msg":"trace[1003688470] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"362.26469ms","start":"2026-02-17T19:17:43.578587Z","end":"2026-02-17T19:17:43.940852Z","steps":["trace[1003688470] 'process raft request' (duration: 330.227425ms)","trace[1003688470] 'compare' (duration: 31.447051ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:43.943449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:43.578573Z","time spent":"362.305812ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5352,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:44.082814Z","caller":"traceutil/trace.go:171","msg":"trace[1610435962] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"131.331344ms","start":"2026-02-17T19:17:43.95147Z","end":"2026-02-17T19:17:44.082802Z","steps":["trace[1610435962] 'process raft request' (duration: 122.082919ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:44.212852Z","caller":"traceutil/trace.go:171","msg":"trace[2127834139] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"124.394367ms","start":"2026-02-17T19:17:44.088444Z","end":"2026-02-17T19:17:44.212838Z","steps":["trace[2127834139] 'process raft request' (duration: 101.371012ms)","trace[2127834139] 'compare' (duration: 22.741183ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:44.548233Z","caller":"traceutil/trace.go:171","msg":"trace[1690958765] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"154.893633ms","start":"2026-02-17T19:17:44.393326Z","end":"2026-02-17T19:17:44.54822Z","steps":["trace[1690958765] 'process raft request' (duration: 154.635393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:44.894027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.452213ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-02-17T19:17:44.894126Z","caller":"traceutil/trace.go:171","msg":"trace[1985621515] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"229.952348ms","start":"2026-02-17T19:17:44.664156Z","end":"2026-02-17T19:17:44.894109Z","steps":["trace[1985621515] 'read index received' (duration: 28.441783ms)","trace[1985621515] 'applied index is now lower than readState.Index' (duration: 201.509025ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:44.894321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.139857ms","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-17T19:17:44.894355Z","caller":"traceutil/trace.go:171","msg":"trace[1423490692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:602; }","duration":"230.210349ms","start":"2026-02-17T19:17:44.664135Z","end":"2026-02-17T19:17:44.894346Z","steps":["trace[1423490692] 'agreement among raft nodes before linearized reading' (duration: 230.027961ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:17:47.462408Z","caller":"traceutil/trace.go:171","msg":"trace[1277252055] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"137.660765ms","start":"2026-02-17T19:17:47.324729Z","end":"2026-02-17T19:17:47.462389Z","steps":["trace[1277252055] 'process raft request' (duration: 137.253658ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:58.318715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.887259ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:17:58.336754Z","caller":"traceutil/trace.go:171","msg":"trace[481317943] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"311.721763ms","start":"2026-02-17T19:17:58.025007Z","end":"2026-02-17T19:17:58.336729Z","steps":["trace[481317943] 'process raft request' (duration: 141.747558ms)","trace[481317943] 'compare' (duration: 151.792526ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:17:58.336935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:17:58.024989Z","time spent":"311.870879ms","remote":"127.0.0.1:47772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:17:58.339447Z","caller":"traceutil/trace.go:171","msg":"trace[1848776853] linearizableReadLoop","detail":"{readStateIndex:715; appliedIndex:713; }","duration":"178.471689ms","start":"2026-02-17T19:17:58.160938Z","end":"2026-02-17T19:17:58.33941Z","steps":["trace[1848776853] 'read index received' (duration: 5.799401ms)","trace[1848776853] 'applied index is now lower than readState.Index' (duration: 172.671678ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:17:58.33963Z","caller":"traceutil/trace.go:171","msg":"trace[1337159525] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"252.379839ms","start":"2026-02-17T19:17:58.087241Z","end":"2026-02-17T19:17:58.339621Z","steps":["trace[1337159525] 'process raft request' (duration: 249.887373ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:58.339826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.883373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:17:58.339877Z","caller":"traceutil/trace.go:171","msg":"trace[1622257004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:687; }","duration":"178.951046ms","start":"2026-02-17T19:17:58.16091Z","end":"2026-02-17T19:17:58.339861Z","steps":["trace[1622257004] 'agreement among raft nodes before linearized reading' (duration: 178.852102ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:17:58.354474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.507949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T19:17:58.354602Z","caller":"traceutil/trace.go:171","msg":"trace[1633907587] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:687; }","duration":"186.711395ms","start":"2026-02-17T19:17:58.167878Z","end":"2026-02-17T19:17:58.35459Z","steps":["trace[1633907587] 'agreement among raft nodes before linearized reading' (duration: 173.710235ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:00.459635Z","caller":"traceutil/trace.go:171","msg":"trace[253730147] linearizableReadLoop","detail":"{readStateIndex:726; appliedIndex:725; }","duration":"175.718494ms","start":"2026-02-17T19:18:00.283899Z","end":"2026-02-17T19:18:00.459618Z","steps":["trace[253730147] 'read index received' (duration: 175.391693ms)","trace[253730147] 'applied index is now lower than readState.Index' (duration: 326.181µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:00.459709Z","caller":"traceutil/trace.go:171","msg":"trace[122224512] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"186.944404ms","start":"2026-02-17T19:18:00.272759Z","end":"2026-02-17T19:18:00.459704Z","steps":["trace[122224512] 'process raft request' (duration: 186.645554ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:00.459922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.008844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-17T19:18:00.459946Z","caller":"traceutil/trace.go:171","msg":"trace[2022228226] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:698; }","duration":"176.044275ms","start":"2026-02-17T19:18:00.283896Z","end":"2026-02-17T19:18:00.45994Z","steps":["trace[2022228226] 'agreement among raft nodes before linearized reading' (duration: 175.948392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:00.460085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.977855ms","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-17T19:18:00.460104Z","caller":"traceutil/trace.go:171","msg":"trace[840623516] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:698; }","duration":"174.015665ms","start":"2026-02-17T19:18:00.286085Z","end":"2026-02-17T19:18:00.4601Z","steps":["trace[840623516] 'agreement among raft nodes before linearized reading' (duration: 173.958874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:00.780432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.076851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-17T19:18:00.780498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.038916ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:18:00.780512Z","caller":"traceutil/trace.go:171","msg":"trace[914361918] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:700; }","duration":"234.187405ms","start":"2026-02-17T19:18:00.546306Z","end":"2026-02-17T19:18:00.780494Z","steps":["trace[914361918] 'range keys from in-memory index tree' (duration: 234.004238ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:00.780601Z","caller":"traceutil/trace.go:171","msg":"trace[586296152] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"230.395557ms","start":"2026-02-17T19:18:00.550155Z","end":"2026-02-17T19:18:00.780551Z","steps":["trace[586296152] 'process raft request' (duration: 51.249107ms)","trace[586296152] 'compare' (duration: 178.905172ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:00.815873Z","caller":"traceutil/trace.go:171","msg":"trace[1589599840] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"265.414512ms","start":"2026-02-17T19:18:00.550437Z","end":"2026-02-17T19:18:00.815852Z","steps":["trace[1589599840] 'process raft request' (duration: 264.981098ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:00.816162Z","caller":"traceutil/trace.go:171","msg":"trace[764110910] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"265.696832ms","start":"2026-02-17T19:18:00.550447Z","end":"2026-02-17T19:18:00.816144Z","steps":["trace[764110910] 'process raft request' (duration: 265.315509ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:00.816429Z","caller":"traceutil/trace.go:171","msg":"trace[1629656985] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"265.907258ms","start":"2026-02-17T19:18:00.550516Z","end":"2026-02-17T19:18:00.816423Z","steps":["trace[1629656985] 'process raft request' (duration: 265.877387ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:00.816534Z","caller":"traceutil/trace.go:171","msg":"trace[2145650291] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"266.040663ms","start":"2026-02-17T19:18:00.550488Z","end":"2026-02-17T19:18:00.816529Z","steps":["trace[2145650291] 'process raft request' (duration: 265.599698ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.454005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.736861ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:18:01.465382Z","caller":"traceutil/trace.go:171","msg":"trace[1730442173] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"793.112842ms","start":"2026-02-17T19:18:00.67199Z","end":"2026-02-17T19:18:01.465103Z","steps":["trace[1730442173] 'process raft request' (duration: 529.166036ms)","trace[1730442173] 'compare' (duration: 250.533706ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:01.465436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:00.671974Z","time spent":"793.439393ms","remote":"127.0.0.1:47772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T19:18:01.471762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:00.832965Z","time spent":"638.795202ms","remote":"127.0.0.1:48236","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-17T19:18:01.471958Z","caller":"traceutil/trace.go:171","msg":"trace[1374090925] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"760.681031ms","start":"2026-02-17T19:18:00.71127Z","end":"2026-02-17T19:18:01.471951Z","steps":["trace[1374090925] 'process raft request' (duration: 752.763696ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.471998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:00.71125Z","time spent":"760.725082ms","remote":"127.0.0.1:47772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:01.47209Z","caller":"traceutil/trace.go:171","msg":"trace[204888327] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"688.547417ms","start":"2026-02-17T19:18:00.783537Z","end":"2026-02-17T19:18:01.472085Z","steps":["trace[204888327] 'process raft request' (duration: 688.148473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.472118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:00.783525Z","time spent":"688.580697ms","remote":"127.0.0.1:47990","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-17T19:18:01.472189Z","caller":"traceutil/trace.go:171","msg":"trace[696809293] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:729; }","duration":"788.06067ms","start":"2026-02-17T19:18:00.684111Z","end":"2026-02-17T19:18:01.472172Z","steps":["trace[696809293] 'read index received' (duration: 131.395072ms)","trace[696809293] 'applied index is now lower than readState.Index' (duration: 656.665008ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:01.472428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.314208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-17T19:18:01.472449Z","caller":"traceutil/trace.go:171","msg":"trace[818073034] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:708; }","duration":"788.35862ms","start":"2026-02-17T19:18:00.684085Z","end":"2026-02-17T19:18:01.472444Z","steps":["trace[818073034] 'agreement among raft nodes before linearized reading' (duration: 788.288857ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.472464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:00.684072Z","time spent":"788.38904ms","remote":"127.0.0.1:47772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4202,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-02-17T19:18:01.472551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.091461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/local-path-provisioner-6f56467975-fg96b\" ","response":"range_response_count:1 size:2858"} {"level":"info","ts":"2026-02-17T19:18:01.472568Z","caller":"traceutil/trace.go:171","msg":"trace[1299943385] range","detail":"{range_begin:/registry/pods/local-path-storage/local-path-provisioner-6f56467975-fg96b; range_end:; response_count:1; response_revision:708; }","duration":"644.129593ms","start":"2026-02-17T19:18:00.828435Z","end":"2026-02-17T19:18:01.472565Z","steps":["trace[1299943385] 'agreement among raft nodes before linearized reading' (duration: 644.076291ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.472582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:00.828423Z","time spent":"644.155453ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":2880,"request content":"key:\"/registry/pods/local-path-storage/local-path-provisioner-6f56467975-fg96b\" "} {"level":"warn","ts":"2026-02-17T19:18:01.472698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.687588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-02-17T19:18:01.472717Z","caller":"traceutil/trace.go:171","msg":"trace[397052716] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:708; }","duration":"388.729459ms","start":"2026-02-17T19:18:01.083983Z","end":"2026-02-17T19:18:01.472713Z","steps":["trace[397052716] 'agreement among raft nodes before linearized reading' (duration: 388.663587ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.472732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.083973Z","time spent":"388.75525ms","remote":"127.0.0.1:47772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":1,"response size":188517,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-17T19:18:01.472829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.616671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:01.472844Z","caller":"traceutil/trace.go:171","msg":"trace[587108245] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:708; }","duration":"313.649003ms","start":"2026-02-17T19:18:01.159192Z","end":"2026-02-17T19:18:01.472841Z","steps":["trace[587108245] 'agreement among raft nodes before linearized reading' (duration: 313.627362ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.472857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.159177Z","time spent":"313.677053ms","remote":"127.0.0.1:47748","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-17T19:18:01.473009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.12625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-17T19:18:01.473027Z","caller":"traceutil/trace.go:171","msg":"trace[664932888] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:708; }","duration":"411.159001ms","start":"2026-02-17T19:18:01.061864Z","end":"2026-02-17T19:18:01.473023Z","steps":["trace[664932888] 'agreement among raft nodes before linearized reading' (duration: 411.12808ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.47304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.061853Z","time spent":"411.183982ms","remote":"127.0.0.1:47920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":201,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "} {"level":"warn","ts":"2026-02-17T19:18:01.473109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.062708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-17T19:18:01.473124Z","caller":"traceutil/trace.go:171","msg":"trace[173763729] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:708; }","duration":"411.11772ms","start":"2026-02-17T19:18:01.062003Z","end":"2026-02-17T19:18:01.473121Z","steps":["trace[173763729] 'agreement among raft nodes before linearized reading' (duration: 411.093379ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.473137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.061983Z","time spent":"411.1509ms","remote":"127.0.0.1:47920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":201,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "} {"level":"warn","ts":"2026-02-17T19:18:01.47321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.278485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-02-17T19:18:01.473227Z","caller":"traceutil/trace.go:171","msg":"trace[717577869] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:708; }","duration":"411.301805ms","start":"2026-02-17T19:18:01.06192Z","end":"2026-02-17T19:18:01.473222Z","steps":["trace[717577869] 'agreement among raft nodes before linearized reading' (duration: 411.258494ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.473242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.061918Z","time spent":"411.321126ms","remote":"127.0.0.1:47920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":919,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-02-17T19:18:01.473466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.276367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T19:18:01.473486Z","caller":"traceutil/trace.go:171","msg":"trace[1000603337] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:708; }","duration":"572.307918ms","start":"2026-02-17T19:18:00.901174Z","end":"2026-02-17T19:18:01.473482Z","steps":["trace[1000603337] 'agreement among raft nodes before linearized reading' (duration: 572.261176ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.473502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:00.901168Z","time spent":"572.33119ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-17T19:18:01.473564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.931114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-17T19:18:01.47358Z","caller":"traceutil/trace.go:171","msg":"trace[2017384415] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:708; }","duration":"413.965945ms","start":"2026-02-17T19:18:01.059611Z","end":"2026-02-17T19:18:01.473577Z","steps":["trace[2017384415] 'agreement among raft nodes before linearized reading' (duration: 413.941014ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.473592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.059596Z","time spent":"413.993336ms","remote":"127.0.0.1:47920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":201,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "} {"level":"warn","ts":"2026-02-17T19:18:01.473894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.963116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-02-17T19:18:01.473916Z","caller":"traceutil/trace.go:171","msg":"trace[154248245] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:708; }","duration":"590.011687ms","start":"2026-02-17T19:18:00.883899Z","end":"2026-02-17T19:18:01.473911Z","steps":["trace[154248245] 'agreement among raft nodes before linearized reading' (duration: 589.848672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.473933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:00.88387Z","time spent":"590.059829ms","remote":"127.0.0.1:47772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5199,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-02-17T19:18:01.846299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.463341ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:18:01.846367Z","caller":"traceutil/trace.go:171","msg":"trace[1331640772] linearizableReadLoop","detail":"{readStateIndex:738; appliedIndex:737; }","duration":"357.510053ms","start":"2026-02-17T19:18:01.488845Z","end":"2026-02-17T19:18:01.846355Z","steps":["trace[1331640772] 'read index received' (duration: 178.949388ms)","trace[1331640772] 'applied index is now lower than readState.Index' (duration: 178.559795ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:01.846418Z","caller":"traceutil/trace.go:171","msg":"trace[611165774] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"357.748731ms","start":"2026-02-17T19:18:01.488661Z","end":"2026-02-17T19:18:01.846409Z","steps":["trace[611165774] 'process raft request' (duration: 179.126824ms)","trace[611165774] 'compare' (duration: 178.255494ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:01.846458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.488644Z","time spent":"357.796743ms","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":708,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T19:18:01.846744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.854684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:01.846828Z","caller":"traceutil/trace.go:171","msg":"trace[876035908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:709; }","duration":"357.984909ms","start":"2026-02-17T19:18:01.488824Z","end":"2026-02-17T19:18:01.846809Z","steps":["trace[876035908] 'agreement among raft nodes before linearized reading' (duration: 357.748801ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.846872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.488818Z","time spent":"358.045991ms","remote":"127.0.0.1:47738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T19:18:01.847237Z","caller":"traceutil/trace.go:171","msg":"trace[1286413945] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"358.238326ms","start":"2026-02-17T19:18:01.488987Z","end":"2026-02-17T19:18:01.847225Z","steps":["trace[1286413945] 'process raft request' (duration: 357.745259ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.847312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.488983Z","time spent":"358.283297ms","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":796,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:18:01.847443Z","caller":"traceutil/trace.go:171","msg":"trace[410467483] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"358.418762ms","start":"2026-02-17T19:18:01.489015Z","end":"2026-02-17T19:18:01.847434Z","steps":["trace[410467483] 'process raft request' (duration: 357.748449ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.847486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.489011Z","time spent":"358.453253ms","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":708,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:18:01.847593Z","caller":"traceutil/trace.go:171","msg":"trace[596046997] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"358.548818ms","start":"2026-02-17T19:18:01.489036Z","end":"2026-02-17T19:18:01.847585Z","steps":["trace[596046997] 'process raft request' (duration: 357.74338ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.847632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.489033Z","time spent":"358.579658ms","remote":"127.0.0.1:48236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":708,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:18:01.847974Z","caller":"traceutil/trace.go:171","msg":"trace[881522050] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"358.082372ms","start":"2026-02-17T19:18:01.489882Z","end":"2026-02-17T19:18:01.847964Z","steps":["trace[881522050] 'process raft request' (duration: 356.916312ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.848036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.489877Z","time spent":"358.122523ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3781,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:01.848247Z","caller":"traceutil/trace.go:171","msg":"trace[1587788586] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"337.819793ms","start":"2026-02-17T19:18:01.510418Z","end":"2026-02-17T19:18:01.848238Z","steps":["trace[1587788586] 'process raft request' (duration: 336.432256ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:01.848298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.5104Z","time spent":"337.869164ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:18:02.062396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.46369ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-02-17T19:18:02.064048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.667592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T19:18:02.064078Z","caller":"traceutil/trace.go:171","msg":"trace[1345156716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:715; }","duration":"387.728384ms","start":"2026-02-17T19:18:01.676343Z","end":"2026-02-17T19:18:02.064071Z","steps":["trace[1345156716] 'agreement among raft nodes before linearized reading' (duration: 387.557848ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.064105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.676331Z","time spent":"387.769605ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-17T19:18:02.064226Z","caller":"traceutil/trace.go:171","msg":"trace[328750390] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"429.98555ms","start":"2026-02-17T19:18:01.634234Z","end":"2026-02-17T19:18:02.064219Z","steps":["trace[328750390] 'process raft request' (duration: 428.351025ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.065049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.634214Z","time spent":"430.071493ms","remote":"127.0.0.1:47772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:18:02.065222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.607809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:02.065252Z","caller":"traceutil/trace.go:171","msg":"trace[1629029600] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:715; }","duration":"359.649961ms","start":"2026-02-17T19:18:01.705594Z","end":"2026-02-17T19:18:02.065244Z","steps":["trace[1629029600] 'agreement among raft nodes before linearized reading' (duration: 359.60264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.065285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.705591Z","time spent":"359.683822ms","remote":"127.0.0.1:42668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" "} {"level":"warn","ts":"2026-02-17T19:18:02.065417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.826397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:02.065445Z","caller":"traceutil/trace.go:171","msg":"trace[166605228] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:715; }","duration":"359.874669ms","start":"2026-02-17T19:18:01.705562Z","end":"2026-02-17T19:18:02.065436Z","steps":["trace[166605228] 'agreement among raft nodes before linearized reading' (duration: 359.834757ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.065466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.705549Z","time spent":"359.912629ms","remote":"127.0.0.1:42668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" "} {"level":"warn","ts":"2026-02-17T19:18:02.065838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.873481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-fs8f2\" ","response":"range_response_count:1 size:3813"} {"level":"info","ts":"2026-02-17T19:18:02.065871Z","caller":"traceutil/trace.go:171","msg":"trace[1149293068] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-fs8f2; range_end:; response_count:1; response_revision:715; }","duration":"576.912992ms","start":"2026-02-17T19:18:01.48895Z","end":"2026-02-17T19:18:02.065863Z","steps":["trace[1149293068] 'agreement among raft nodes before linearized reading' (duration: 576.825899ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.065894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.488947Z","time spent":"576.940993ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":3835,"request content":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-fs8f2\" "} {"level":"warn","ts":"2026-02-17T19:18:02.066031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.357761ms","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-17T19:18:02.066056Z","caller":"traceutil/trace.go:171","msg":"trace[349068716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:715; }","duration":"430.397903ms","start":"2026-02-17T19:18:01.63565Z","end":"2026-02-17T19:18:02.066048Z","steps":["trace[349068716] 'agreement among raft nodes before linearized reading' (duration: 430.330279ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.066073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.635645Z","time spent":"430.424653ms","remote":"127.0.0.1:47990","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":"warn","ts":"2026-02-17T19:18:02.066313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.363218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-m2g82\" ","response":"range_response_count:1 size:3849"} {"level":"info","ts":"2026-02-17T19:18:02.066334Z","caller":"traceutil/trace.go:171","msg":"trace[1271473827] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-m2g82; range_end:; response_count:1; response_revision:715; }","duration":"577.387779ms","start":"2026-02-17T19:18:01.488939Z","end":"2026-02-17T19:18:02.066327Z","steps":["trace[1271473827] 'agreement among raft nodes before linearized reading' (duration: 577.327777ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.066352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.488936Z","time spent":"577.41089ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":3871,"request content":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-m2g82\" "} {"level":"warn","ts":"2026-02-17T19:18:02.066504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.568144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/local-path-provisioner-6f56467975-fg96b\" ","response":"range_response_count:1 size:3796"} {"level":"info","ts":"2026-02-17T19:18:02.066531Z","caller":"traceutil/trace.go:171","msg":"trace[1340021636] range","detail":"{range_begin:/registry/pods/local-path-storage/local-path-provisioner-6f56467975-fg96b; range_end:; response_count:1; response_revision:715; }","duration":"577.599655ms","start":"2026-02-17T19:18:01.488924Z","end":"2026-02-17T19:18:02.066523Z","steps":["trace[1340021636] 'agreement among raft nodes before linearized reading' (duration: 577.539923ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.066552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.48892Z","time spent":"577.627337ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":3818,"request content":"key:\"/registry/pods/local-path-storage/local-path-provisioner-6f56467975-fg96b\" "} {"level":"info","ts":"2026-02-17T19:18:02.063869Z","caller":"traceutil/trace.go:171","msg":"trace[835387222] linearizableReadLoop","detail":"{readStateIndex:745; appliedIndex:738; }","duration":"217.469237ms","start":"2026-02-17T19:18:01.846387Z","end":"2026-02-17T19:18:02.063856Z","steps":["trace[835387222] 'read index received' (duration: 318.5µs)","trace[835387222] 'applied index is now lower than readState.Index' (duration: 217.149977ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:02.066783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.907077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-jkvlx\" ","response":"range_response_count:1 size:3849"} {"level":"info","ts":"2026-02-17T19:18:02.066809Z","caller":"traceutil/trace.go:171","msg":"trace[1396426938] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-jkvlx; range_end:; response_count:1; response_revision:715; }","duration":"577.940107ms","start":"2026-02-17T19:18:01.488863Z","end":"2026-02-17T19:18:02.066803Z","steps":["trace[1396426938] 'agreement among raft nodes before linearized reading' (duration: 577.868245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.06683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:01.48886Z","time spent":"577.966128ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":3871,"request content":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-jkvlx\" "} {"level":"warn","ts":"2026-02-17T19:18:02.102688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.946972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-fs8f2\" ","response":"range_response_count:1 size:3813"} {"level":"info","ts":"2026-02-17T19:18:02.102732Z","caller":"traceutil/trace.go:171","msg":"trace[929390206] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-fs8f2; range_end:; response_count:1; response_revision:716; }","duration":"250.020785ms","start":"2026-02-17T19:18:01.852702Z","end":"2026-02-17T19:18:02.102723Z","steps":["trace[929390206] 'agreement among raft nodes before linearized reading' (duration: 249.898221ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:02.498323Z","caller":"traceutil/trace.go:171","msg":"trace[1067349668] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"358.025521ms","start":"2026-02-17T19:18:02.14028Z","end":"2026-02-17T19:18:02.498306Z","steps":["trace[1067349668] 'process raft request' (duration: 357.98899ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.498429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:02.140262Z","time spent":"358.109804ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4682,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:02.498612Z","caller":"traceutil/trace.go:171","msg":"trace[154400215] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"383.900609ms","start":"2026-02-17T19:18:02.114704Z","end":"2026-02-17T19:18:02.498604Z","steps":["trace[154400215] 'process raft request' (duration: 383.3311ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.498641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:02.114688Z","time spent":"383.940821ms","remote":"127.0.0.1:42668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1653,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:18:02.498775Z","caller":"traceutil/trace.go:171","msg":"trace[746626853] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"377.176696ms","start":"2026-02-17T19:18:02.121592Z","end":"2026-02-17T19:18:02.498769Z","steps":["trace[746626853] 'process raft request' (duration: 376.527945ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.498807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:02.121577Z","time spent":"377.215298ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:02.498866Z","caller":"traceutil/trace.go:171","msg":"trace[1544152998] transaction","detail":"{read_only:false; number_of_response:0; response_revision:719; }","duration":"377.215107ms","start":"2026-02-17T19:18:02.121647Z","end":"2026-02-17T19:18:02.498863Z","steps":["trace[1544152998] 'process raft request' (duration: 376.507664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.498889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:02.121643Z","time spent":"377.237818ms","remote":"127.0.0.1:42668","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:18:02.500186Z","caller":"traceutil/trace.go:171","msg":"trace[468432359] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"376.11099ms","start":"2026-02-17T19:18:02.124067Z","end":"2026-02-17T19:18:02.500178Z","steps":["trace[468432359] 'process raft request' (duration: 374.100254ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.500229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:02.124057Z","time spent":"376.151671ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":799,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:18:02.500618Z","caller":"traceutil/trace.go:171","msg":"trace[832297449] linearizableReadLoop","detail":"{readStateIndex:752; appliedIndex:752; }","duration":"325.092049ms","start":"2026-02-17T19:18:02.17552Z","end":"2026-02-17T19:18:02.500612Z","steps":["trace[832297449] 'read index received' (duration: 325.089058ms)","trace[832297449] 'applied index is now lower than readState.Index' (duration: 2.26µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:02.500657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.13727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:02.500673Z","caller":"traceutil/trace.go:171","msg":"trace[2130548160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:721; }","duration":"325.179351ms","start":"2026-02-17T19:18:02.175489Z","end":"2026-02-17T19:18:02.500668Z","steps":["trace[2130548160] 'agreement among raft nodes before linearized reading' (duration: 325.15218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.500687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:02.175466Z","time spent":"325.218323ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T19:18:02.757326Z","caller":"traceutil/trace.go:171","msg":"trace[984740919] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:752; }","duration":"256.67573ms","start":"2026-02-17T19:18:02.500631Z","end":"2026-02-17T19:18:02.757307Z","steps":["trace[984740919] 'read index received' (duration: 228.374822ms)","trace[984740919] 'applied index is now lower than readState.Index' (duration: 28.300138ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:02.759576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.84869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1668"} {"level":"info","ts":"2026-02-17T19:18:02.759651Z","caller":"traceutil/trace.go:171","msg":"trace[1281916755] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:723; }","duration":"254.976285ms","start":"2026-02-17T19:18:02.504659Z","end":"2026-02-17T19:18:02.759635Z","steps":["trace[1281916755] 'agreement among raft nodes before linearized reading' (duration: 254.735597ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:02.76078Z","caller":"traceutil/trace.go:171","msg":"trace[1311817312] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"253.779314ms","start":"2026-02-17T19:18:02.506937Z","end":"2026-02-17T19:18:02.760716Z","steps":["trace[1311817312] 'process raft request' (duration: 252.328956ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:02.76239Z","caller":"traceutil/trace.go:171","msg":"trace[65151524] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"551.497836ms","start":"2026-02-17T19:18:02.210869Z","end":"2026-02-17T19:18:02.762367Z","steps":["trace[65151524] 'process raft request' (duration: 518.12732ms)","trace[65151524] 'compare' (duration: 28.067ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:02.76388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:02.210852Z","time spent":"551.59385ms","remote":"127.0.0.1:47772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:18:02.764292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.522265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-02-17T19:18:02.764909Z","caller":"traceutil/trace.go:171","msg":"trace[2065747589] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:723; }","duration":"183.607238ms","start":"2026-02-17T19:18:02.580732Z","end":"2026-02-17T19:18:02.764339Z","steps":["trace[2065747589] 'agreement among raft nodes before linearized reading' (duration: 183.379321ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.766258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.216298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:02.766286Z","caller":"traceutil/trace.go:171","msg":"trace[1113102851] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:723; }","duration":"510.2732ms","start":"2026-02-17T19:18:02.256002Z","end":"2026-02-17T19:18:02.766275Z","steps":["trace[1113102851] 'agreement among raft nodes before linearized reading' (duration: 510.234968ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.766398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:02.255984Z","time spent":"510.378002ms","remote":"127.0.0.1:47792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-02-17T19:18:02.767478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.267348ms","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-17T19:18:02.767505Z","caller":"traceutil/trace.go:171","msg":"trace[994959527] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:723; }","duration":"253.325811ms","start":"2026-02-17T19:18:02.514169Z","end":"2026-02-17T19:18:02.767495Z","steps":["trace[994959527] 'agreement among raft nodes before linearized reading' (duration: 253.185676ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.768861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.392206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-m2g82\" ","response":"range_response_count:1 size:3849"} {"level":"info","ts":"2026-02-17T19:18:02.76889Z","caller":"traceutil/trace.go:171","msg":"trace[728254361] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-m2g82; range_end:; response_count:1; response_revision:723; }","duration":"261.427208ms","start":"2026-02-17T19:18:02.507452Z","end":"2026-02-17T19:18:02.768879Z","steps":["trace[728254361] 'agreement among raft nodes before linearized reading' (duration: 261.17019ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:02.772442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.740167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:02.772628Z","caller":"traceutil/trace.go:171","msg":"trace[1758234606] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:723; }","duration":"267.774669ms","start":"2026-02-17T19:18:02.504684Z","end":"2026-02-17T19:18:02.772459Z","steps":["trace[1758234606] 'agreement among raft nodes before linearized reading' (duration: 267.619794ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:03.142919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.83083ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:18:03.143001Z","caller":"traceutil/trace.go:171","msg":"trace[263132098] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"341.828044ms","start":"2026-02-17T19:18:02.80116Z","end":"2026-02-17T19:18:03.142988Z","steps":["trace[263132098] 'process raft request' (duration: 67.86653ms)","trace[263132098] 'compare' (duration: 273.639404ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:03.143033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:02.801146Z","time spent":"341.875026ms","remote":"127.0.0.1:47786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":865,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T19:18:03.182765Z","caller":"traceutil/trace.go:171","msg":"trace[1588881808] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"381.099663ms","start":"2026-02-17T19:18:02.801642Z","end":"2026-02-17T19:18:03.182741Z","steps":["trace[1588881808] 'process raft request' (duration: 380.359959ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:03.183236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:02.801637Z","time spent":"381.500386ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4718,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:03.184655Z","caller":"traceutil/trace.go:171","msg":"trace[309357737] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"383.111789ms","start":"2026-02-17T19:18:02.801497Z","end":"2026-02-17T19:18:03.184608Z","steps":["trace[309357737] 'process raft request' (duration: 380.639477ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:03.185007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:02.801491Z","time spent":"383.336296ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:18:03.520777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.886015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:18:03.520993Z","caller":"traceutil/trace.go:171","msg":"trace[471765989] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"318.491818ms","start":"2026-02-17T19:18:03.202478Z","end":"2026-02-17T19:18:03.52097Z","steps":["trace[471765989] 'process raft request' (duration: 62.327145ms)","trace[471765989] 'compare' (duration: 255.76057ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:03.521074Z","caller":"traceutil/trace.go:171","msg":"trace[722931321] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"195.177853ms","start":"2026-02-17T19:18:03.325882Z","end":"2026-02-17T19:18:03.521059Z","steps":["trace[722931321] 'process raft request' (duration: 195.125251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:03.521103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:03.202463Z","time spent":"318.580471ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4718,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:03.521415Z","caller":"traceutil/trace.go:171","msg":"trace[989007622] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"318.605891ms","start":"2026-02-17T19:18:03.202802Z","end":"2026-02-17T19:18:03.521408Z","steps":["trace[989007622] 'process raft request' (duration: 318.088275ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:03.521708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:03.202796Z","time spent":"318.869931ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:03.521802Z","caller":"traceutil/trace.go:171","msg":"trace[2026441561] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"207.139045ms","start":"2026-02-17T19:18:03.314651Z","end":"2026-02-17T19:18:03.52179Z","steps":["trace[2026441561] 'process raft request' (duration: 206.331579ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:03.522018Z","caller":"traceutil/trace.go:171","msg":"trace[300751165] linearizableReadLoop","detail":"{readStateIndex:759; appliedIndex:757; }","duration":"267.717562ms","start":"2026-02-17T19:18:03.254287Z","end":"2026-02-17T19:18:03.522005Z","steps":["trace[300751165] 'read index received' (duration: 10.522065ms)","trace[300751165] 'applied index is now lower than readState.Index' (duration: 257.194277ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:03.522113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.815975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:03.522142Z","caller":"traceutil/trace.go:171","msg":"trace[1616858142] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:731; }","duration":"267.870967ms","start":"2026-02-17T19:18:03.254261Z","end":"2026-02-17T19:18:03.522132Z","steps":["trace[1616858142] 'agreement among raft nodes before linearized reading' (duration: 267.817145ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:03.522144Z","caller":"traceutil/trace.go:171","msg":"trace[889713952] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"251.849482ms","start":"2026-02-17T19:18:03.270286Z","end":"2026-02-17T19:18:03.522136Z","steps":["trace[889713952] 'process raft request' (duration: 250.647673ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:03.522306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.970439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:03.522333Z","caller":"traceutil/trace.go:171","msg":"trace[533883017] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:731; }","duration":"267.99602ms","start":"2026-02-17T19:18:03.254328Z","end":"2026-02-17T19:18:03.522324Z","steps":["trace[533883017] 'agreement among raft nodes before linearized reading' (duration: 267.960489ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:03.522582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.599194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-17T19:18:03.522618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.674156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:03.522628Z","caller":"traceutil/trace.go:171","msg":"trace[1812292622] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:731; }","duration":"255.631015ms","start":"2026-02-17T19:18:03.266971Z","end":"2026-02-17T19:18:03.522602Z","steps":["trace[1812292622] 'agreement among raft nodes before linearized reading' (duration: 255.580413ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:03.522644Z","caller":"traceutil/trace.go:171","msg":"trace[1139900538] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:731; }","duration":"255.696707ms","start":"2026-02-17T19:18:03.266938Z","end":"2026-02-17T19:18:03.522635Z","steps":["trace[1139900538] 'agreement among raft nodes before linearized reading' (duration: 255.662936ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:03.522731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.381983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:03.522753Z","caller":"traceutil/trace.go:171","msg":"trace[1524211238] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:731; }","duration":"268.412075ms","start":"2026-02-17T19:18:03.254333Z","end":"2026-02-17T19:18:03.522745Z","steps":["trace[1524211238] 'agreement among raft nodes before linearized reading' (duration: 268.374742ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:03.522585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.617054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:03.523014Z","caller":"traceutil/trace.go:171","msg":"trace[1457965628] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:731; }","duration":"256.05544ms","start":"2026-02-17T19:18:03.266952Z","end":"2026-02-17T19:18:03.523007Z","steps":["trace[1457965628] 'agreement among raft nodes before linearized reading' (duration: 255.609735ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:03.52334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.379937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1889"} {"level":"info","ts":"2026-02-17T19:18:03.523367Z","caller":"traceutil/trace.go:171","msg":"trace[869227832] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:731; }","duration":"233.431999ms","start":"2026-02-17T19:18:03.289926Z","end":"2026-02-17T19:18:03.523358Z","steps":["trace[869227832] 'agreement among raft nodes before linearized reading' (duration: 233.388777ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:03.78504Z","caller":"traceutil/trace.go:171","msg":"trace[932238779] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"228.268858ms","start":"2026-02-17T19:18:03.556757Z","end":"2026-02-17T19:18:03.785026Z","steps":["trace[932238779] 'process raft request' (duration: 228.230916ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:03.785162Z","caller":"traceutil/trace.go:171","msg":"trace[1291221655] linearizableReadLoop","detail":"{readStateIndex:763; appliedIndex:762; }","duration":"228.454404ms","start":"2026-02-17T19:18:03.556702Z","end":"2026-02-17T19:18:03.785156Z","steps":["trace[1291221655] 'read index received' (duration: 133.673455ms)","trace[1291221655] 'applied index is now lower than readState.Index' (duration: 94.780349ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:03.785128Z","caller":"traceutil/trace.go:171","msg":"trace[1045101439] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"235.758643ms","start":"2026-02-17T19:18:03.549347Z","end":"2026-02-17T19:18:03.785105Z","steps":["trace[1045101439] 'process raft request' (duration: 141.019835ms)","trace[1045101439] 'compare' (duration: 94.436458ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:03.78529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.573688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:2252"} {"level":"info","ts":"2026-02-17T19:18:03.785309Z","caller":"traceutil/trace.go:171","msg":"trace[59619900] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:733; }","duration":"228.627249ms","start":"2026-02-17T19:18:03.556676Z","end":"2026-02-17T19:18:03.785303Z","steps":["trace[59619900] 'agreement among raft nodes before linearized reading' (duration: 228.580307ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:05.901818Z","caller":"traceutil/trace.go:171","msg":"trace[787961884] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"107.459451ms","start":"2026-02-17T19:18:05.794342Z","end":"2026-02-17T19:18:05.901802Z","steps":["trace[787961884] 'process raft request' (duration: 107.10109ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:06.134752Z","caller":"traceutil/trace.go:171","msg":"trace[1975016867] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"141.381496ms","start":"2026-02-17T19:18:05.993357Z","end":"2026-02-17T19:18:06.134739Z","steps":["trace[1975016867] 'process raft request' (duration: 141.291093ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:06.137404Z","caller":"traceutil/trace.go:171","msg":"trace[957062446] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"100.38563ms","start":"2026-02-17T19:18:06.037005Z","end":"2026-02-17T19:18:06.13739Z","steps":["trace[957062446] 'process raft request' (duration: 100.0724ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:06.269251Z","caller":"traceutil/trace.go:171","msg":"trace[832034613] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"106.680349ms","start":"2026-02-17T19:18:06.162554Z","end":"2026-02-17T19:18:06.269234Z","steps":["trace[832034613] 'read index received' (duration: 105.031267ms)","trace[832034613] 'applied index is now lower than readState.Index' (duration: 1.648542ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:06.269505Z","caller":"traceutil/trace.go:171","msg":"trace[956162578] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"107.147374ms","start":"2026-02-17T19:18:06.162341Z","end":"2026-02-17T19:18:06.269488Z","steps":["trace[956162578] 'process raft request' (duration: 105.293015ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:06.269638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.069202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:06.269662Z","caller":"traceutil/trace.go:171","msg":"trace[243130106] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:747; }","duration":"107.111044ms","start":"2026-02-17T19:18:06.162543Z","end":"2026-02-17T19:18:06.269655Z","steps":["trace[243130106] 'agreement among raft nodes before linearized reading' (duration: 107.064232ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:07.45914Z","caller":"traceutil/trace.go:171","msg":"trace[1941725978] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"116.431121ms","start":"2026-02-17T19:18:07.342693Z","end":"2026-02-17T19:18:07.459124Z","steps":["trace[1941725978] 'process raft request' (duration: 116.335058ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:08.052468Z","caller":"traceutil/trace.go:171","msg":"trace[723256896] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"232.755172ms","start":"2026-02-17T19:18:07.819695Z","end":"2026-02-17T19:18:08.05245Z","steps":["trace[723256896] 'process raft request' (duration: 232.66908ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:08.490421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.641897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-17T19:18:08.490499Z","caller":"traceutil/trace.go:171","msg":"trace[1827710199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:757; }","duration":"194.76137ms","start":"2026-02-17T19:18:08.295717Z","end":"2026-02-17T19:18:08.490478Z","steps":["trace[1827710199] 'range keys from in-memory index tree' (duration: 194.491513ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:08.628804Z","caller":"traceutil/trace.go:171","msg":"trace[1701604090] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"133.697671ms","start":"2026-02-17T19:18:08.495093Z","end":"2026-02-17T19:18:08.628791Z","steps":["trace[1701604090] 'process raft request' (duration: 133.123654ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:08.906461Z","caller":"traceutil/trace.go:171","msg":"trace[1084209519] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"230.549884ms","start":"2026-02-17T19:18:08.675894Z","end":"2026-02-17T19:18:08.906444Z","steps":["trace[1084209519] 'process raft request' (duration: 230.467051ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:10.870129Z","caller":"traceutil/trace.go:171","msg":"trace[1528021513] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"163.977098ms","start":"2026-02-17T19:18:10.706131Z","end":"2026-02-17T19:18:10.870108Z","steps":["trace[1528021513] 'process raft request' (duration: 163.933496ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:10.871355Z","caller":"traceutil/trace.go:171","msg":"trace[1236730549] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"165.631989ms","start":"2026-02-17T19:18:10.705708Z","end":"2026-02-17T19:18:10.87134Z","steps":["trace[1236730549] 'process raft request' (duration: 129.224148ms)","trace[1236730549] 'compare' (duration: 35.037048ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:11.067944Z","caller":"traceutil/trace.go:171","msg":"trace[553845034] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"127.015625ms","start":"2026-02-17T19:18:10.940909Z","end":"2026-02-17T19:18:11.067925Z","steps":["trace[553845034] 'process raft request' (duration: 79.77596ms)","trace[553845034] 'compare' (duration: 47.015008ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:11.470857Z","caller":"traceutil/trace.go:171","msg":"trace[1164414018] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"106.468071ms","start":"2026-02-17T19:18:11.364369Z","end":"2026-02-17T19:18:11.470837Z","steps":["trace[1164414018] 'process raft request' (duration: 106.40682ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:11.471481Z","caller":"traceutil/trace.go:171","msg":"trace[623177714] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"107.179873ms","start":"2026-02-17T19:18:11.364291Z","end":"2026-02-17T19:18:11.47147Z","steps":["trace[623177714] 'process raft request' (duration: 106.3981ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:11.797934Z","caller":"traceutil/trace.go:171","msg":"trace[1057008742] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:825; }","duration":"118.880257ms","start":"2026-02-17T19:18:11.679012Z","end":"2026-02-17T19:18:11.797892Z","steps":["trace[1057008742] 'read index received' (duration: 90.83073ms)","trace[1057008742] 'applied index is now lower than readState.Index' (duration: 28.049036ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:11.798562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.243038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-fs8f2\" ","response":"range_response_count:1 size:4809"} {"level":"info","ts":"2026-02-17T19:18:11.800752Z","caller":"traceutil/trace.go:171","msg":"trace[127000794] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-fs8f2; range_end:; response_count:1; response_revision:793; }","duration":"121.732862ms","start":"2026-02-17T19:18:11.678992Z","end":"2026-02-17T19:18:11.800725Z","steps":["trace[127000794] 'agreement among raft nodes before linearized reading' (duration: 119.089123ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:11.801156Z","caller":"traceutil/trace.go:171","msg":"trace[500116134] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"122.60528ms","start":"2026-02-17T19:18:11.678544Z","end":"2026-02-17T19:18:11.801149Z","steps":["trace[500116134] 'process raft request' (duration: 91.292404ms)","trace[500116134] 'compare' (duration: 27.865551ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:11.802008Z","caller":"traceutil/trace.go:171","msg":"trace[1769544323] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"113.890077ms","start":"2026-02-17T19:18:11.688111Z","end":"2026-02-17T19:18:11.802001Z","steps":["trace[1769544323] 'process raft request' (duration: 113.824325ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:12.197635Z","caller":"traceutil/trace.go:171","msg":"trace[541944469] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:833; }","duration":"118.92469ms","start":"2026-02-17T19:18:12.07869Z","end":"2026-02-17T19:18:12.197615Z","steps":["trace[541944469] 'read index received' (duration: 118.815146ms)","trace[541944469] 'applied index is now lower than readState.Index' (duration: 108.314µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:12.19774Z","caller":"traceutil/trace.go:171","msg":"trace[1417722666] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"241.528326ms","start":"2026-02-17T19:18:11.956196Z","end":"2026-02-17T19:18:12.197725Z","steps":["trace[1417722666] 'process raft request' (duration: 241.275708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:12.197905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.197817ms","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-17T19:18:12.197922Z","caller":"traceutil/trace.go:171","msg":"trace[563030187] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:801; }","duration":"119.258629ms","start":"2026-02-17T19:18:12.078658Z","end":"2026-02-17T19:18:12.197917Z","steps":["trace[563030187] 'agreement among raft nodes before linearized reading' (duration: 119.169057ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:12.996195Z","caller":"traceutil/trace.go:171","msg":"trace[1172125810] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"115.571441ms","start":"2026-02-17T19:18:12.880602Z","end":"2026-02-17T19:18:12.996173Z","steps":["trace[1172125810] 'process raft request' (duration: 115.435757ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:13.279751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.818559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T19:18:13.279827Z","caller":"traceutil/trace.go:171","msg":"trace[851024827] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:806; }","duration":"147.935622ms","start":"2026-02-17T19:18:13.131873Z","end":"2026-02-17T19:18:13.279809Z","steps":["trace[851024827] 'count revisions from in-memory index tree' (duration: 147.726926ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:13.279879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.309807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:13.279931Z","caller":"traceutil/trace.go:171","msg":"trace[1275124022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:806; }","duration":"118.392289ms","start":"2026-02-17T19:18:13.161526Z","end":"2026-02-17T19:18:13.279918Z","steps":["trace[1275124022] 'range keys from in-memory index tree' (duration: 118.255025ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:15.175225Z","caller":"traceutil/trace.go:171","msg":"trace[1916229928] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"171.615601ms","start":"2026-02-17T19:18:15.003595Z","end":"2026-02-17T19:18:15.175211Z","steps":["trace[1916229928] 'process raft request' (duration: 167.146752ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:18.642423Z","caller":"traceutil/trace.go:171","msg":"trace[471828302] linearizableReadLoop","detail":"{readStateIndex:862; appliedIndex:861; }","duration":"176.38192ms","start":"2026-02-17T19:18:18.466023Z","end":"2026-02-17T19:18:18.642405Z","steps":["trace[471828302] 'read index received' (duration: 176.230996ms)","trace[471828302] 'applied index is now lower than readState.Index' (duration: 150.224µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:18.6432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.175332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T19:18:18.64328Z","caller":"traceutil/trace.go:171","msg":"trace[612502020] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:828; }","duration":"177.335797ms","start":"2026-02-17T19:18:18.465935Z","end":"2026-02-17T19:18:18.643271Z","steps":["trace[612502020] 'agreement among raft nodes before linearized reading' (duration: 177.10283ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:18.644244Z","caller":"traceutil/trace.go:171","msg":"trace[431147440] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"247.908881ms","start":"2026-02-17T19:18:18.396323Z","end":"2026-02-17T19:18:18.644232Z","steps":["trace[431147440] 'process raft request' (duration: 245.981488ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:19.901203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.208008ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:18:19.901272Z","caller":"traceutil/trace.go:171","msg":"trace[36416050] linearizableReadLoop","detail":"{readStateIndex:863; appliedIndex:862; }","duration":"1.011031304s","start":"2026-02-17T19:18:18.890228Z","end":"2026-02-17T19:18:19.901259Z","steps":["trace[36416050] 'read index received' (duration: 329.684502ms)","trace[36416050] 'applied index is now lower than readState.Index' (duration: 681.345712ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:19.901315Z","caller":"traceutil/trace.go:171","msg":"trace[1030903210] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"1.251778513s","start":"2026-02-17T19:18:18.649517Z","end":"2026-02-17T19:18:19.901295Z","steps":["trace[1030903210] 'process raft request' (duration: 570.40723ms)","trace[1030903210] 'compare' (duration: 680.976592ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:19.901408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.011186967s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-17T19:18:19.901407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:18.649496Z","time spent":"1.251858795s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:19.901432Z","caller":"traceutil/trace.go:171","msg":"trace[1009873657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:829; }","duration":"1.011238159s","start":"2026-02-17T19:18:18.890185Z","end":"2026-02-17T19:18:19.901424Z","steps":["trace[1009873657] 'agreement among raft nodes before linearized reading' (duration: 1.011131926s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:19.901454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:18.890147Z","time spent":"1.011299601s","remote":"127.0.0.1:47990","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":"warn","ts":"2026-02-17T19:18:19.901549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.799412ms","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-17T19:18:19.901573Z","caller":"traceutil/trace.go:171","msg":"trace[1640645401] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:829; }","duration":"835.850934ms","start":"2026-02-17T19:18:19.065714Z","end":"2026-02-17T19:18:19.901565Z","steps":["trace[1640645401] 'agreement among raft nodes before linearized reading' (duration: 835.810813ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:19.901607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:19.065699Z","time spent":"835.904255ms","remote":"127.0.0.1:48220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":29,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-02-17T19:18:19.90165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.963428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T19:18:19.90167Z","caller":"traceutil/trace.go:171","msg":"trace[993194963] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:829; }","duration":"520.009079ms","start":"2026-02-17T19:18:19.381656Z","end":"2026-02-17T19:18:19.901665Z","steps":["trace[993194963] 'agreement among raft nodes before linearized reading' (duration: 519.967218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:19.901687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:19.381641Z","time spent":"520.04191ms","remote":"127.0.0.1:47906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":29,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-02-17T19:18:19.901737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.686405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-17T19:18:19.901753Z","caller":"traceutil/trace.go:171","msg":"trace[1166148741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:829; }","duration":"619.731166ms","start":"2026-02-17T19:18:19.282017Z","end":"2026-02-17T19:18:19.901748Z","steps":["trace[1166148741] 'agreement among raft nodes before linearized reading' (duration: 619.684135ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:19.901767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:19.281969Z","time spent":"619.795478ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T19:18:19.901819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.308597ms","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-17T19:18:19.901836Z","caller":"traceutil/trace.go:171","msg":"trace[1750421850] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:829; }","duration":"177.347928ms","start":"2026-02-17T19:18:19.724484Z","end":"2026-02-17T19:18:19.901832Z","steps":["trace[1750421850] 'agreement among raft nodes before linearized reading' (duration: 177.281526ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:19.901847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.747743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:19.901863Z","caller":"traceutil/trace.go:171","msg":"trace[558094268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:829; }","duration":"737.790363ms","start":"2026-02-17T19:18:19.164068Z","end":"2026-02-17T19:18:19.901858Z","steps":["trace[558094268] 'agreement among raft nodes before linearized reading' (duration: 737.759692ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:19.901884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:19.164055Z","time spent":"737.821835ms","remote":"127.0.0.1:47748","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-17T19:18:20.529411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.944132ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:18:20.529482Z","caller":"traceutil/trace.go:171","msg":"trace[1442045388] linearizableReadLoop","detail":"{readStateIndex:864; appliedIndex:863; }","duration":"621.3885ms","start":"2026-02-17T19:18:19.908082Z","end":"2026-02-17T19:18:20.52947Z","steps":["trace[1442045388] 'read index received' (duration: 462.415668ms)","trace[1442045388] 'applied index is now lower than readState.Index' (duration: 158.971922ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:20.529556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.473362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:20.529574Z","caller":"traceutil/trace.go:171","msg":"trace[1840223833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:830; }","duration":"621.490173ms","start":"2026-02-17T19:18:19.908077Z","end":"2026-02-17T19:18:20.529568Z","steps":["trace[1840223833] 'agreement among raft nodes before linearized reading' (duration: 621.422521ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:20.529595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:19.908047Z","time spent":"621.543164ms","remote":"127.0.0.1:47738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T19:18:20.529813Z","caller":"traceutil/trace.go:171","msg":"trace[1307689393] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"621.988466ms","start":"2026-02-17T19:18:19.907816Z","end":"2026-02-17T19:18:20.529805Z","steps":["trace[1307689393] 'process raft request' (duration: 462.550071ms)","trace[1307689393] 'compare' (duration: 158.704945ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:20.529853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:19.907798Z","time spent":"622.033848ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:20.604192Z","caller":"traceutil/trace.go:171","msg":"trace[1584431990] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"688.290983ms","start":"2026-02-17T19:18:19.915887Z","end":"2026-02-17T19:18:20.604178Z","steps":["trace[1584431990] 'process raft request' (duration: 687.996975ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:20.604273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:19.915875Z","time spent":"688.351005ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:20.604338Z","caller":"traceutil/trace.go:171","msg":"trace[1428961278] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"688.384836ms","start":"2026-02-17T19:18:19.915949Z","end":"2026-02-17T19:18:20.604334Z","steps":["trace[1428961278] 'process raft request' (duration: 688.000185ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:20.604362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:19.915931Z","time spent":"688.417146ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:20.726726Z","caller":"traceutil/trace.go:171","msg":"trace[1407830413] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"115.012062ms","start":"2026-02-17T19:18:20.6117Z","end":"2026-02-17T19:18:20.726713Z","steps":["trace[1407830413] 'process raft request' (duration: 42.42722ms)","trace[1407830413] 'compare' (duration: 72.205611ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:24.032941Z","caller":"traceutil/trace.go:171","msg":"trace[1056637606] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"114.249993ms","start":"2026-02-17T19:18:23.918422Z","end":"2026-02-17T19:18:24.032672Z","steps":["trace[1056637606] 'process raft request' (duration: 94.080898ms)","trace[1056637606] 'compare' (duration: 20.003381ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:29.057081Z","caller":"traceutil/trace.go:171","msg":"trace[716809996] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"146.022069ms","start":"2026-02-17T19:18:28.91104Z","end":"2026-02-17T19:18:29.057062Z","steps":["trace[716809996] 'process raft request' (duration: 142.834879ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:29.358168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.955892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:29.358276Z","caller":"traceutil/trace.go:171","msg":"trace[351540214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:862; }","duration":"196.109976ms","start":"2026-02-17T19:18:29.162149Z","end":"2026-02-17T19:18:29.358259Z","steps":["trace[351540214] 'range keys from in-memory index tree' (duration: 195.902831ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:49.697283Z","caller":"traceutil/trace.go:171","msg":"trace[100753969] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"150.067571ms","start":"2026-02-17T19:18:49.547193Z","end":"2026-02-17T19:18:49.697261Z","steps":["trace[100753969] 'process raft request' (duration: 149.901017ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:49.960153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.339007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T19:18:49.960276Z","caller":"traceutil/trace.go:171","msg":"trace[118069046] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:934; }","duration":"143.51954ms","start":"2026-02-17T19:18:49.816743Z","end":"2026-02-17T19:18:49.960263Z","steps":["trace[118069046] 'count revisions from in-memory index tree' (duration: 143.239245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:56.853752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:56.425469Z","time spent":"428.276292ms","remote":"127.0.0.1:47750","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-17T19:18:57.154326Z","caller":"traceutil/trace.go:171","msg":"trace[1413209849] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1010; }","duration":"107.905043ms","start":"2026-02-17T19:18:57.046398Z","end":"2026-02-17T19:18:57.154303Z","steps":["trace[1413209849] 'read index received' (duration: 106.22908ms)","trace[1413209849] 'applied index is now lower than readState.Index' (duration: 1.675133ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:57.154725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.319811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-17T19:18:57.155139Z","caller":"traceutil/trace.go:171","msg":"trace[1540304601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:969; }","duration":"108.78409ms","start":"2026-02-17T19:18:57.046342Z","end":"2026-02-17T19:18:57.155126Z","steps":["trace[1540304601] 'agreement among raft nodes before linearized reading' (duration: 108.165978ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:57.154778Z","caller":"traceutil/trace.go:171","msg":"trace[816121532] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"298.17117ms","start":"2026-02-17T19:18:56.856594Z","end":"2026-02-17T19:18:57.154766Z","steps":["trace[816121532] 'process raft request' (duration: 296.020888ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:18:57.155037Z","caller":"traceutil/trace.go:171","msg":"trace[520209257] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"295.102348ms","start":"2026-02-17T19:18:56.859919Z","end":"2026-02-17T19:18:57.155021Z","steps":["trace[520209257] 'process raft request' (duration: 294.243021ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:57.731715Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938289587084574038,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T19:18:57.866527Z","caller":"traceutil/trace.go:171","msg":"trace[287703602] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"635.867401ms","start":"2026-02-17T19:18:57.23064Z","end":"2026-02-17T19:18:57.866507Z","steps":["trace[287703602] 'read index received' (duration: 572.908969ms)","trace[287703602] 'applied index is now lower than readState.Index' (duration: 62.957622ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T19:18:57.866767Z","caller":"traceutil/trace.go:171","msg":"trace[1857336165] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"699.132169ms","start":"2026-02-17T19:18:57.167624Z","end":"2026-02-17T19:18:57.866756Z","steps":["trace[1857336165] 'process raft request' (duration: 636.671985ms)","trace[1857336165] 'compare' (duration: 62.092305ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:57.866866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:57.167617Z","time spent":"699.174929ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T19:18:57.867155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.155848ms","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-17T19:18:57.867188Z","caller":"traceutil/trace.go:171","msg":"trace[654042776] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:971; }","duration":"683.206569ms","start":"2026-02-17T19:18:57.183971Z","end":"2026-02-17T19:18:57.867177Z","steps":["trace[654042776] 'agreement among raft nodes before linearized reading' (duration: 683.119977ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:57.867232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:57.18396Z","time spent":"683.265071ms","remote":"127.0.0.1:47990","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":"warn","ts":"2026-02-17T19:18:57.867315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.547768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T19:18:57.867337Z","caller":"traceutil/trace.go:171","msg":"trace[1660905818] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:971; }","duration":"699.578348ms","start":"2026-02-17T19:18:57.167753Z","end":"2026-02-17T19:18:57.867331Z","steps":["trace[1660905818] 'agreement among raft nodes before linearized reading' (duration: 699.543847ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:57.867373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:57.167749Z","time spent":"699.618679ms","remote":"127.0.0.1:47748","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-17T19:18:57.867527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.241858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T19:18:57.867549Z","caller":"traceutil/trace.go:171","msg":"trace[243942730] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:971; }","duration":"631.287989ms","start":"2026-02-17T19:18:57.236256Z","end":"2026-02-17T19:18:57.867544Z","steps":["trace[243942730] 'agreement among raft nodes before linearized reading' (duration: 631.227098ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:57.867587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:57.236211Z","time spent":"631.370111ms","remote":"127.0.0.1:47750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-02-17T19:18:58.670838Z","caller":"traceutil/trace.go:171","msg":"trace[1585872714] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"398.960772ms","start":"2026-02-17T19:18:58.271853Z","end":"2026-02-17T19:18:58.670814Z","steps":["trace[1585872714] 'process raft request' (duration: 398.785457ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:58.67101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:58.271835Z","time spent":"399.076843ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:59.479372Z","caller":"traceutil/trace.go:171","msg":"trace[1844347297] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"310.865792ms","start":"2026-02-17T19:18:59.168488Z","end":"2026-02-17T19:18:59.479354Z","steps":["trace[1844347297] 'process raft request' (duration: 310.693669ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:18:59.479628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:18:59.168471Z","time spent":"310.960394ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T19:18:59.480147Z","caller":"traceutil/trace.go:171","msg":"trace[311209927] linearizableReadLoop","detail":"{readStateIndex:1017; appliedIndex:1017; }","duration":"235.591764ms","start":"2026-02-17T19:18:59.244545Z","end":"2026-02-17T19:18:59.480137Z","steps":["trace[311209927] 'read index received' (duration: 235.584264ms)","trace[311209927] 'applied index is now lower than readState.Index' (duration: 6.71µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:18:59.480469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.922282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-17T19:18:59.480499Z","caller":"traceutil/trace.go:171","msg":"trace[1527308140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:974; }","duration":"235.983703ms","start":"2026-02-17T19:18:59.244508Z","end":"2026-02-17T19:18:59.480492Z","steps":["trace[1527308140] 'agreement among raft nodes before linearized reading' (duration: 235.665476ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T19:19:08.361935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.886053ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T19:19:08.363005Z","caller":"traceutil/trace.go:171","msg":"trace[2139790353] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"405.028774ms","start":"2026-02-17T19:19:07.95794Z","end":"2026-02-17T19:19:08.362969Z","steps":["trace[2139790353] 'process raft request' (duration: 229.026322ms)","trace[2139790353] 'compare' (duration: 174.667998ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:19:08.363301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:19:07.957927Z","time spent":"405.33005ms","remote":"127.0.0.1:47990","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-17T19:19:09.761695Z","caller":"traceutil/trace.go:171","msg":"trace[1399966227] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"234.134952ms","start":"2026-02-17T19:19:09.527523Z","end":"2026-02-17T19:19:09.761658Z","steps":["trace[1399966227] 'process raft request' (duration: 233.944658ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T19:19:09.763472Z","caller":"traceutil/trace.go:171","msg":"trace[639246800] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1053; }","duration":"191.792941ms","start":"2026-02-17T19:19:09.571652Z","end":"2026-02-17T19:19:09.763445Z","steps":["trace[639246800] 'read index received' (duration: 191.787101ms)","trace[639246800] 'applied index is now lower than readState.Index' (duration: 4.79µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T19:19:09.764974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.300019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T19:19:09.765128Z","caller":"traceutil/trace.go:171","msg":"trace[1511389970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1008; }","duration":"193.465932ms","start":"2026-02-17T19:19:09.571646Z","end":"2026-02-17T19:19:09.765112Z","steps":["trace[1511389970] 'agreement among raft nodes before linearized reading' (duration: 193.195407ms)"],"step_count":1}