{"level":"warn","ts":"2026-02-18T05:16:57.785147Z","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-18T05:16:57.785429Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.155: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.155:2380","--initial-cluster=instance=https://199.204.45.155:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.155:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.155: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-18T05:16:57.785573Z","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-18T05:16:57.785655Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-02-18T05:16:57.785749Z","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-18T05:16:57.7864Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"]} {"level":"info","ts":"2026-02-18T05:16:57.786554Z","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.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.155: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-18T05:16:57.792653Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.55703ms"} {"level":"info","ts":"2026-02-18T05:16:57.806639Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"344940fc142d902f","cluster-id":"c7d65bf2a36fbd4"} {"level":"info","ts":"2026-02-18T05:16:57.806924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=()"} {"level":"info","ts":"2026-02-18T05:16:57.807012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 0"} {"level":"info","ts":"2026-02-18T05:16:57.80719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 344940fc142d902f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-18T05:16:57.807275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 1"} {"level":"info","ts":"2026-02-18T05:16:57.807378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"warn","ts":"2026-02-18T05:16:57.813647Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-18T05:16:57.814674Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-18T05:16:57.815705Z","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-18T05:16:57.817966Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"344940fc142d902f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-18T05:16:57.818704Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"344940fc142d902f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-18T05:16:57.823187Z","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-18T05:16:57.824236Z","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-18T05:16:57.824326Z","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-18T05:16:57.823534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"info","ts":"2026-02-18T05:16:57.82462Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","added-peer-id":"344940fc142d902f","added-peer-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-02-18T05:16:57.824166Z","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-18T05:16:57.825259Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"344940fc142d902f","initial-advertise-peer-urls":["https://199.204.45.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-18T05:16:57.825957Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-18T05:16:57.824182Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-02-18T05:16:57.827694Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-02-18T05:16:58.408236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f is starting a new election at term 1"} {"level":"info","ts":"2026-02-18T05:16:58.40834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became pre-candidate at term 1"} {"level":"info","ts":"2026-02-18T05:16:58.408367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgPreVoteResp from 344940fc142d902f at term 1"} {"level":"info","ts":"2026-02-18T05:16:58.40838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became candidate at term 2"} {"level":"info","ts":"2026-02-18T05:16:58.408386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgVoteResp from 344940fc142d902f at term 2"} {"level":"info","ts":"2026-02-18T05:16:58.408394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became leader at term 2"} {"level":"info","ts":"2026-02-18T05:16:58.408427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 344940fc142d902f elected leader 344940fc142d902f at term 2"} {"level":"info","ts":"2026-02-18T05:16:58.409373Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T05:16:58.410529Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"344940fc142d902f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.155:2379]}","request-path":"/0/members/344940fc142d902f/attributes","cluster-id":"c7d65bf2a36fbd4","publish-timeout":"7s"} {"level":"info","ts":"2026-02-18T05:16:58.411435Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T05:16:58.41152Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T05:16:58.411573Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-18T05:16:58.411584Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T05:16:58.411837Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-18T05:16:58.415387Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.155:2379"} {"level":"info","ts":"2026-02-18T05:16:58.417865Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-18T05:16:58.41795Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-18T05:16:58.423006Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-18T05:17:14.534965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.440277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"info","ts":"2026-02-18T05:17:14.535117Z","caller":"traceutil/trace.go:171","msg":"trace[600863790] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:371; }","duration":"189.675112ms","start":"2026-02-18T05:17:14.345421Z","end":"2026-02-18T05:17:14.535096Z","steps":["trace[600863790] 'range keys from in-memory index tree' (duration: 189.327185ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:17.137868Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389694866695672450,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T05:17:17.276634Z","caller":"traceutil/trace.go:171","msg":"trace[2421881] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"709.738609ms","start":"2026-02-18T05:17:16.566864Z","end":"2026-02-18T05:17:17.276602Z","steps":["trace[2421881] 'process raft request' (duration: 708.868651ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:17.277373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:16.566838Z","time spent":"709.908573ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T05:17:17.559222Z","caller":"traceutil/trace.go:171","msg":"trace[470051948] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"922.061923ms","start":"2026-02-18T05:17:16.637131Z","end":"2026-02-18T05:17:17.559193Z","steps":["trace[470051948] 'read index received' (duration: 639.628679ms)","trace[470051948] 'applied index is now lower than readState.Index' (duration: 282.431934ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:17:17.559369Z","caller":"traceutil/trace.go:171","msg":"trace[1591240670] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"989.458025ms","start":"2026-02-18T05:17:16.569899Z","end":"2026-02-18T05:17:17.559357Z","steps":["trace[1591240670] 'process raft request' (duration: 910.874631ms)","trace[1591240670] 'compare' (duration: 78.243847ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:17:17.559516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:16.569881Z","time spent":"989.518107ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T05:17:17.560503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.374502ms","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-18T05:17:17.560517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.281817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:17:17.560554Z","caller":"traceutil/trace.go:171","msg":"trace[1886736114] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:409; }","duration":"923.491154ms","start":"2026-02-18T05:17:16.637049Z","end":"2026-02-18T05:17:17.56054Z","steps":["trace[1886736114] 'agreement among raft nodes before linearized reading' (duration: 923.363471ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:17:17.560589Z","caller":"traceutil/trace.go:171","msg":"trace[877940517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"363.392889ms","start":"2026-02-18T05:17:17.197179Z","end":"2026-02-18T05:17:17.560572Z","steps":["trace[877940517] 'agreement among raft nodes before linearized reading' (duration: 363.284537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:17.56059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:16.637018Z","time spent":"923.564376ms","remote":"127.0.0.1:39614","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-18T05:17:17.560619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:17.197145Z","time spent":"363.468391ms","remote":"127.0.0.1:39338","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-18T05:17:19.796547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.60684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T05:17:19.796638Z","caller":"traceutil/trace.go:171","msg":"trace[1498509011] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"156.217808ms","start":"2026-02-18T05:17:19.640403Z","end":"2026-02-18T05:17:19.796621Z","steps":["trace[1498509011] 'process raft request' (duration: 50.383963ms)","trace[1498509011] 'compare' (duration: 105.430807ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:17:29.937614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.711394ms","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-18T05:17:29.937691Z","caller":"traceutil/trace.go:171","msg":"trace[660737055] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:471; }","duration":"106.99635ms","start":"2026-02-18T05:17:29.830681Z","end":"2026-02-18T05:17:29.937678Z","steps":["trace[660737055] 'range keys from in-memory index tree' (duration: 106.611302ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:17:30.176773Z","caller":"traceutil/trace.go:171","msg":"trace[724187690] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"234.354732ms","start":"2026-02-18T05:17:29.942226Z","end":"2026-02-18T05:17:30.176581Z","steps":["trace[724187690] 'process raft request' (duration: 234.227169ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:17:30.624823Z","caller":"traceutil/trace.go:171","msg":"trace[422772379] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:488; }","duration":"607.307679ms","start":"2026-02-18T05:17:30.017493Z","end":"2026-02-18T05:17:30.6248Z","steps":["trace[422772379] 'read index received' (duration: 158.888306ms)","trace[422772379] 'applied index is now lower than readState.Index' (duration: 448.418443ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:17:30.625781Z","caller":"traceutil/trace.go:171","msg":"trace[2099698439] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"683.340148ms","start":"2026-02-18T05:17:29.942424Z","end":"2026-02-18T05:17:30.625764Z","steps":["trace[2099698439] 'process raft request' (duration: 682.261115ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:30.6259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:29.942419Z","time spent":"683.405629ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T05:17:30.626294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.793702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4019"} {"level":"info","ts":"2026-02-18T05:17:30.62634Z","caller":"traceutil/trace.go:171","msg":"trace[1267474925] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:473; }","duration":"608.875254ms","start":"2026-02-18T05:17:30.017452Z","end":"2026-02-18T05:17:30.626328Z","steps":["trace[1267474925] 'agreement among raft nodes before linearized reading' (duration: 608.75613ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:30.626547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:30.017435Z","time spent":"609.007976ms","remote":"127.0.0.1:39538","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-18T05:17:30.627753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.117814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:17:30.627801Z","caller":"traceutil/trace.go:171","msg":"trace[1701576306] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:473; }","duration":"446.189355ms","start":"2026-02-18T05:17:30.181597Z","end":"2026-02-18T05:17:30.627787Z","steps":["trace[1701576306] 'agreement among raft nodes before linearized reading' (duration: 446.103393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:30.627831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:30.181586Z","time spent":"446.238896ms","remote":"127.0.0.1:39338","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-18T05:17:32.426146Z","caller":"traceutil/trace.go:171","msg":"trace[150150301] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:495; }","duration":"244.367388ms","start":"2026-02-18T05:17:32.18176Z","end":"2026-02-18T05:17:32.426127Z","steps":["trace[150150301] 'read index received' (duration: 157.383072ms)","trace[150150301] 'applied index is now lower than readState.Index' (duration: 86.983026ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:17:32.426225Z","caller":"traceutil/trace.go:171","msg":"trace[786868979] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"246.879353ms","start":"2026-02-18T05:17:32.17934Z","end":"2026-02-18T05:17:32.426219Z","steps":["trace[786868979] 'process raft request' (duration: 159.815706ms)","trace[786868979] 'compare' (duration: 86.796052ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:17:32.426325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.530362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:17:32.426395Z","caller":"traceutil/trace.go:171","msg":"trace[566720211] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:478; }","duration":"244.629164ms","start":"2026-02-18T05:17:32.181749Z","end":"2026-02-18T05:17:32.426378Z","steps":["trace[566720211] 'agreement among raft nodes before linearized reading' (duration: 244.503791ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:32.426438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.660045ms","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-18T05:17:32.426461Z","caller":"traceutil/trace.go:171","msg":"trace[623841521] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:478; }","duration":"244.715955ms","start":"2026-02-18T05:17:32.181739Z","end":"2026-02-18T05:17:32.426455Z","steps":["trace[623841521] 'agreement among raft nodes before linearized reading' (duration: 244.648274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:32.777629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.242861ms","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-18T05:17:32.777696Z","caller":"traceutil/trace.go:171","msg":"trace[1230408661] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:479; }","duration":"140.340204ms","start":"2026-02-18T05:17:32.637338Z","end":"2026-02-18T05:17:32.777678Z","steps":["trace[1230408661] 'range keys from in-memory index tree' (duration: 140.17287ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:17:33.018468Z","caller":"traceutil/trace.go:171","msg":"trace[1933573532] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"238.264296ms","start":"2026-02-18T05:17:32.780186Z","end":"2026-02-18T05:17:33.01845Z","steps":["trace[1933573532] 'process raft request' (duration: 238.171304ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:37.897081Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389694866695672642,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-18T05:17:38.169161Z","caller":"traceutil/trace.go:171","msg":"trace[1834683836] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"909.591344ms","start":"2026-02-18T05:17:37.259547Z","end":"2026-02-18T05:17:38.169139Z","steps":["trace[1834683836] 'process raft request' (duration: 909.430951ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:38.1693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:37.259534Z","time spent":"909.695756ms","remote":"127.0.0.1:39552","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-18T05:17:38.301576Z","caller":"traceutil/trace.go:171","msg":"trace[865464734] linearizableReadLoop","detail":"{readStateIndex:512; appliedIndex:511; }","duration":"904.992713ms","start":"2026-02-18T05:17:37.396556Z","end":"2026-02-18T05:17:38.301549Z","steps":["trace[865464734] 'read index received' (duration: 774.733729ms)","trace[865464734] 'applied index is now lower than readState.Index' (duration: 130.257524ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:17:38.301796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.217029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T05:17:38.301829Z","caller":"traceutil/trace.go:171","msg":"trace[262233046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:493; }","duration":"905.29176ms","start":"2026-02-18T05:17:37.396528Z","end":"2026-02-18T05:17:38.30182Z","steps":["trace[262233046] 'agreement among raft nodes before linearized reading' (duration: 905.196958ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:38.301867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:37.396514Z","time spent":"905.342921ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-18T05:17:38.302116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.42773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-18T05:17:38.302178Z","caller":"traceutil/trace.go:171","msg":"trace[933279419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:493; }","duration":"547.489003ms","start":"2026-02-18T05:17:37.75468Z","end":"2026-02-18T05:17:38.302169Z","steps":["trace[933279419] 'agreement among raft nodes before linearized reading' (duration: 547.405091ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:38.302208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:37.754625Z","time spent":"547.576064ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-18T05:17:38.302404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.463224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:17:38.302445Z","caller":"traceutil/trace.go:171","msg":"trace[805701108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:493; }","duration":"121.524345ms","start":"2026-02-18T05:17:38.18091Z","end":"2026-02-18T05:17:38.302434Z","steps":["trace[805701108] 'agreement among raft nodes before linearized reading' (duration: 121.471564ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:40.822793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.911733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-18T05:17:40.822885Z","caller":"traceutil/trace.go:171","msg":"trace[1925117498] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:510; }","duration":"205.042516ms","start":"2026-02-18T05:17:40.617809Z","end":"2026-02-18T05:17:40.822851Z","steps":["trace[1925117498] 'range keys from in-memory index tree' (duration: 204.834631ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:40.823029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.624209ms","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-18T05:17:40.823096Z","caller":"traceutil/trace.go:171","msg":"trace[2044129951] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:510; }","duration":"342.731492ms","start":"2026-02-18T05:17:40.480347Z","end":"2026-02-18T05:17:40.823078Z","steps":["trace[2044129951] 'range keys from in-memory index tree' (duration: 342.470716ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:40.823136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:40.480329Z","time spent":"342.796193ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-18T05:17:52.250365Z","caller":"traceutil/trace.go:171","msg":"trace[619399258] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"700.972201ms","start":"2026-02-18T05:17:51.549379Z","end":"2026-02-18T05:17:52.250351Z","steps":["trace[619399258] 'process raft request' (duration: 700.881109ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:52.25045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:51.549136Z","time spent":"701.270147ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3754,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T05:17:52.684458Z","caller":"traceutil/trace.go:171","msg":"trace[652961709] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:681; }","duration":"780.542556ms","start":"2026-02-18T05:17:51.903899Z","end":"2026-02-18T05:17:52.684441Z","steps":["trace[652961709] 'read index received' (duration: 346.853682ms)","trace[652961709] 'applied index is now lower than readState.Index' (duration: 433.686894ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:17:52.684674Z","caller":"traceutil/trace.go:171","msg":"trace[1162273597] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"888.61047ms","start":"2026-02-18T05:17:51.796003Z","end":"2026-02-18T05:17:52.684613Z","steps":["trace[1162273597] 'process raft request' (duration: 888.315253ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:52.684759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:51.795968Z","time spent":"888.737373ms","remote":"127.0.0.1:39614","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-18T05:17:52.68497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.070507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-18T05:17:52.684992Z","caller":"traceutil/trace.go:171","msg":"trace[846413884] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:660; }","duration":"781.126148ms","start":"2026-02-18T05:17:51.903859Z","end":"2026-02-18T05:17:52.684985Z","steps":["trace[846413884] 'agreement among raft nodes before linearized reading' (duration: 781.027876ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:52.68501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:51.903838Z","time spent":"781.168499ms","remote":"127.0.0.1:39374","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.155\" "} {"level":"warn","ts":"2026-02-18T05:17:52.691122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.407895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:17:52.691151Z","caller":"traceutil/trace.go:171","msg":"trace[470863473] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:662; }","duration":"491.462827ms","start":"2026-02-18T05:17:52.199681Z","end":"2026-02-18T05:17:52.691144Z","steps":["trace[470863473] 'agreement among raft nodes before linearized reading' (duration: 491.404796ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:52.691183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:52.19967Z","time spent":"491.509138ms","remote":"127.0.0.1:39338","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-18T05:17:52.691342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.47078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-18T05:17:52.69136Z","caller":"traceutil/trace.go:171","msg":"trace[554291741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:662; }","duration":"208.511711ms","start":"2026-02-18T05:17:52.482842Z","end":"2026-02-18T05:17:52.691354Z","steps":["trace[554291741] 'agreement among raft nodes before linearized reading' (duration: 208.45081ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:52.691465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.169528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T05:17:52.691481Z","caller":"traceutil/trace.go:171","msg":"trace[1598660089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:662; }","duration":"216.222008ms","start":"2026-02-18T05:17:52.475254Z","end":"2026-02-18T05:17:52.691477Z","steps":["trace[1598660089] 'agreement among raft nodes before linearized reading' (duration: 216.175947ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:17:52.691717Z","caller":"traceutil/trace.go:171","msg":"trace[1028947181] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"436.340962ms","start":"2026-02-18T05:17:52.25537Z","end":"2026-02-18T05:17:52.691711Z","steps":["trace[1028947181] 'process raft request' (duration: 435.519204ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:52.691763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:52.255359Z","time spent":"436.374772ms","remote":"127.0.0.1:39818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4182,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T05:17:52.690994Z","caller":"traceutil/trace.go:171","msg":"trace[826453208] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"251.565315ms","start":"2026-02-18T05:17:52.439418Z","end":"2026-02-18T05:17:52.690984Z","steps":["trace[826453208] 'process raft request' (duration: 251.538655ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:17:58.928905Z","caller":"traceutil/trace.go:171","msg":"trace[593785468] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"163.040376ms","start":"2026-02-18T05:17:58.765847Z","end":"2026-02-18T05:17:58.928888Z","steps":["trace[593785468] 'process raft request' (duration: 162.855132ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:17:59.104775Z","caller":"traceutil/trace.go:171","msg":"trace[590158840] linearizableReadLoop","detail":"{readStateIndex:707; appliedIndex:706; }","duration":"153.334214ms","start":"2026-02-18T05:17:58.951423Z","end":"2026-02-18T05:17:59.104757Z","steps":["trace[590158840] 'read index received' (duration: 153.172051ms)","trace[590158840] 'applied index is now lower than readState.Index' (duration: 161.423µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:17:59.104971Z","caller":"traceutil/trace.go:171","msg":"trace[2126614273] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"337.259615ms","start":"2026-02-18T05:17:58.767703Z","end":"2026-02-18T05:17:59.104962Z","steps":["trace[2126614273] 'process raft request' (duration: 336.935937ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:59.105045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:58.767696Z","time spent":"337.294695ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T05:17:59.105215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.788725ms","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-18T05:17:59.105238Z","caller":"traceutil/trace.go:171","msg":"trace[1700177107] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:683; }","duration":"153.855976ms","start":"2026-02-18T05:17:58.951374Z","end":"2026-02-18T05:17:59.10523Z","steps":["trace[1700177107] 'agreement among raft nodes before linearized reading' (duration: 153.772925ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:17:59.872198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.214188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T05:17:59.872256Z","caller":"traceutil/trace.go:171","msg":"trace[379535756] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"677.669774ms","start":"2026-02-18T05:17:59.194574Z","end":"2026-02-18T05:17:59.872244Z","steps":["trace[379535756] 'process raft request' (duration: 568.352964ms)","trace[379535756] 'compare' (duration: 109.055295ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:17:59.872286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:17:59.19456Z","time spent":"677.712166ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-18T05:18:13.210409Z","caller":"traceutil/trace.go:171","msg":"trace[919188809] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"178.152173ms","start":"2026-02-18T05:18:13.03224Z","end":"2026-02-18T05:18:13.210393Z","steps":["trace[919188809] 'process raft request' (duration: 177.755345ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:18.210253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.481758ms","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-18T05:18:18.210297Z","caller":"traceutil/trace.go:171","msg":"trace[707951697] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:742; }","duration":"261.5578ms","start":"2026-02-18T05:18:17.948729Z","end":"2026-02-18T05:18:18.210287Z","steps":["trace[707951697] 'range keys from in-memory index tree' (duration: 261.376446ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:18.651301Z","caller":"traceutil/trace.go:171","msg":"trace[1120811379] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"438.380104ms","start":"2026-02-18T05:18:18.212898Z","end":"2026-02-18T05:18:18.651278Z","steps":["trace[1120811379] 'process raft request' (duration: 438.234741ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:18.651454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:18.212889Z","time spent":"438.478866ms","remote":"127.0.0.1:39614","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-18T05:18:22.994899Z","caller":"traceutil/trace.go:171","msg":"trace[2055856776] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"317.545475ms","start":"2026-02-18T05:18:22.67733Z","end":"2026-02-18T05:18:22.994876Z","steps":["trace[2055856776] 'process raft request' (duration: 317.403532ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:22.995523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:22.677286Z","time spent":"317.681958ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T05:18:23.664567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.286384ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T05:18:23.665003Z","caller":"traceutil/trace.go:171","msg":"trace[925312868] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:785; }","duration":"231.484599ms","start":"2026-02-18T05:18:23.433495Z","end":"2026-02-18T05:18:23.664979Z","steps":["trace[925312868] 'read index received' (duration: 96.665173ms)","trace[925312868] 'applied index is now lower than readState.Index' (duration: 134.817526ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:18:23.669615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.749809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-18T05:18:23.670325Z","caller":"traceutil/trace.go:171","msg":"trace[1980393614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:756; }","duration":"228.486126ms","start":"2026-02-18T05:18:23.441821Z","end":"2026-02-18T05:18:23.670307Z","steps":["trace[1980393614] 'agreement among raft nodes before linearized reading' (duration: 227.649168ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:23.665675Z","caller":"traceutil/trace.go:171","msg":"trace[882004723] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"285.91137ms","start":"2026-02-18T05:18:23.379735Z","end":"2026-02-18T05:18:23.665646Z","steps":["trace[882004723] 'process raft request' (duration: 150.44317ms)","trace[882004723] 'compare' (duration: 134.09074ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:18:23.670144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.642248ms","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-18T05:18:23.671781Z","caller":"traceutil/trace.go:171","msg":"trace[7309911] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:756; }","duration":"238.317725ms","start":"2026-02-18T05:18:23.433446Z","end":"2026-02-18T05:18:23.671764Z","steps":["trace[7309911] 'agreement among raft nodes before linearized reading' (duration: 236.609468ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:23.670248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.455907ms","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-18T05:18:23.673665Z","caller":"traceutil/trace.go:171","msg":"trace[768956766] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:756; }","duration":"224.895539ms","start":"2026-02-18T05:18:23.448762Z","end":"2026-02-18T05:18:23.673657Z","steps":["trace[768956766] 'agreement among raft nodes before linearized reading' (duration: 221.418175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:23.964523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.329281ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T05:18:23.964918Z","caller":"traceutil/trace.go:171","msg":"trace[820379921] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"287.653148ms","start":"2026-02-18T05:18:23.677246Z","end":"2026-02-18T05:18:23.964899Z","steps":["trace[820379921] 'process raft request' (duration: 111.867717ms)","trace[820379921] 'compare' (duration: 175.188127ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:18:24.007853Z","caller":"traceutil/trace.go:171","msg":"trace[1080288514] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"330.431261ms","start":"2026-02-18T05:18:23.677372Z","end":"2026-02-18T05:18:24.007804Z","steps":["trace[1080288514] 'process raft request' (duration: 330.153955ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:24.007905Z","caller":"traceutil/trace.go:171","msg":"trace[1316388870] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"328.683683ms","start":"2026-02-18T05:18:23.679202Z","end":"2026-02-18T05:18:24.007886Z","steps":["trace[1316388870] 'process raft request' (duration: 328.441798ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:24.008234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:23.679192Z","time spent":"328.970588ms","remote":"127.0.0.1:39614","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-18T05:18:24.008082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:23.677366Z","time spent":"330.581944ms","remote":"127.0.0.1:39614","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-18T05:18:37.448689Z","caller":"traceutil/trace.go:171","msg":"trace[1248841569] linearizableReadLoop","detail":"{readStateIndex:882; appliedIndex:881; }","duration":"265.964195ms","start":"2026-02-18T05:18:37.18271Z","end":"2026-02-18T05:18:37.448674Z","steps":["trace[1248841569] 'read index received' (duration: 265.849633ms)","trace[1248841569] 'applied index is now lower than readState.Index' (duration: 113.982µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:18:37.448765Z","caller":"traceutil/trace.go:171","msg":"trace[369053174] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"379.544508ms","start":"2026-02-18T05:18:37.069215Z","end":"2026-02-18T05:18:37.44876Z","steps":["trace[369053174] 'process raft request' (duration: 379.347944ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:37.448823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:37.069187Z","time spent":"379.590659ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T05:18:37.448895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.18631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:18:37.448913Z","caller":"traceutil/trace.go:171","msg":"trace[1268892358] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:847; }","duration":"266.2254ms","start":"2026-02-18T05:18:37.182682Z","end":"2026-02-18T05:18:37.448907Z","steps":["trace[1268892358] 'agreement among raft nodes before linearized reading' (duration: 266.19984ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:38.578096Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389694866695673416,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-18T05:18:39.019337Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.001429928s","expected-duration":"1s"} {"level":"info","ts":"2026-02-18T05:18:39.019612Z","caller":"traceutil/trace.go:171","msg":"trace[2070686062] linearizableReadLoop","detail":"{readStateIndex:884; appliedIndex:883; }","duration":"942.169904ms","start":"2026-02-18T05:18:38.077426Z","end":"2026-02-18T05:18:39.019596Z","steps":["trace[2070686062] 'read index received' (duration: 942.019501ms)","trace[2070686062] 'applied index is now lower than readState.Index' (duration: 149.603µs)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:18:39.01986Z","caller":"traceutil/trace.go:171","msg":"trace[443147464] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"1.00199637s","start":"2026-02-18T05:18:38.017856Z","end":"2026-02-18T05:18:39.019852Z","steps":["trace[443147464] 'process raft request' (duration: 1.001636423s)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:39.019931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:38.017848Z","time spent":"1.002033101s","remote":"127.0.0.1:39614","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-18T05:18:39.020089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.658114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T05:18:39.020111Z","caller":"traceutil/trace.go:171","msg":"trace[1745721423] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:849; }","duration":"942.707566ms","start":"2026-02-18T05:18:38.077397Z","end":"2026-02-18T05:18:39.020105Z","steps":["trace[1745721423] 'agreement among raft nodes before linearized reading' (duration: 942.639044ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:39.020146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:38.077383Z","time spent":"942.741576ms","remote":"127.0.0.1:39704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":68,"response size":29,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-02-18T05:18:39.020315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.614475ms","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-18T05:18:39.020333Z","caller":"traceutil/trace.go:171","msg":"trace[1307870574] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:849; }","duration":"936.645015ms","start":"2026-02-18T05:18:38.083683Z","end":"2026-02-18T05:18:39.020328Z","steps":["trace[1307870574] 'agreement among raft nodes before linearized reading' (duration: 936.563404ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:39.020359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:38.083678Z","time spent":"936.668276ms","remote":"127.0.0.1:39614","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-18T05:18:39.020515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.007523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T05:18:39.020537Z","caller":"traceutil/trace.go:171","msg":"trace[128880573] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:849; }","duration":"496.057945ms","start":"2026-02-18T05:18:38.524473Z","end":"2026-02-18T05:18:39.020531Z","steps":["trace[128880573] 'agreement among raft nodes before linearized reading' (duration: 496.012214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:39.020554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:38.524461Z","time spent":"496.088895ms","remote":"127.0.0.1:39724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-18T05:18:39.020708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.341643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-18T05:18:39.020736Z","caller":"traceutil/trace.go:171","msg":"trace[1078153111] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:849; }","duration":"917.383004ms","start":"2026-02-18T05:18:38.103348Z","end":"2026-02-18T05:18:39.020731Z","steps":["trace[1078153111] 'agreement among raft nodes before linearized reading' (duration: 917.302352ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:39.020753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:38.103342Z","time spent":"917.406814ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-18T05:18:39.566567Z","caller":"traceutil/trace.go:171","msg":"trace[423967233] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"542.022865ms","start":"2026-02-18T05:18:39.024516Z","end":"2026-02-18T05:18:39.566539Z","steps":["trace[423967233] 'process raft request' (duration: 541.551985ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:39.566668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:39.024498Z","time spent":"542.114457ms","remote":"127.0.0.1:39614","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-18T05:18:39.570074Z","caller":"traceutil/trace.go:171","msg":"trace[161307977] linearizableReadLoop","detail":"{readStateIndex:886; appliedIndex:884; }","duration":"432.716273ms","start":"2026-02-18T05:18:39.137336Z","end":"2026-02-18T05:18:39.570052Z","steps":["trace[161307977] 'read index received' (duration: 429.003094ms)","trace[161307977] 'applied index is now lower than readState.Index' (duration: 3.712659ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:18:39.570258Z","caller":"traceutil/trace.go:171","msg":"trace[2104452902] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"544.939947ms","start":"2026-02-18T05:18:39.025306Z","end":"2026-02-18T05:18:39.570246Z","steps":["trace[2104452902] 'process raft request' (duration: 544.667581ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:39.570312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:39.025293Z","time spent":"544.984298ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T05:18:39.570426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.08532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:18:39.570451Z","caller":"traceutil/trace.go:171","msg":"trace[1849554384] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:851; }","duration":"433.113261ms","start":"2026-02-18T05:18:39.137331Z","end":"2026-02-18T05:18:39.570444Z","steps":["trace[1849554384] 'agreement among raft nodes before linearized reading' (duration: 433.0697ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:39.57047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:39.137291Z","time spent":"433.173042ms","remote":"127.0.0.1:39520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-02-18T05:18:39.570621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.375911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:18:39.570641Z","caller":"traceutil/trace.go:171","msg":"trace[1121593794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:851; }","duration":"391.412601ms","start":"2026-02-18T05:18:39.17922Z","end":"2026-02-18T05:18:39.570633Z","steps":["trace[1121593794] 'agreement among raft nodes before linearized reading' (duration: 391.3861ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:39.570655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:39.179209Z","time spent":"391.442511ms","remote":"127.0.0.1:39338","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-18T05:18:39.570807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.507311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-18T05:18:39.570867Z","caller":"traceutil/trace.go:171","msg":"trace[1730274851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:851; }","duration":"112.537712ms","start":"2026-02-18T05:18:39.458282Z","end":"2026-02-18T05:18:39.57082Z","steps":["trace[1730274851] 'agreement among raft nodes before linearized reading' (duration: 112.485061ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:39.571411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.575331ms","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-18T05:18:39.571432Z","caller":"traceutil/trace.go:171","msg":"trace[405944246] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:851; }","duration":"118.637072ms","start":"2026-02-18T05:18:39.452786Z","end":"2026-02-18T05:18:39.571423Z","steps":["trace[405944246] 'agreement among raft nodes before linearized reading' (duration: 118.586641ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:42.133979Z","caller":"traceutil/trace.go:171","msg":"trace[962797589] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"460.663499ms","start":"2026-02-18T05:18:41.6733Z","end":"2026-02-18T05:18:42.133963Z","steps":["trace[962797589] 'process raft request' (duration: 460.576907ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:42.134083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:41.673286Z","time spent":"460.738371ms","remote":"127.0.0.1:39614","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-18T05:18:42.210351Z","caller":"traceutil/trace.go:171","msg":"trace[666375969] linearizableReadLoop","detail":"{readStateIndex:893; appliedIndex:891; }","duration":"303.617919ms","start":"2026-02-18T05:18:41.906717Z","end":"2026-02-18T05:18:42.210335Z","steps":["trace[666375969] 'read index received' (duration: 227.608778ms)","trace[666375969] 'applied index is now lower than readState.Index' (duration: 76.008551ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:18:42.210622Z","caller":"traceutil/trace.go:171","msg":"trace[1490200621] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"537.213583ms","start":"2026-02-18T05:18:41.673402Z","end":"2026-02-18T05:18:42.210616Z","steps":["trace[1490200621] 'process raft request' (duration: 536.790964ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:42.210691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:41.673398Z","time spent":"537.239054ms","remote":"127.0.0.1:39614","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-18T05:18:42.210807Z","caller":"traceutil/trace.go:171","msg":"trace[649824315] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"529.272063ms","start":"2026-02-18T05:18:41.68153Z","end":"2026-02-18T05:18:42.210802Z","steps":["trace[649824315] 'process raft request' (duration: 528.782263ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:42.210832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:41.681523Z","time spent":"529.294794ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T05:18:42.210935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.219342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-18T05:18:42.210951Z","caller":"traceutil/trace.go:171","msg":"trace[248392102] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:858; }","duration":"304.271423ms","start":"2026-02-18T05:18:41.906674Z","end":"2026-02-18T05:18:42.210945Z","steps":["trace[248392102] 'agreement among raft nodes before linearized reading' (duration: 304.210632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:42.210964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:41.906655Z","time spent":"304.306884ms","remote":"127.0.0.1:39374","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.155\" "} {"level":"warn","ts":"2026-02-18T05:18:46.394733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.727304ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T05:18:46.394802Z","caller":"traceutil/trace.go:171","msg":"trace[1720270160] linearizableReadLoop","detail":"{readStateIndex:905; appliedIndex:904; }","duration":"215.222912ms","start":"2026-02-18T05:18:46.179568Z","end":"2026-02-18T05:18:46.39479Z","steps":["trace[1720270160] 'read index received' (duration: 65.358165ms)","trace[1720270160] 'applied index is now lower than readState.Index' (duration: 149.863897ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:18:46.394968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.381646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-18T05:18:46.395013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.118846ms","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-18T05:18:46.395023Z","caller":"traceutil/trace.go:171","msg":"trace[1883017683] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:869; }","duration":"215.460858ms","start":"2026-02-18T05:18:46.17955Z","end":"2026-02-18T05:18:46.395011Z","steps":["trace[1883017683] 'agreement among raft nodes before linearized reading' (duration: 215.361315ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:46.395037Z","caller":"traceutil/trace.go:171","msg":"trace[1264673393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:869; }","duration":"174.169447ms","start":"2026-02-18T05:18:46.220861Z","end":"2026-02-18T05:18:46.39503Z","steps":["trace[1264673393] 'agreement among raft nodes before linearized reading' (duration: 174.082205ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:46.395178Z","caller":"traceutil/trace.go:171","msg":"trace[1620474803] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"224.0149ms","start":"2026-02-18T05:18:46.171153Z","end":"2026-02-18T05:18:46.395168Z","steps":["trace[1620474803] 'process raft request' (duration: 73.793194ms)","trace[1620474803] 'compare' (duration: 149.634883ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:18:46.395198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.602462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-18T05:18:46.395218Z","caller":"traceutil/trace.go:171","msg":"trace[1085846440] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:869; }","duration":"171.624473ms","start":"2026-02-18T05:18:46.223588Z","end":"2026-02-18T05:18:46.395213Z","steps":["trace[1085846440] 'agreement among raft nodes before linearized reading' (duration: 171.558521ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:46.563238Z","caller":"traceutil/trace.go:171","msg":"trace[926414953] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"163.627812ms","start":"2026-02-18T05:18:46.399595Z","end":"2026-02-18T05:18:46.563223Z","steps":["trace[926414953] 'process raft request' (duration: 163.601441ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:46.563536Z","caller":"traceutil/trace.go:171","msg":"trace[74087335] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"164.148943ms","start":"2026-02-18T05:18:46.399379Z","end":"2026-02-18T05:18:46.563528Z","steps":["trace[74087335] 'process raft request' (duration: 99.685798ms)","trace[74087335] 'compare' (duration: 64.056957ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:18:52.874078Z","caller":"traceutil/trace.go:171","msg":"trace[1822027709] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"249.497424ms","start":"2026-02-18T05:18:52.624558Z","end":"2026-02-18T05:18:52.874056Z","steps":["trace[1822027709] 'process raft request' (duration: 249.303139ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:52.874267Z","caller":"traceutil/trace.go:171","msg":"trace[63348039] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"248.704426ms","start":"2026-02-18T05:18:52.625552Z","end":"2026-02-18T05:18:52.874257Z","steps":["trace[63348039] 'process raft request' (duration: 248.651045ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:54.167365Z","caller":"traceutil/trace.go:171","msg":"trace[718578049] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"357.956918ms","start":"2026-02-18T05:18:53.809382Z","end":"2026-02-18T05:18:54.167339Z","steps":["trace[718578049] 'process raft request' (duration: 357.802245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:54.167514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:53.80936Z","time spent":"358.07497ms","remote":"127.0.0.1:39614","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-18T05:18:54.588559Z","caller":"traceutil/trace.go:171","msg":"trace[562754931] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"131.773942ms","start":"2026-02-18T05:18:54.456765Z","end":"2026-02-18T05:18:54.588539Z","steps":["trace[562754931] 'process raft request' (duration: 131.648839ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:54.872399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.208464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T05:18:54.872468Z","caller":"traceutil/trace.go:171","msg":"trace[964710647] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"399.7362ms","start":"2026-02-18T05:18:54.472718Z","end":"2026-02-18T05:18:54.872455Z","steps":["trace[964710647] 'process raft request' (duration: 220.396023ms)","trace[964710647] 'compare' (duration: 178.981549ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:18:54.872504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:54.472701Z","time spent":"399.78734ms","remote":"127.0.0.1:39614","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-18T05:18:54.996589Z","caller":"traceutil/trace.go:171","msg":"trace[1682480743] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"107.173696ms","start":"2026-02-18T05:18:54.889379Z","end":"2026-02-18T05:18:54.996553Z","steps":["trace[1682480743] 'process raft request' (duration: 85.480253ms)","trace[1682480743] 'compare' (duration: 21.572891ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:18:56.526583Z","caller":"traceutil/trace.go:171","msg":"trace[194187772] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"106.908121ms","start":"2026-02-18T05:18:56.419653Z","end":"2026-02-18T05:18:56.526561Z","steps":["trace[194187772] 'process raft request' (duration: 105.44773ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:56.814276Z","caller":"traceutil/trace.go:171","msg":"trace[1865835007] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"218.222676ms","start":"2026-02-18T05:18:56.596035Z","end":"2026-02-18T05:18:56.814258Z","steps":["trace[1865835007] 'process raft request' (duration: 211.090033ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:58.28812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.052137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:18:58.288184Z","caller":"traceutil/trace.go:171","msg":"trace[1180355174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:902; }","duration":"109.146959ms","start":"2026-02-18T05:18:58.179021Z","end":"2026-02-18T05:18:58.288168Z","steps":["trace[1180355174] 'range keys from in-memory index tree' (duration: 109.000866ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:58.494799Z","caller":"traceutil/trace.go:171","msg":"trace[830658755] linearizableReadLoop","detail":"{readStateIndex:942; appliedIndex:941; }","duration":"137.654427ms","start":"2026-02-18T05:18:58.357094Z","end":"2026-02-18T05:18:58.494748Z","steps":["trace[830658755] 'read index received' (duration: 137.500584ms)","trace[830658755] 'applied index is now lower than readState.Index' (duration: 152.973µs)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:18:58.494978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.864092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4740"} {"level":"info","ts":"2026-02-18T05:18:58.495014Z","caller":"traceutil/trace.go:171","msg":"trace[854625409] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:903; }","duration":"137.940733ms","start":"2026-02-18T05:18:58.357064Z","end":"2026-02-18T05:18:58.495005Z","steps":["trace[854625409] 'agreement among raft nodes before linearized reading' (duration: 137.79216ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:58.495314Z","caller":"traceutil/trace.go:171","msg":"trace[941222880] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"200.102969ms","start":"2026-02-18T05:18:58.2952Z","end":"2026-02-18T05:18:58.495303Z","steps":["trace[941222880] 'process raft request' (duration: 199.444395ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:59.103354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.638628ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T05:18:59.103421Z","caller":"traceutil/trace.go:171","msg":"trace[1742308466] linearizableReadLoop","detail":"{readStateIndex:943; appliedIndex:942; }","duration":"430.572198ms","start":"2026-02-18T05:18:58.672837Z","end":"2026-02-18T05:18:59.103409Z","steps":["trace[1742308466] 'read index received' (duration: 291.775337ms)","trace[1742308466] 'applied index is now lower than readState.Index' (duration: 138.795951ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:18:59.103491Z","caller":"traceutil/trace.go:171","msg":"trace[606091778] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"597.011408ms","start":"2026-02-18T05:18:58.506473Z","end":"2026-02-18T05:18:59.103484Z","steps":["trace[606091778] 'process raft request' (duration: 458.197217ms)","trace[606091778] 'compare' (duration: 138.459274ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:18:59.103527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:58.506459Z","time spent":"597.052239ms","remote":"127.0.0.1:39430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":750,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T05:18:59.103687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.847434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T05:18:59.103713Z","caller":"traceutil/trace.go:171","msg":"trace[1722552241] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:904; }","duration":"430.901964ms","start":"2026-02-18T05:18:58.672805Z","end":"2026-02-18T05:18:59.103707Z","steps":["trace[1722552241] 'agreement among raft nodes before linearized reading' (duration: 430.843873ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:59.103737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:58.672791Z","time spent":"430.941246ms","remote":"127.0.0.1:39628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":29,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-02-18T05:18:59.103832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.348559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:18:59.103854Z","caller":"traceutil/trace.go:171","msg":"trace[1075355145] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:904; }","duration":"397.4069ms","start":"2026-02-18T05:18:58.706442Z","end":"2026-02-18T05:18:59.103849Z","steps":["trace[1075355145] 'agreement among raft nodes before linearized reading' (duration: 397.375359ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:59.103877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:58.70642Z","time spent":"397.450471ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" "} {"level":"warn","ts":"2026-02-18T05:18:59.104148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.714649ms","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-18T05:18:59.104174Z","caller":"traceutil/trace.go:171","msg":"trace[774378423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:904; }","duration":"116.762171ms","start":"2026-02-18T05:18:58.987406Z","end":"2026-02-18T05:18:59.104168Z","steps":["trace[774378423] 'agreement among raft nodes before linearized reading' (duration: 116.70445ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:59.104286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.105242ms","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-18T05:18:59.104309Z","caller":"traceutil/trace.go:171","msg":"trace[1099556417] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:904; }","duration":"285.161974ms","start":"2026-02-18T05:18:58.819142Z","end":"2026-02-18T05:18:59.104304Z","steps":["trace[1099556417] 'agreement among raft nodes before linearized reading' (duration: 285.103532ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:59.679321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.737944ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T05:18:59.68034Z","caller":"traceutil/trace.go:171","msg":"trace[372236267] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"480.919262ms","start":"2026-02-18T05:18:59.199405Z","end":"2026-02-18T05:18:59.680324Z","steps":["trace[372236267] 'process raft request' (duration: 17.106075ms)","trace[372236267] 'compare' (duration: 462.319734ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:18:59.680481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:59.199386Z","time spent":"481.072065ms","remote":"127.0.0.1:39430","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-18T05:18:59.731382Z","caller":"traceutil/trace.go:171","msg":"trace[115650122] linearizableReadLoop","detail":"{readStateIndex:945; appliedIndex:943; }","duration":"529.043529ms","start":"2026-02-18T05:18:59.202324Z","end":"2026-02-18T05:18:59.731367Z","steps":["trace[115650122] 'read index received' (duration: 14.191773ms)","trace[115650122] 'applied index is now lower than readState.Index' (duration: 514.850946ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:18:59.731615Z","caller":"traceutil/trace.go:171","msg":"trace[1337705792] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"529.342795ms","start":"2026-02-18T05:18:59.202267Z","end":"2026-02-18T05:18:59.73161Z","steps":["trace[1337705792] 'process raft request' (duration: 528.981997ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:59.731679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:59.202258Z","time spent":"529.376445ms","remote":"127.0.0.1:39614","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-18T05:18:59.731755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.402036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:18:59.731805Z","caller":"traceutil/trace.go:171","msg":"trace[1052351724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:908; }","duration":"529.489308ms","start":"2026-02-18T05:18:59.202304Z","end":"2026-02-18T05:18:59.731794Z","steps":["trace[1052351724] 'agreement among raft nodes before linearized reading' (duration: 529.369935ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:59.731831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:59.202299Z","time spent":"529.527458ms","remote":"127.0.0.1:39338","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-18T05:18:59.731831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.314826ms","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-18T05:18:59.731853Z","caller":"traceutil/trace.go:171","msg":"trace[1098443963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:908; }","duration":"509.374988ms","start":"2026-02-18T05:18:59.222472Z","end":"2026-02-18T05:18:59.731847Z","steps":["trace[1098443963] 'agreement among raft nodes before linearized reading' (duration: 509.305376ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:59.731867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:59.222447Z","time spent":"509.417399ms","remote":"127.0.0.1:39614","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-18T05:18:59.731965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.34651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T05:18:59.731979Z","caller":"traceutil/trace.go:171","msg":"trace[909462614] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:908; }","duration":"212.523723ms","start":"2026-02-18T05:18:59.519451Z","end":"2026-02-18T05:18:59.731974Z","steps":["trace[909462614] 'agreement among raft nodes before linearized reading' (duration: 212.494813ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:18:59.731974Z","caller":"traceutil/trace.go:171","msg":"trace[1046780727] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"529.60749ms","start":"2026-02-18T05:18:59.20236Z","end":"2026-02-18T05:18:59.731967Z","steps":["trace[1046780727] 'process raft request' (duration: 528.966967ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:59.73203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:59.202355Z","time spent":"529.637591ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T05:18:59.732063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.715859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T05:18:59.732076Z","caller":"traceutil/trace.go:171","msg":"trace[1183782322] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:908; }","duration":"497.75213ms","start":"2026-02-18T05:18:59.23432Z","end":"2026-02-18T05:18:59.732072Z","steps":["trace[1183782322] 'agreement among raft nodes before linearized reading' (duration: 497.72473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:59.732088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:59.234293Z","time spent":"497.792001ms","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-02-18T05:18:59.732103Z","caller":"traceutil/trace.go:171","msg":"trace[226140754] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"529.684592ms","start":"2026-02-18T05:18:59.202413Z","end":"2026-02-18T05:18:59.732098Z","steps":["trace[226140754] 'process raft request' (duration: 528.936896ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:18:59.732128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:59.202409Z","time spent":"529.706032ms","remote":"127.0.0.1:39614","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-18T05:19:00.986145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.285931ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-18T05:19:00.986205Z","caller":"traceutil/trace.go:171","msg":"trace[488613697] linearizableReadLoop","detail":"{readStateIndex:948; appliedIndex:947; }","duration":"983.77229ms","start":"2026-02-18T05:19:00.002423Z","end":"2026-02-18T05:19:00.986195Z","steps":["trace[488613697] 'read index received' (duration: 463.376786ms)","trace[488613697] 'applied index is now lower than readState.Index' (duration: 520.394914ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:19:00.986307Z","caller":"traceutil/trace.go:171","msg":"trace[1307815431] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"1.249881809s","start":"2026-02-18T05:18:59.736419Z","end":"2026-02-18T05:19:00.986301Z","steps":["trace[1307815431] 'process raft request' (duration: 729.393603ms)","trace[1307815431] 'compare' (duration: 520.156709ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:19:00.986335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:18:59.73641Z","time spent":"1.249910449s","remote":"127.0.0.1:39614","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-18T05:19:00.986452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.027417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-18T05:19:00.986466Z","caller":"traceutil/trace.go:171","msg":"trace[654464313] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:909; }","duration":"984.041597ms","start":"2026-02-18T05:19:00.002419Z","end":"2026-02-18T05:19:00.986461Z","steps":["trace[654464313] 'agreement among raft nodes before linearized reading' (duration: 984.011806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:19:00.986481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:19:00.002369Z","time spent":"984.106958ms","remote":"127.0.0.1:39680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":14,"response size":29,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-02-18T05:19:00.986575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.582435ms","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-18T05:19:00.986588Z","caller":"traceutil/trace.go:171","msg":"trace[1267155329] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:909; }","duration":"675.634146ms","start":"2026-02-18T05:19:00.31095Z","end":"2026-02-18T05:19:00.986584Z","steps":["trace[1267155329] 'agreement among raft nodes before linearized reading' (duration: 675.611655ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:19:00.986602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:19:00.31093Z","time spent":"675.668797ms","remote":"127.0.0.1:39850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":3,"response size":29,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-02-18T05:19:00.986732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.522261ms","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-18T05:19:00.986745Z","caller":"traceutil/trace.go:171","msg":"trace[176216267] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:909; }","duration":"486.562321ms","start":"2026-02-18T05:19:00.500178Z","end":"2026-02-18T05:19:00.986741Z","steps":["trace[176216267] 'agreement among raft nodes before linearized reading' (duration: 486.50488ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:19:00.986757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:19:00.500162Z","time spent":"486.591762ms","remote":"127.0.0.1:39614","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":"info","ts":"2026-02-18T05:19:05.261165Z","caller":"traceutil/trace.go:171","msg":"trace[1303477673] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"248.679357ms","start":"2026-02-18T05:19:05.01247Z","end":"2026-02-18T05:19:05.261149Z","steps":["trace[1303477673] 'process raft request' (duration: 248.595685ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:19:05.427218Z","caller":"traceutil/trace.go:171","msg":"trace[1849683374] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"413.38551ms","start":"2026-02-18T05:19:05.013818Z","end":"2026-02-18T05:19:05.427203Z","steps":["trace[1849683374] 'process raft request' (duration: 409.460457ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:19:05.427318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:19:05.013801Z","time spent":"413.456682ms","remote":"127.0.0.1:39614","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-18T05:19:05.427308Z","caller":"traceutil/trace.go:171","msg":"trace[650745642] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"369.187097ms","start":"2026-02-18T05:19:05.058095Z","end":"2026-02-18T05:19:05.427282Z","steps":["trace[650745642] 'process raft request' (duration: 368.910461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:19:05.427477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:19:05.058077Z","time spent":"369.3073ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-18T05:19:07.384813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.929719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-18T05:19:07.384977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.086413ms","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-18T05:19:07.38503Z","caller":"traceutil/trace.go:171","msg":"trace[1825335113] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:950; }","duration":"120.168874ms","start":"2026-02-18T05:19:07.264848Z","end":"2026-02-18T05:19:07.385017Z","steps":["trace[1825335113] 'range keys from in-memory index tree' (duration: 119.94892ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:19:07.385791Z","caller":"traceutil/trace.go:171","msg":"trace[1555831442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:950; }","duration":"202.067131ms","start":"2026-02-18T05:19:07.182801Z","end":"2026-02-18T05:19:07.384868Z","steps":["trace[1555831442] 'range keys from in-memory index tree' (duration: 201.823716ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:19:09.544236Z","caller":"traceutil/trace.go:171","msg":"trace[2082522714] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"102.853965ms","start":"2026-02-18T05:19:09.441364Z","end":"2026-02-18T05:19:09.544218Z","steps":["trace[2082522714] 'process raft request' (duration: 102.745483ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:19:12.766443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.839763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:19:12.766567Z","caller":"traceutil/trace.go:171","msg":"trace[374690731] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:983; }","duration":"245.002107ms","start":"2026-02-18T05:19:12.521546Z","end":"2026-02-18T05:19:12.766548Z","steps":["trace[374690731] 'range keys from in-memory index tree' (duration: 244.792593ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:19:13.313632Z","caller":"traceutil/trace.go:171","msg":"trace[1343764102] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"672.535541ms","start":"2026-02-18T05:19:12.641011Z","end":"2026-02-18T05:19:13.313547Z","steps":["trace[1343764102] 'process raft request' (duration: 672.340106ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:19:13.313784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:19:12.640987Z","time spent":"672.714324ms","remote":"127.0.0.1:39430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":784,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-18T05:19:13.595274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.881806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T05:19:13.595422Z","caller":"traceutil/trace.go:171","msg":"trace[703576529] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"277.055452ms","start":"2026-02-18T05:19:13.31835Z","end":"2026-02-18T05:19:13.595406Z","steps":["trace[703576529] 'process raft request' (duration: 277.002631ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:19:13.595835Z","caller":"traceutil/trace.go:171","msg":"trace[973819976] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1025; }","duration":"536.265952ms","start":"2026-02-18T05:19:13.059531Z","end":"2026-02-18T05:19:13.595797Z","steps":["trace[973819976] 'read index received' (duration: 253.97888ms)","trace[973819976] 'applied index is now lower than readState.Index' (duration: 282.285002ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:19:13.596008Z","caller":"traceutil/trace.go:171","msg":"trace[1917257633] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"810.460282ms","start":"2026-02-18T05:19:12.785537Z","end":"2026-02-18T05:19:13.595997Z","steps":["trace[1917257633] 'process raft request' (duration: 646.156547ms)","trace[1917257633] 'compare' (duration: 162.446856ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:19:13.596255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.871863ms","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-18T05:19:13.596306Z","caller":"traceutil/trace.go:171","msg":"trace[332190414] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:986; }","duration":"183.959396ms","start":"2026-02-18T05:19:13.412335Z","end":"2026-02-18T05:19:13.596294Z","steps":["trace[332190414] 'agreement among raft nodes before linearized reading' (duration: 183.808572ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:19:13.596668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.130151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-02-18T05:19:13.596708Z","caller":"traceutil/trace.go:171","msg":"trace[762871552] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:986; }","duration":"537.205793ms","start":"2026-02-18T05:19:13.059493Z","end":"2026-02-18T05:19:13.596699Z","steps":["trace[762871552] 'agreement among raft nodes before linearized reading' (duration: 537.03674ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:19:13.596774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:19:13.059477Z","time spent":"537.286865ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-18T05:19:13.597445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:19:12.785523Z","time spent":"810.654418ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":512,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T05:22:19.535448Z","caller":"traceutil/trace.go:171","msg":"trace[1442898572] transaction","detail":"{read_only:false; response_revision:1791; number_of_response:1; }","duration":"131.384087ms","start":"2026-02-18T05:22:19.404036Z","end":"2026-02-18T05:22:19.53542Z","steps":["trace[1442898572] 'process raft request' (duration: 131.229194ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:22:19.911452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.687451ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-18T05:22:19.911515Z","caller":"traceutil/trace.go:171","msg":"trace[1722502688] transaction","detail":"{read_only:false; response_revision:1792; number_of_response:1; }","duration":"362.149484ms","start":"2026-02-18T05:22:19.549354Z","end":"2026-02-18T05:22:19.911503Z","steps":["trace[1722502688] 'process raft request' (duration: 63.36113ms)","trace[1722502688] 'compare' (duration: 278.978583ms)"],"step_count":2} {"level":"warn","ts":"2026-02-18T05:22:19.911543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:22:19.549339Z","time spent":"362.192264ms","remote":"127.0.0.1:39430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":706,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-18T05:22:19.963296Z","caller":"traceutil/trace.go:171","msg":"trace[813215329] transaction","detail":"{read_only:false; response_revision:1793; number_of_response:1; }","duration":"170.879836ms","start":"2026-02-18T05:22:19.792397Z","end":"2026-02-18T05:22:19.963276Z","steps":["trace[813215329] 'process raft request' (duration: 170.780894ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:22:20.885293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.663409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-18T05:22:20.885665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.490399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-02-18T05:22:20.885748Z","caller":"traceutil/trace.go:171","msg":"trace[618195536] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1793; }","duration":"212.585682ms","start":"2026-02-18T05:22:20.673113Z","end":"2026-02-18T05:22:20.885698Z","steps":["trace[618195536] 'range keys from in-memory index tree' (duration: 212.391987ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:22:20.886402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.855526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-02-18T05:22:20.886472Z","caller":"traceutil/trace.go:171","msg":"trace[970459763] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1793; }","duration":"515.948258ms","start":"2026-02-18T05:22:20.370515Z","end":"2026-02-18T05:22:20.886464Z","steps":["trace[970459763] 'range keys from in-memory index tree' (duration: 515.734963ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:22:20.886541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:22:20.370481Z","time spent":"516.05148ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-18T05:22:20.886816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.598322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-18T05:22:20.887025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.14913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-18T05:22:20.887076Z","caller":"traceutil/trace.go:171","msg":"trace[654320685] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1793; }","duration":"105.254511ms","start":"2026-02-18T05:22:20.781813Z","end":"2026-02-18T05:22:20.887068Z","steps":["trace[654320685] 'range keys from in-memory index tree' (duration: 105.057067ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:22:20.885735Z","caller":"traceutil/trace.go:171","msg":"trace[2106461638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1793; }","duration":"416.057168ms","start":"2026-02-18T05:22:20.469607Z","end":"2026-02-18T05:22:20.885665Z","steps":["trace[2106461638] 'range keys from in-memory index tree' (duration: 415.533585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:22:20.887518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T05:22:20.469565Z","time spent":"417.941541ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-18T05:22:20.885574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.616881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-18T05:22:20.88775Z","caller":"traceutil/trace.go:171","msg":"trace[1642223405] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1793; }","duration":"243.832272ms","start":"2026-02-18T05:22:20.643908Z","end":"2026-02-18T05:22:20.88774Z","steps":["trace[1642223405] 'range keys from in-memory index tree' (duration: 241.442798ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:22:20.886867Z","caller":"traceutil/trace.go:171","msg":"trace[184115852] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1793; }","duration":"205.678464ms","start":"2026-02-18T05:22:20.681176Z","end":"2026-02-18T05:22:20.886854Z","steps":["trace[184115852] 'range keys from in-memory index tree' (duration: 205.5049ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:22:20.899114Z","caller":"traceutil/trace.go:171","msg":"trace[1321575450] transaction","detail":"{read_only:false; response_revision:1794; number_of_response:1; }","duration":"106.551792ms","start":"2026-02-18T05:22:20.79255Z","end":"2026-02-18T05:22:20.899102Z","steps":["trace[1321575450] 'process raft request' (duration: 106.442049ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:22:21.000976Z","caller":"traceutil/trace.go:171","msg":"trace[1514803415] transaction","detail":"{read_only:false; response_revision:1796; number_of_response:1; }","duration":"104.6797ms","start":"2026-02-18T05:22:20.896279Z","end":"2026-02-18T05:22:21.000958Z","steps":["trace[1514803415] 'process raft request' (duration: 104.276611ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:22:21.002236Z","caller":"traceutil/trace.go:171","msg":"trace[1288583576] transaction","detail":"{read_only:false; response_revision:1795; number_of_response:1; }","duration":"106.033461ms","start":"2026-02-18T05:22:20.896195Z","end":"2026-02-18T05:22:21.002229Z","steps":["trace[1288583576] 'process raft request' (duration: 95.667785ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:22:21.002461Z","caller":"traceutil/trace.go:171","msg":"trace[1773219611] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"104.157058ms","start":"2026-02-18T05:22:20.898299Z","end":"2026-02-18T05:22:21.002456Z","steps":["trace[1773219611] 'process raft request' (duration: 102.293726ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:22:21.004494Z","caller":"traceutil/trace.go:171","msg":"trace[1655314145] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"108.104247ms","start":"2026-02-18T05:22:20.896379Z","end":"2026-02-18T05:22:21.004483Z","steps":["trace[1655314145] 'process raft request' (duration: 104.198558ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:22:21.004652Z","caller":"traceutil/trace.go:171","msg":"trace[2067413987] linearizableReadLoop","detail":"{readStateIndex:1878; appliedIndex:1874; }","duration":"105.364045ms","start":"2026-02-18T05:22:20.899282Z","end":"2026-02-18T05:22:21.004646Z","steps":["trace[2067413987] 'read index received' (duration: 92.586314ms)","trace[2067413987] 'applied index is now lower than readState.Index' (duration: 12.776931ms)"],"step_count":2} {"level":"info","ts":"2026-02-18T05:22:21.006016Z","caller":"traceutil/trace.go:171","msg":"trace[1994474358] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"103.846621ms","start":"2026-02-18T05:22:20.902161Z","end":"2026-02-18T05:22:21.006008Z","steps":["trace[1994474358] 'process raft request' (duration: 98.475579ms)"],"step_count":1} {"level":"info","ts":"2026-02-18T05:22:21.006105Z","caller":"traceutil/trace.go:171","msg":"trace[1136035240] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"105.54827ms","start":"2026-02-18T05:22:20.900552Z","end":"2026-02-18T05:22:21.0061Z","steps":["trace[1136035240] 'process raft request' (duration: 100.066345ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:22:21.006322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.303923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-18T05:22:21.00634Z","caller":"traceutil/trace.go:171","msg":"trace[108863841] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1800; }","duration":"108.348833ms","start":"2026-02-18T05:22:20.897986Z","end":"2026-02-18T05:22:21.006335Z","steps":["trace[108863841] 'agreement among raft nodes before linearized reading' (duration: 108.306402ms)"],"step_count":1} {"level":"warn","ts":"2026-02-18T05:22:21.006486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.267488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-18T05:22:21.006521Z","caller":"traceutil/trace.go:171","msg":"trace[1876084782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1800; }","duration":"198.297678ms","start":"2026-02-18T05:22:20.808201Z","end":"2026-02-18T05:22:21.006499Z","steps":["trace[1876084782] 'agreement among raft nodes before linearized reading' (duration: 198.230447ms)"],"step_count":1}