{"level":"warn","ts":"2026-04-03T02:18:42.755902Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-03T02:18:42.756011Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-03T02:18:42.756085Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-03T02:18:42.756102Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-04-03T02:18:42.756128Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-03T02:18:42.756989Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-04-03T02:18:42.757088Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-03T02:18:42.760946Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.564ms"} {"level":"info","ts":"2026-04-03T02:18:42.768129Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-04-03T02:18:42.768239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-04-03T02:18:42.76826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-04-03T02:18:42.76827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-03T02:18:42.768278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-04-03T02:18:42.768312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-04-03T02:18:42.77609Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-03T02:18:42.778521Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-03T02:18:42.780067Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-03T02:18:42.782209Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-03T02:18:42.782458Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-03T02:18:42.782676Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-03T02:18:42.783176Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-03T02:18:42.783212Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-03T02:18:42.783795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-04-03T02:18:42.784128Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-04-03T02:18:42.78663Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-03T02:18:42.786711Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-04-03T02:18:42.786885Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-04-03T02:18:42.787101Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-03T02:18:42.78731Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-03T02:18:43.068723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-04-03T02:18:43.068813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-03T02:18:43.068864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-04-03T02:18:43.06889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-04-03T02:18:43.06891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-04-03T02:18:43.068928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-04-03T02:18:43.068951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-04-03T02:18:43.069887Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T02:18:43.070101Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-04-03T02:18:43.070129Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-03T02:18:43.070365Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-03T02:18:43.070811Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-03T02:18:43.070851Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-03T02:18:43.071065Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T02:18:43.071245Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T02:18:43.071319Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T02:18:43.075223Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-04-03T02:18:43.076775Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-03T02:18:47.787031Z","caller":"traceutil/trace.go:171","msg":"trace[65489681] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"130.962362ms","start":"2026-04-03T02:18:47.656042Z","end":"2026-04-03T02:18:47.787004Z","steps":["trace[65489681] 'process raft request' (duration: 112.529775ms)","trace[65489681] 'compare' (duration: 18.305703ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:48.39733Z","caller":"traceutil/trace.go:171","msg":"trace[885394750] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"116.566739ms","start":"2026-04-03T02:18:48.280708Z","end":"2026-04-03T02:18:48.397275Z","steps":["trace[885394750] 'process raft request' (duration: 115.632485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:48.723302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.957353ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:18:48.723537Z","caller":"traceutil/trace.go:171","msg":"trace[2019003615] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"260.03086ms","start":"2026-04-03T02:18:48.463486Z","end":"2026-04-03T02:18:48.723517Z","steps":["trace[2019003615] 'process raft request' (duration: 259.956738ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:48.723536Z","caller":"traceutil/trace.go:171","msg":"trace[222085282] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"261.450456ms","start":"2026-04-03T02:18:48.462024Z","end":"2026-04-03T02:18:48.723475Z","steps":["trace[222085282] 'process raft request' (duration: 53.738543ms)","trace[222085282] 'compare' (duration: 206.473081ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:48.7237Z","caller":"traceutil/trace.go:171","msg":"trace[84902699] linearizableReadLoop","detail":"{readStateIndex:287; appliedIndex:286; }","duration":"261.450986ms","start":"2026-04-03T02:18:48.462224Z","end":"2026-04-03T02:18:48.723675Z","steps":["trace[84902699] 'read index received' (duration: 53.627861ms)","trace[84902699] 'applied index is now lower than readState.Index' (duration: 207.820725ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:18:48.723849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.825935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4016"} {"level":"warn","ts":"2026-04-03T02:18:48.723875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.151699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2918"} {"level":"info","ts":"2026-04-03T02:18:48.723935Z","caller":"traceutil/trace.go:171","msg":"trace[1509610615] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:278; }","duration":"261.943489ms","start":"2026-04-03T02:18:48.461969Z","end":"2026-04-03T02:18:48.723912Z","steps":["trace[1509610615] 'agreement among raft nodes before linearized reading' (duration: 261.736953ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:48.723935Z","caller":"traceutil/trace.go:171","msg":"trace[1290674282] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:278; }","duration":"265.230842ms","start":"2026-04-03T02:18:48.458687Z","end":"2026-04-03T02:18:48.723918Z","steps":["trace[1290674282] 'agreement among raft nodes before linearized reading' (duration: 265.112059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:48.723934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.144969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3468"} {"level":"info","ts":"2026-04-03T02:18:48.724024Z","caller":"traceutil/trace.go:171","msg":"trace[2120582501] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:278; }","duration":"265.273033ms","start":"2026-04-03T02:18:48.458726Z","end":"2026-04-03T02:18:48.723999Z","steps":["trace[2120582501] 'agreement among raft nodes before linearized reading' (duration: 265.066828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:50.157013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.898126ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:18:50.157797Z","caller":"traceutil/trace.go:171","msg":"trace[253932114] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"1.428035257s","start":"2026-04-03T02:18:48.729111Z","end":"2026-04-03T02:18:50.157146Z","steps":["trace[253932114] 'process raft request' (duration: 502.903595ms)","trace[253932114] 'compare' (duration: 924.593158ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:18:50.157878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:48.729088Z","time spent":"1.428758446s","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:18:50.650874Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.419012518s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-03T02:18:51.026291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999898151s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-03T02:18:51.026411Z","caller":"traceutil/trace.go:171","msg":"trace[1485410490] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000074416s","start":"2026-04-03T02:18:49.026303Z","end":"2026-04-03T02:18:51.026377Z","steps":["trace[1485410490] 'agreement among raft nodes before linearized reading' (duration: 1.999933613s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:51.026528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:49.026272Z","time spent":"2.000241119s","remote":"127.0.0.1:58468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/03 02:18:51 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-03T02:18:51.237185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.011759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:18:51.237568Z","caller":"traceutil/trace.go:171","msg":"trace[1346419468] linearizableReadLoop","detail":"{readStateIndex:291; appliedIndex:288; }","duration":"2.441093646s","start":"2026-04-03T02:18:48.796454Z","end":"2026-04-03T02:18:51.237548Z","steps":["trace[1346419468] 'read index received' (duration: 435.451763ms)","trace[1346419468] 'applied index is now lower than readState.Index' (duration: 2.005640743s)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:51.237651Z","caller":"traceutil/trace.go:171","msg":"trace[154630015] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"2.493685261s","start":"2026-04-03T02:18:48.743947Z","end":"2026-04-03T02:18:51.237632Z","steps":["trace[154630015] 'process raft request' (duration: 2.493508346s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:51.237702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.44124674s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:18:51.237542Z","caller":"traceutil/trace.go:171","msg":"trace[673033356] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"2.50427668s","start":"2026-04-03T02:18:48.733178Z","end":"2026-04-03T02:18:51.237455Z","steps":["trace[673033356] 'process raft request' (duration: 1.917924763s)","trace[673033356] 'compare' (duration: 585.853125ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:18:51.238227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:48.733155Z","time spent":"2.505010398s","remote":"127.0.0.1:58578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1933,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:18:51.237965Z","caller":"traceutil/trace.go:171","msg":"trace[1315503888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:281; }","duration":"2.441533707s","start":"2026-04-03T02:18:48.796388Z","end":"2026-04-03T02:18:51.237921Z","steps":["trace[1315503888] 'agreement among raft nodes before linearized reading' (duration: 2.44125688s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:51.238503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:48.796364Z","time spent":"2.442120292s","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-03T02:18:51.239489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:48.743927Z","time spent":"2.493821274s","remote":"127.0.0.1:58646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4182,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:18:52.16324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000710087s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-03T02:18:52.163312Z","caller":"traceutil/trace.go:171","msg":"trace[1741844559] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00081414s","start":"2026-04-03T02:18:50.162474Z","end":"2026-04-03T02:18:52.163288Z","steps":["trace[1741844559] 'agreement among raft nodes before linearized reading' (duration: 2.000732338s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:52.163347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:50.162456Z","time spent":"2.000884202s","remote":"127.0.0.1:58468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/03 02:18:52 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-03T02:18:52.303688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.137418ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-04-03T02:18:52.303945Z","caller":"traceutil/trace.go:171","msg":"trace[1386471364] transaction","detail":"{read_only:false; number_of_response:0; response_revision:281; }","duration":"2.945834342s","start":"2026-04-03T02:18:49.358078Z","end":"2026-04-03T02:18:52.303912Z","steps":["trace[1386471364] 'process raft request' (duration: 2.94572837s)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:52.303971Z","caller":"traceutil/trace.go:171","msg":"trace[574624919] transaction","detail":"{read_only:false; number_of_response:0; response_revision:281; }","duration":"2.945523884s","start":"2026-04-03T02:18:49.358426Z","end":"2026-04-03T02:18:52.30395Z","steps":["trace[574624919] 'process raft request' (duration: 2.945409681s)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:52.304028Z","caller":"traceutil/trace.go:171","msg":"trace[1638008383] transaction","detail":"{read_only:false; number_of_response:0; response_revision:281; }","duration":"2.945445563s","start":"2026-04-03T02:18:49.358557Z","end":"2026-04-03T02:18:52.304003Z","steps":["trace[1638008383] 'process raft request' (duration: 2.945294979s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:52.304108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:49.358071Z","time spent":"2.945955005s","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:18:52.30411Z","caller":"traceutil/trace.go:171","msg":"trace[2002333786] transaction","detail":"{read_only:false; number_of_response:0; response_revision:281; }","duration":"2.946254583s","start":"2026-04-03T02:18:49.357842Z","end":"2026-04-03T02:18:52.304096Z","steps":["trace[2002333786] 'process raft request' (duration: 2.208594042s)","trace[2002333786] 'compare' (duration: 737.081336ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:18:52.304116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:49.358405Z","time spent":"2.945622267s","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:18:52.304234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:49.357826Z","time spent":"2.946332425s","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:18:52.304159Z","caller":"traceutil/trace.go:171","msg":"trace[300072116] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"1.058859353s","start":"2026-04-03T02:18:51.245252Z","end":"2026-04-03T02:18:52.304111Z","steps":["trace[300072116] 'process raft request' (duration: 1.058814892s)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:52.304263Z","caller":"traceutil/trace.go:171","msg":"trace[2032161229] linearizableReadLoop","detail":"{readStateIndex:296; appliedIndex:291; }","duration":"1.066640041s","start":"2026-04-03T02:18:51.237607Z","end":"2026-04-03T02:18:52.304247Z","steps":["trace[2032161229] 'read index received' (duration: 328.937879ms)","trace[2032161229] 'applied index is now lower than readState.Index' (duration: 737.700142ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:18:52.304164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:49.358546Z","time spent":"2.945552465s","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:18:52.304381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:51.245243Z","time spent":"1.059079819s","remote":"127.0.0.1:58936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2651,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:18:52.304422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.142201355s","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-04-03T02:18:52.304466Z","caller":"traceutil/trace.go:171","msg":"trace[368955337] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:284; }","duration":"2.142285087s","start":"2026-04-03T02:18:50.162167Z","end":"2026-04-03T02:18:52.304452Z","steps":["trace[368955337] 'agreement among raft nodes before linearized reading' (duration: 2.142186984s)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:52.304043Z","caller":"traceutil/trace.go:171","msg":"trace[451134249] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"2.141345564s","start":"2026-04-03T02:18:50.162674Z","end":"2026-04-03T02:18:52.30402Z","steps":["trace[451134249] 'process raft request' (duration: 2.14119551s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:52.30453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.277832158s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T02:18:52.304534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:50.162146Z","time spent":"2.142363099s","remote":"127.0.0.1:58718","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-04-03T02:18:52.304541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.484262822s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:18:52.304582Z","caller":"traceutil/trace.go:171","msg":"trace[578785966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:284; }","duration":"3.484335463s","start":"2026-04-03T02:18:48.820234Z","end":"2026-04-03T02:18:52.304569Z","steps":["trace[578785966] 'agreement among raft nodes before linearized reading' (duration: 3.484258271s)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:52.304568Z","caller":"traceutil/trace.go:171","msg":"trace[1916899887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:284; }","duration":"1.277940641s","start":"2026-04-03T02:18:51.026616Z","end":"2026-04-03T02:18:52.304557Z","steps":["trace[1916899887] 'agreement among raft nodes before linearized reading' (duration: 1.277848348s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:52.304633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:48.820222Z","time spent":"3.484399734s","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-03T02:18:52.304647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:51.026566Z","time spent":"1.278071654s","remote":"127.0.0.1:58484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-03T02:18:52.30447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.948179332s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5892"} {"level":"info","ts":"2026-04-03T02:18:52.30475Z","caller":"traceutil/trace.go:171","msg":"trace[290812697] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:284; }","duration":"2.94848352s","start":"2026-04-03T02:18:49.356255Z","end":"2026-04-03T02:18:52.304738Z","steps":["trace[290812697] 'agreement among raft nodes before linearized reading' (duration: 2.948172612s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:52.304797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:49.356233Z","time spent":"2.948552601s","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5915,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-04-03T02:18:52.304819Z","caller":"traceutil/trace.go:171","msg":"trace[29877764] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"1.061048919s","start":"2026-04-03T02:18:51.243736Z","end":"2026-04-03T02:18:52.304785Z","steps":["trace[29877764] 'process raft request' (duration: 1.060256159s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:52.304896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:51.243716Z","time spent":"1.061144311s","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:18:52.304401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.494475471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:18:52.304978Z","caller":"traceutil/trace.go:171","msg":"trace[731971316] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:284; }","duration":"3.495060886s","start":"2026-04-03T02:18:48.809903Z","end":"2026-04-03T02:18:52.304964Z","steps":["trace[731971316] 'agreement among raft nodes before linearized reading' (duration: 3.494402699s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:52.305044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:48.809853Z","time spent":"3.495174468s","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-03T02:18:52.30496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:50.162663Z","time spent":"2.141890127s","remote":"127.0.0.1:58556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:18:53.460088Z","caller":"traceutil/trace.go:171","msg":"trace[414115746] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"144.094074ms","start":"2026-04-03T02:18:53.315974Z","end":"2026-04-03T02:18:53.460068Z","steps":["trace[414115746] 'process raft request' (duration: 142.994417ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:54.061676Z","caller":"traceutil/trace.go:171","msg":"trace[1077645135] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"425.667658ms","start":"2026-04-03T02:18:53.635967Z","end":"2026-04-03T02:18:54.061635Z","steps":["trace[1077645135] 'process raft request' (duration: 416.697589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:54.06183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:53.635939Z","time spent":"425.818772ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:18:54.531735Z","caller":"traceutil/trace.go:171","msg":"trace[1144330510] linearizableReadLoop","detail":"{readStateIndex:334; appliedIndex:333; }","duration":"200.069191ms","start":"2026-04-03T02:18:54.331637Z","end":"2026-04-03T02:18:54.531706Z","steps":["trace[1144330510] 'read index received' (duration: 199.792284ms)","trace[1144330510] 'applied index is now lower than readState.Index' (duration: 275.987µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:54.531905Z","caller":"traceutil/trace.go:171","msg":"trace[122421188] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"204.339739ms","start":"2026-04-03T02:18:54.327488Z","end":"2026-04-03T02:18:54.531828Z","steps":["trace[122421188] 'process raft request' (duration: 204.009391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:54.532002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.182328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-03T02:18:54.532132Z","caller":"traceutil/trace.go:171","msg":"trace[1823909625] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:320; }","duration":"197.347201ms","start":"2026-04-03T02:18:54.334769Z","end":"2026-04-03T02:18:54.532116Z","steps":["trace[1823909625] 'agreement among raft nodes before linearized reading' (duration: 197.166107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:54.532153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.421102ms","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-04-03T02:18:54.53229Z","caller":"traceutil/trace.go:171","msg":"trace[1791423058] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:320; }","duration":"182.555955ms","start":"2026-04-03T02:18:54.349688Z","end":"2026-04-03T02:18:54.532244Z","steps":["trace[1791423058] 'agreement among raft nodes before linearized reading' (duration: 182.294559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:54.531964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.309418ms","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-04-03T02:18:54.532476Z","caller":"traceutil/trace.go:171","msg":"trace[205358429] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:320; }","duration":"200.860221ms","start":"2026-04-03T02:18:54.331601Z","end":"2026-04-03T02:18:54.532461Z","steps":["trace[205358429] 'agreement among raft nodes before linearized reading' (duration: 200.287507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:54.532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.690067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-03T02:18:54.532585Z","caller":"traceutil/trace.go:171","msg":"trace[643285368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:320; }","duration":"179.317033ms","start":"2026-04-03T02:18:54.353249Z","end":"2026-04-03T02:18:54.532566Z","steps":["trace[643285368] 'agreement among raft nodes before linearized reading' (duration: 178.703277ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:54.711558Z","caller":"traceutil/trace.go:171","msg":"trace[1218619018] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"118.547456ms","start":"2026-04-03T02:18:54.592975Z","end":"2026-04-03T02:18:54.711522Z","steps":["trace[1218619018] 'process raft request' (duration: 37.283879ms)","trace[1218619018] 'compare' (duration: 81.104003ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:55.759546Z","caller":"traceutil/trace.go:171","msg":"trace[1285853131] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"272.759793ms","start":"2026-04-03T02:18:55.486758Z","end":"2026-04-03T02:18:55.759518Z","steps":["trace[1285853131] 'process raft request' (duration: 272.573508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:56.160559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.725899ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:18:56.160701Z","caller":"traceutil/trace.go:171","msg":"trace[1560574390] linearizableReadLoop","detail":"{readStateIndex:349; appliedIndex:348; }","duration":"133.437127ms","start":"2026-04-03T02:18:56.027242Z","end":"2026-04-03T02:18:56.160679Z","steps":["trace[1560574390] 'read index received' (duration: 40.991µs)","trace[1560574390] 'applied index is now lower than readState.Index' (duration: 133.394766ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:56.160746Z","caller":"traceutil/trace.go:171","msg":"trace[1197141024] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"224.881916ms","start":"2026-04-03T02:18:55.935823Z","end":"2026-04-03T02:18:56.160704Z","steps":["trace[1197141024] 'process raft request' (duration: 60.913641ms)","trace[1197141024] 'compare' (duration: 163.543704ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:18:56.160816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.57394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:18:56.160847Z","caller":"traceutil/trace.go:171","msg":"trace[1010332984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:335; }","duration":"133.653202ms","start":"2026-04-03T02:18:56.027183Z","end":"2026-04-03T02:18:56.160836Z","steps":["trace[1010332984] 'agreement among raft nodes before linearized reading' (duration: 133.55391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:56.361932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.650833ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:18:56.36207Z","caller":"traceutil/trace.go:171","msg":"trace[885606548] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"191.451165ms","start":"2026-04-03T02:18:56.170592Z","end":"2026-04-03T02:18:56.362043Z","steps":["trace[885606548] 'process raft request' (duration: 90.592267ms)","trace[885606548] 'compare' (duration: 100.481959ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:56.815937Z","caller":"traceutil/trace.go:171","msg":"trace[206251993] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:351; }","duration":"395.356008ms","start":"2026-04-03T02:18:56.420556Z","end":"2026-04-03T02:18:56.815912Z","steps":["trace[206251993] 'read index received' (duration: 395.060111ms)","trace[206251993] 'applied index is now lower than readState.Index' (duration: 294.737µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:56.816003Z","caller":"traceutil/trace.go:171","msg":"trace[1117389219] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"397.559364ms","start":"2026-04-03T02:18:56.418401Z","end":"2026-04-03T02:18:56.815961Z","steps":["trace[1117389219] 'process raft request' (duration: 397.333809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:56.816308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:56.418343Z","time spent":"397.80738ms","remote":"127.0.0.1:58512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:18:56.816368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.366433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:18:56.816421Z","caller":"traceutil/trace.go:171","msg":"trace[651098404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:337; }","duration":"279.551687ms","start":"2026-04-03T02:18:56.536855Z","end":"2026-04-03T02:18:56.816406Z","steps":["trace[651098404] 'agreement among raft nodes before linearized reading' (duration: 279.212749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:56.816382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.787188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-03T02:18:56.816495Z","caller":"traceutil/trace.go:171","msg":"trace[315114425] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:337; }","duration":"395.931822ms","start":"2026-04-03T02:18:56.420537Z","end":"2026-04-03T02:18:56.816469Z","steps":["trace[315114425] 'agreement among raft nodes before linearized reading' (duration: 395.501741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:56.816562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:56.420487Z","time spent":"396.065016ms","remote":"127.0.0.1:58580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-03T02:18:56.816466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.814263ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:18:56.81669Z","caller":"traceutil/trace.go:171","msg":"trace[1831417068] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:337; }","duration":"223.06442ms","start":"2026-04-03T02:18:56.593581Z","end":"2026-04-03T02:18:56.816646Z","steps":["trace[1831417068] 'agreement among raft nodes before linearized reading' (duration: 222.519766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:56.816638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.216574ms","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-04-03T02:18:56.816688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.456055ms","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-04-03T02:18:56.816715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.500252ms","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-04-03T02:18:56.816761Z","caller":"traceutil/trace.go:171","msg":"trace[1890044770] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:337; }","duration":"222.554898ms","start":"2026-04-03T02:18:56.594191Z","end":"2026-04-03T02:18:56.816746Z","steps":["trace[1890044770] 'agreement among raft nodes before linearized reading' (duration: 222.421575ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:56.816761Z","caller":"traceutil/trace.go:171","msg":"trace[725805154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:337; }","duration":"223.41512ms","start":"2026-04-03T02:18:56.593321Z","end":"2026-04-03T02:18:56.816737Z","steps":["trace[725805154] 'agreement among raft nodes before linearized reading' (duration: 223.07739ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:56.816796Z","caller":"traceutil/trace.go:171","msg":"trace[1784736505] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:337; }","duration":"223.627895ms","start":"2026-04-03T02:18:56.593151Z","end":"2026-04-03T02:18:56.816779Z","steps":["trace[1784736505] 'agreement among raft nodes before linearized reading' (duration: 223.376428ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:56.940723Z","caller":"traceutil/trace.go:171","msg":"trace[284624482] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"118.504107ms","start":"2026-04-03T02:18:56.822195Z","end":"2026-04-03T02:18:56.940699Z","steps":["trace[284624482] 'process raft request' (duration: 118.412505ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:56.940729Z","caller":"traceutil/trace.go:171","msg":"trace[349691977] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"119.094573ms","start":"2026-04-03T02:18:56.821597Z","end":"2026-04-03T02:18:56.940692Z","steps":["trace[349691977] 'process raft request' (duration: 110.974836ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:56.940928Z","caller":"traceutil/trace.go:171","msg":"trace[1703276807] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"118.632012ms","start":"2026-04-03T02:18:56.822134Z","end":"2026-04-03T02:18:56.940766Z","steps":["trace[1703276807] 'process raft request' (duration: 118.422707ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:56.941002Z","caller":"traceutil/trace.go:171","msg":"trace[342640322] linearizableReadLoop","detail":"{readStateIndex:354; appliedIndex:353; }","duration":"119.111524ms","start":"2026-04-03T02:18:56.821873Z","end":"2026-04-03T02:18:56.940985Z","steps":["trace[342640322] 'read index received' (duration: 13.007151ms)","trace[342640322] 'applied index is now lower than readState.Index' (duration: 106.102793ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:18:56.94121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.314099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"warn","ts":"2026-04-03T02:18:56.941352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.714402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-04-03T02:18:56.941402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.294328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-03T02:18:56.941399Z","caller":"traceutil/trace.go:171","msg":"trace[602878204] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:342; }","duration":"103.781223ms","start":"2026-04-03T02:18:56.837605Z","end":"2026-04-03T02:18:56.941386Z","steps":["trace[602878204] 'agreement among raft nodes before linearized reading' (duration: 103.710371ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:56.941457Z","caller":"traceutil/trace.go:171","msg":"trace[107064214] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:342; }","duration":"119.384071ms","start":"2026-04-03T02:18:56.822058Z","end":"2026-04-03T02:18:56.941442Z","steps":["trace[107064214] 'agreement among raft nodes before linearized reading' (duration: 119.254458ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:56.941428Z","caller":"traceutil/trace.go:171","msg":"trace[314269458] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:342; }","duration":"119.455573ms","start":"2026-04-03T02:18:56.82185Z","end":"2026-04-03T02:18:56.941305Z","steps":["trace[314269458] 'agreement among raft nodes before linearized reading' (duration: 119.175556ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:56.941253Z","caller":"traceutil/trace.go:171","msg":"trace[2112857053] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"118.344094ms","start":"2026-04-03T02:18:56.822898Z","end":"2026-04-03T02:18:56.941242Z","steps":["trace[2112857053] 'process raft request' (duration: 117.750069ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:57.729138Z","caller":"traceutil/trace.go:171","msg":"trace[217505663] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"343.435748ms","start":"2026-04-03T02:18:57.385674Z","end":"2026-04-03T02:18:57.72911Z","steps":["trace[217505663] 'process raft request' (duration: 343.238793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:57.729331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.385655Z","time spent":"343.576012ms","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5139,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:18:58.386763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.307418ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:18:58.38691Z","caller":"traceutil/trace.go:171","msg":"trace[1998919777] linearizableReadLoop","detail":"{readStateIndex:364; appliedIndex:362; }","duration":"952.609661ms","start":"2026-04-03T02:18:57.434276Z","end":"2026-04-03T02:18:58.386886Z","steps":["trace[1998919777] 'read index received' (duration: 294.597345ms)","trace[1998919777] 'applied index is now lower than readState.Index' (duration: 658.010776ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:58.387013Z","caller":"traceutil/trace.go:171","msg":"trace[1647508540] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"996.93104ms","start":"2026-04-03T02:18:57.389996Z","end":"2026-04-03T02:18:58.386927Z","steps":["trace[1647508540] 'process raft request' (duration: 686.350845ms)","trace[1647508540] 'compare' (duration: 310.094263ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:18:58.387148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.868477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-04-03T02:18:58.387187Z","caller":"traceutil/trace.go:171","msg":"trace[2139795161] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:349; }","duration":"952.94955ms","start":"2026-04-03T02:18:57.434225Z","end":"2026-04-03T02:18:58.387175Z","steps":["trace[2139795161] 'agreement among raft nodes before linearized reading' (duration: 952.794806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:58.387241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.434212Z","time spent":"953.018381ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-04-03T02:18:58.387297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.389976Z","time spent":"997.211687ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:18:58.387679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.03664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-04-03T02:18:58.387872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.613487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-03T02:18:58.38792Z","caller":"traceutil/trace.go:171","msg":"trace[2067663783] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:349; }","duration":"502.666408ms","start":"2026-04-03T02:18:57.885243Z","end":"2026-04-03T02:18:58.387909Z","steps":["trace[2067663783] 'agreement among raft nodes before linearized reading' (duration: 502.540645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:58.387926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.200495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-04-03T02:18:58.387956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.885195Z","time spent":"502.75437ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-04-03T02:18:58.388001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.423119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-04-03T02:18:58.387954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.601918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-04-03T02:18:58.388026Z","caller":"traceutil/trace.go:171","msg":"trace[79081455] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:349; }","duration":"553.335739ms","start":"2026-04-03T02:18:57.834668Z","end":"2026-04-03T02:18:58.388004Z","steps":["trace[79081455] 'agreement among raft nodes before linearized reading' (duration: 553.157285ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:58.388055Z","caller":"traceutil/trace.go:171","msg":"trace[523542362] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:349; }","duration":"653.47893ms","start":"2026-04-03T02:18:57.734561Z","end":"2026-04-03T02:18:58.388039Z","steps":["trace[523542362] 'agreement among raft nodes before linearized reading' (duration: 653.415229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:58.388081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.834646Z","time spent":"553.427161ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-04-03T02:18:58.388097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.734555Z","time spent":"653.534452ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"info","ts":"2026-04-03T02:18:58.388094Z","caller":"traceutil/trace.go:171","msg":"trace[2145328265] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:349; }","duration":"442.813914ms","start":"2026-04-03T02:18:57.945242Z","end":"2026-04-03T02:18:58.388056Z","steps":["trace[2145328265] 'agreement among raft nodes before linearized reading' (duration: 442.469655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:58.388161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.94523Z","time spent":"442.918698ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-04-03T02:18:58.387927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.29585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-04-03T02:18:58.388164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.0117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4321"} {"level":"info","ts":"2026-04-03T02:18:58.388214Z","caller":"traceutil/trace.go:171","msg":"trace[2052225544] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:349; }","duration":"703.632329ms","start":"2026-04-03T02:18:57.68457Z","end":"2026-04-03T02:18:58.388202Z","steps":["trace[2052225544] 'agreement among raft nodes before linearized reading' (duration: 703.266469ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:58.388233Z","caller":"traceutil/trace.go:171","msg":"trace[1241646217] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:349; }","duration":"655.147634ms","start":"2026-04-03T02:18:57.733065Z","end":"2026-04-03T02:18:58.388213Z","steps":["trace[1241646217] 'agreement among raft nodes before linearized reading' (duration: 654.972178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:58.388243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.134658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:18:58.388297Z","caller":"traceutil/trace.go:171","msg":"trace[1587703227] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:349; }","duration":"360.21964ms","start":"2026-04-03T02:18:58.028062Z","end":"2026-04-03T02:18:58.388281Z","steps":["trace[1587703227] 'agreement among raft nodes before linearized reading' (duration: 360.152989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:58.38831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.730062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"warn","ts":"2026-04-03T02:18:58.388296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.733045Z","time spent":"655.237615ms","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4344,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-04-03T02:18:58.388347Z","caller":"traceutil/trace.go:171","msg":"trace[1593458729] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:349; }","duration":"442.802744ms","start":"2026-04-03T02:18:57.945536Z","end":"2026-04-03T02:18:58.388339Z","steps":["trace[1593458729] 'agreement among raft nodes before linearized reading' (duration: 442.739672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:58.388355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.028043Z","time spent":"360.297422ms","remote":"127.0.0.1:58468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-03T02:18:58.38838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.945527Z","time spent":"442.846765ms","remote":"127.0.0.1:58844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-04-03T02:18:58.388244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.684543Z","time spent":"703.693781ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-04-03T02:18:58.388539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.815821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-03T02:18:58.388576Z","caller":"traceutil/trace.go:171","msg":"trace[377709529] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:349; }","duration":"803.891833ms","start":"2026-04-03T02:18:57.584674Z","end":"2026-04-03T02:18:58.388566Z","steps":["trace[377709529] 'agreement among raft nodes before linearized reading' (duration: 803.829911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:58.388618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.584641Z","time spent":"803.970305ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-04-03T02:18:58.388667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.205129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-03T02:18:58.388726Z","caller":"traceutil/trace.go:171","msg":"trace[1338294274] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:349; }","duration":"853.316472ms","start":"2026-04-03T02:18:57.535393Z","end":"2026-04-03T02:18:58.38871Z","steps":["trace[1338294274] 'agreement among raft nodes before linearized reading' (duration: 853.24121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:58.388744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.94908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-03T02:18:58.388763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.535363Z","time spent":"853.392454ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"info","ts":"2026-04-03T02:18:58.38881Z","caller":"traceutil/trace.go:171","msg":"trace[268814561] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:349; }","duration":"754.082733ms","start":"2026-04-03T02:18:57.634712Z","end":"2026-04-03T02:18:58.388794Z","steps":["trace[268814561] 'agreement among raft nodes before linearized reading' (duration: 753.9712ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:58.387735Z","caller":"traceutil/trace.go:171","msg":"trace[1890753150] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:349; }","duration":"602.147213ms","start":"2026-04-03T02:18:57.785575Z","end":"2026-04-03T02:18:58.387722Z","steps":["trace[1890753150] 'agreement among raft nodes before linearized reading' (duration: 602.02779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:58.388888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.634677Z","time spent":"754.173796ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-04-03T02:18:58.388929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.785563Z","time spent":"603.297283ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-04-03T02:18:58.388922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.828677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-03T02:18:58.388983Z","caller":"traceutil/trace.go:171","msg":"trace[1360342556] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:349; }","duration":"903.120191ms","start":"2026-04-03T02:18:57.485847Z","end":"2026-04-03T02:18:58.388967Z","steps":["trace[1360342556] 'agreement among raft nodes before linearized reading' (duration: 901.758155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:58.389024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:57.485821Z","time spent":"903.192943ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-04-03T02:18:59.203006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.938381ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:18:59.203107Z","caller":"traceutil/trace.go:171","msg":"trace[1838857453] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:364; }","duration":"806.802943ms","start":"2026-04-03T02:18:58.396286Z","end":"2026-04-03T02:18:59.203089Z","steps":["trace[1838857453] 'read index received' (duration: 359.717978ms)","trace[1838857453] 'applied index is now lower than readState.Index' (duration: 447.081675ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:59.203252Z","caller":"traceutil/trace.go:171","msg":"trace[175739976] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"807.259084ms","start":"2026-04-03T02:18:58.395967Z","end":"2026-04-03T02:18:59.203226Z","steps":["trace[175739976] 'process raft request' (duration: 360.023816ms)","trace[175739976] 'compare' (duration: 446.831898ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:18:59.203308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.395957Z","time spent":"807.322596ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:18:59.203499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.564123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-03T02:18:59.203528Z","caller":"traceutil/trace.go:171","msg":"trace[710983315] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:350; }","duration":"807.602604ms","start":"2026-04-03T02:18:58.395915Z","end":"2026-04-03T02:18:59.203518Z","steps":["trace[710983315] 'agreement among raft nodes before linearized reading' (duration: 807.512241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.203556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.395911Z","time spent":"807.639184ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-04-03T02:18:59.203715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.382138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-04-03T02:18:59.203957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.657055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-03T02:18:59.203946Z","caller":"traceutil/trace.go:171","msg":"trace[1902268479] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:350; }","duration":"807.650145ms","start":"2026-04-03T02:18:58.396229Z","end":"2026-04-03T02:18:59.203879Z","steps":["trace[1902268479] 'agreement among raft nodes before linearized reading' (duration: 807.182073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.204105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.396221Z","time spent":"807.8549ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"info","ts":"2026-04-03T02:18:59.204158Z","caller":"traceutil/trace.go:171","msg":"trace[1773829119] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:350; }","duration":"807.802988ms","start":"2026-04-03T02:18:58.396258Z","end":"2026-04-03T02:18:59.204061Z","steps":["trace[1773829119] 'agreement among raft nodes before linearized reading' (duration: 807.45877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.204377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.396253Z","time spent":"808.104207ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-04-03T02:18:59.802127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.703213ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:18:59.802501Z","caller":"traceutil/trace.go:171","msg":"trace[699153715] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:365; }","duration":"599.350089ms","start":"2026-04-03T02:18:59.203132Z","end":"2026-04-03T02:18:59.802482Z","steps":["trace[699153715] 'read index received' (duration: 313.0413ms)","trace[699153715] 'applied index is now lower than readState.Index' (duration: 286.305569ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:18:59.802642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405955276s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-03T02:18:59.80271Z","caller":"traceutil/trace.go:171","msg":"trace[827432968] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:354; }","duration":"1.406110509s","start":"2026-04-03T02:18:58.396584Z","end":"2026-04-03T02:18:59.802695Z","steps":["trace[827432968] 'agreement among raft nodes before linearized reading' (duration: 1.405997127s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.802787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.396564Z","time spent":"1.406209122s","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"info","ts":"2026-04-03T02:18:59.802813Z","caller":"traceutil/trace.go:171","msg":"trace[1332699921] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"1.400886817s","start":"2026-04-03T02:18:58.401884Z","end":"2026-04-03T02:18:59.802771Z","steps":["trace[1332699921] 'process raft request' (duration: 1.400425666s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.802986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.401863Z","time spent":"1.401018921s","remote":"127.0.0.1:58646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4354,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:18:59.803063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.406223343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-03T02:18:59.803106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.404678334s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-03T02:18:59.803134Z","caller":"traceutil/trace.go:171","msg":"trace[994143346] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:354; }","duration":"1.406298345s","start":"2026-04-03T02:18:58.39682Z","end":"2026-04-03T02:18:59.803118Z","steps":["trace[994143346] 'agreement among raft nodes before linearized reading' (duration: 1.406195792s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.803127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.406282605s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-03T02:18:59.803208Z","caller":"traceutil/trace.go:171","msg":"trace[420138244] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"1.400306003s","start":"2026-04-03T02:18:58.402887Z","end":"2026-04-03T02:18:59.803193Z","steps":["trace[420138244] 'process raft request' (duration: 1.399498262s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.803232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.396812Z","time spent":"1.406404369s","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"info","ts":"2026-04-03T02:18:59.803251Z","caller":"traceutil/trace.go:171","msg":"trace[1552889753] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:354; }","duration":"1.406430429s","start":"2026-04-03T02:18:58.396794Z","end":"2026-04-03T02:18:59.803225Z","steps":["trace[1552889753] 'agreement among raft nodes before linearized reading' (duration: 1.406197723s)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.803247Z","caller":"traceutil/trace.go:171","msg":"trace[616436082] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:354; }","duration":"1.4048723s","start":"2026-04-03T02:18:58.398322Z","end":"2026-04-03T02:18:59.803195Z","steps":["trace[616436082] 'agreement among raft nodes before linearized reading' (duration: 1.404648324s)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.803266Z","caller":"traceutil/trace.go:171","msg":"trace[2068251799] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"1.188729071s","start":"2026-04-03T02:18:58.614522Z","end":"2026-04-03T02:18:59.803251Z","steps":["trace[2068251799] 'process raft request' (duration: 1.18790775s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.803339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.250582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-03T02:18:59.802815Z","caller":"traceutil/trace.go:171","msg":"trace[528219877] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"1.406205852s","start":"2026-04-03T02:18:58.396583Z","end":"2026-04-03T02:18:59.802789Z","steps":["trace[528219877] 'process raft request' (duration: 1.119732569s)","trace[528219877] 'compare' (duration: 285.56849ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:18:59.803449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.398314Z","time spent":"1.405096905s","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-04-03T02:18:59.80348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.396569Z","time spent":"1.40686464s","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:18:59.8034Z","caller":"traceutil/trace.go:171","msg":"trace[81561254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:354; }","duration":"855.331615ms","start":"2026-04-03T02:18:58.948056Z","end":"2026-04-03T02:18:59.803388Z","steps":["trace[81561254] 'agreement among raft nodes before linearized reading' (duration: 855.236092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.803322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.40288Z","time spent":"1.400389955s","remote":"127.0.0.1:58578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2162,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:18:59.80359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.948045Z","time spent":"855.53462ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-03T02:18:59.802981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.40610746s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-03T02:18:59.80376Z","caller":"traceutil/trace.go:171","msg":"trace[1738084068] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:354; }","duration":"1.406896291s","start":"2026-04-03T02:18:58.396845Z","end":"2026-04-03T02:18:59.803741Z","steps":["trace[1738084068] 'agreement among raft nodes before linearized reading' (duration: 1.406051299s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.803461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.614502Z","time spent":"1.188880065s","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:18:59.802667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.18631ms","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-04-03T02:18:59.804702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.586652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:18:59.804734Z","caller":"traceutil/trace.go:171","msg":"trace[1604294687] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:354; }","duration":"857.295694ms","start":"2026-04-03T02:18:58.947425Z","end":"2026-04-03T02:18:59.804721Z","steps":["trace[1604294687] 'agreement among raft nodes before linearized reading' (duration: 855.086358ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.804743Z","caller":"traceutil/trace.go:171","msg":"trace[818047846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:354; }","duration":"857.662984ms","start":"2026-04-03T02:18:58.947068Z","end":"2026-04-03T02:18:59.804731Z","steps":["trace[818047846] 'agreement among raft nodes before linearized reading' (duration: 857.581292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.804783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.947397Z","time spent":"857.374797ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-03T02:18:59.804782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.947046Z","time spent":"857.729095ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-03T02:18:59.803872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.396841Z","time spent":"1.407011154s","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-04-03T02:18:59.803316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.396788Z","time spent":"1.406518441s","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-04-03T02:18:59.805243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.321075ms","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-04-03T02:18:59.805293Z","caller":"traceutil/trace.go:171","msg":"trace[801468284] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:354; }","duration":"859.504579ms","start":"2026-04-03T02:18:58.945777Z","end":"2026-04-03T02:18:59.805281Z","steps":["trace[801468284] 'agreement among raft nodes before linearized reading' (duration: 857.165731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.805343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:58.945756Z","time spent":"859.569112ms","remote":"127.0.0.1:58718","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":"info","ts":"2026-04-03T02:18:59.808186Z","caller":"traceutil/trace.go:171","msg":"trace[1515313026] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"596.857096ms","start":"2026-04-03T02:18:59.211257Z","end":"2026-04-03T02:18:59.808114Z","steps":["trace[1515313026] 'process raft request' (duration: 596.63469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.80844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:59.211237Z","time spent":"597.081311ms","remote":"127.0.0.1:58556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:18:59.808468Z","caller":"traceutil/trace.go:171","msg":"trace[2051303307] transaction","detail":"{read_only:false; number_of_response:1; response_revision:360; }","duration":"591.346986ms","start":"2026-04-03T02:18:59.217102Z","end":"2026-04-03T02:18:59.808449Z","steps":["trace[2051303307] 'process raft request' (duration: 591.109429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.80892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:59.217094Z","time spent":"591.700105ms","remote":"127.0.0.1:58646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30,"response count":0,"response size":4402,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:18:59.809177Z","caller":"traceutil/trace.go:171","msg":"trace[1757102788] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"601.822732ms","start":"2026-04-03T02:18:59.207331Z","end":"2026-04-03T02:18:59.809154Z","steps":["trace[1757102788] 'process raft request' (duration: 600.451356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.809411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:59.207294Z","time spent":"602.030347ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:18:59.810928Z","caller":"traceutil/trace.go:171","msg":"trace[1828478250] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"596.754043ms","start":"2026-04-03T02:18:59.214136Z","end":"2026-04-03T02:18:59.81089Z","steps":["trace[1828478250] 'process raft request' (duration: 593.824858ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.811046Z","caller":"traceutil/trace.go:171","msg":"trace[1630251351] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"594.470445ms","start":"2026-04-03T02:18:59.216508Z","end":"2026-04-03T02:18:59.810979Z","steps":["trace[1630251351] 'process raft request' (duration: 591.558621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.811255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:59.216496Z","time spent":"594.645979ms","remote":"127.0.0.1:58788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:18:59.811599Z","caller":"traceutil/trace.go:171","msg":"trace[1456193601] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"595.143262ms","start":"2026-04-03T02:18:59.216438Z","end":"2026-04-03T02:18:59.811581Z","steps":["trace[1456193601] 'process raft request' (duration: 591.57036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.81227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:59.216419Z","time spent":"595.803109ms","remote":"127.0.0.1:58788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:18:59.811735Z","caller":"traceutil/trace.go:171","msg":"trace[948372279] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"595.116252ms","start":"2026-04-03T02:18:59.216593Z","end":"2026-04-03T02:18:59.811709Z","steps":["trace[948372279] 'process raft request' (duration: 591.559681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.81289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:59.216583Z","time spent":"596.180839ms","remote":"127.0.0.1:58788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:18:59.815005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:18:59.214126Z","time spent":"596.867485ms","remote":"127.0.0.1:58942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:18:59.963522Z","caller":"traceutil/trace.go:171","msg":"trace[359353725] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"149.09572ms","start":"2026-04-03T02:18:59.814394Z","end":"2026-04-03T02:18:59.96349Z","steps":["trace[359353725] 'process raft request' (duration: 123.323593ms)","trace[359353725] 'compare' (duration: 25.171502ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:59.963512Z","caller":"traceutil/trace.go:171","msg":"trace[548374726] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"148.746022ms","start":"2026-04-03T02:18:59.814727Z","end":"2026-04-03T02:18:59.963473Z","steps":["trace[548374726] 'process raft request' (duration: 148.536297ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.963913Z","caller":"traceutil/trace.go:171","msg":"trace[1608781145] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"148.092305ms","start":"2026-04-03T02:18:59.815793Z","end":"2026-04-03T02:18:59.963886Z","steps":["trace[1608781145] 'process raft request' (duration: 147.605603ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.963949Z","caller":"traceutil/trace.go:171","msg":"trace[1896721345] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"149.06681ms","start":"2026-04-03T02:18:59.814862Z","end":"2026-04-03T02:18:59.963928Z","steps":["trace[1896721345] 'process raft request' (duration: 148.504736ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.964685Z","caller":"traceutil/trace.go:171","msg":"trace[1307375470] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"148.357592ms","start":"2026-04-03T02:18:59.81631Z","end":"2026-04-03T02:18:59.964667Z","steps":["trace[1307375470] 'process raft request' (duration: 147.308236ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.964925Z","caller":"traceutil/trace.go:171","msg":"trace[788513839] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"146.73188ms","start":"2026-04-03T02:18:59.818177Z","end":"2026-04-03T02:18:59.964909Z","steps":["trace[788513839] 'process raft request' (duration: 146.424372ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.964973Z","caller":"traceutil/trace.go:171","msg":"trace[211010381] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"145.253722ms","start":"2026-04-03T02:18:59.81971Z","end":"2026-04-03T02:18:59.964963Z","steps":["trace[211010381] 'process raft request' (duration: 144.977855ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.96505Z","caller":"traceutil/trace.go:171","msg":"trace[386520021] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"145.360265ms","start":"2026-04-03T02:18:59.819675Z","end":"2026-04-03T02:18:59.965035Z","steps":["trace[386520021] 'process raft request' (duration: 144.965485ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.965166Z","caller":"traceutil/trace.go:171","msg":"trace[1741445716] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"144.575695ms","start":"2026-04-03T02:18:59.820575Z","end":"2026-04-03T02:18:59.965151Z","steps":["trace[1741445716] 'process raft request' (duration: 144.190565ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.964936Z","caller":"traceutil/trace.go:171","msg":"trace[526115345] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"145.132979ms","start":"2026-04-03T02:18:59.819792Z","end":"2026-04-03T02:18:59.964925Z","steps":["trace[526115345] 'process raft request' (duration: 144.933144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.965776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.181884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4321"} {"level":"info","ts":"2026-04-03T02:18:59.965817Z","caller":"traceutil/trace.go:171","msg":"trace[1188510116] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:375; }","duration":"151.257935ms","start":"2026-04-03T02:18:59.81455Z","end":"2026-04-03T02:18:59.965808Z","steps":["trace[1188510116] 'agreement among raft nodes before linearized reading' (duration: 151.153873ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.965071Z","caller":"traceutil/trace.go:171","msg":"trace[454773909] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"105.51308ms","start":"2026-04-03T02:18:59.859502Z","end":"2026-04-03T02:18:59.965015Z","steps":["trace[454773909] 'process raft request' (duration: 105.458848ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.965462Z","caller":"traceutil/trace.go:171","msg":"trace[1467511475] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"110.228021ms","start":"2026-04-03T02:18:59.855222Z","end":"2026-04-03T02:18:59.96545Z","steps":["trace[1467511475] 'process raft request' (duration: 109.668686ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.966243Z","caller":"traceutil/trace.go:171","msg":"trace[1688442379] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"147.52149ms","start":"2026-04-03T02:18:59.817237Z","end":"2026-04-03T02:18:59.964759Z","steps":["trace[1688442379] 'process raft request' (duration: 147.307095ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:18:59.965681Z","caller":"traceutil/trace.go:171","msg":"trace[1535419750] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:376; }","duration":"151.093322ms","start":"2026-04-03T02:18:59.814575Z","end":"2026-04-03T02:18:59.965669Z","steps":["trace[1535419750] 'read index received' (duration: 36.211403ms)","trace[1535419750] 'applied index is now lower than readState.Index' (duration: 114.880309ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:18:59.965668Z","caller":"traceutil/trace.go:171","msg":"trace[1031407545] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"145.069808ms","start":"2026-04-03T02:18:59.820579Z","end":"2026-04-03T02:18:59.965648Z","steps":["trace[1031407545] 'process raft request' (duration: 144.224086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.966871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.331027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:1 size:2108"} {"level":"info","ts":"2026-04-03T02:18:59.966922Z","caller":"traceutil/trace.go:171","msg":"trace[1495083768] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:1; response_revision:375; }","duration":"149.392828ms","start":"2026-04-03T02:18:59.817517Z","end":"2026-04-03T02:18:59.966909Z","steps":["trace[1495083768] 'agreement among raft nodes before linearized reading' (duration: 149.288795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:18:59.966934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.318288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-03T02:18:59.967321Z","caller":"traceutil/trace.go:171","msg":"trace[1996926046] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:375; }","duration":"111.597255ms","start":"2026-04-03T02:18:59.855569Z","end":"2026-04-03T02:18:59.967166Z","steps":["trace[1996926046] 'agreement among raft nodes before linearized reading' (duration: 111.324269ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:01.596569Z","caller":"traceutil/trace.go:171","msg":"trace[216613565] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"196.940324ms","start":"2026-04-03T02:19:01.399608Z","end":"2026-04-03T02:19:01.596548Z","steps":["trace[216613565] 'process raft request' (duration: 196.78484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:01.990298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.780834ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-03T02:19:07.888265Z","caller":"traceutil/trace.go:171","msg":"trace[875468660] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"170.388885ms","start":"2026-04-03T02:19:07.717851Z","end":"2026-04-03T02:19:07.88824Z","steps":["trace[875468660] 'process raft request' (duration: 170.213001ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:08.182441Z","caller":"traceutil/trace.go:171","msg":"trace[2017519052] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"110.33363ms","start":"2026-04-03T02:19:08.072081Z","end":"2026-04-03T02:19:08.182415Z","steps":["trace[2017519052] 'process raft request' (duration: 63.417851ms)","trace[2017519052] 'compare' (duration: 46.729675ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:19:08.183136Z","caller":"traceutil/trace.go:171","msg":"trace[2125612909] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"109.915729ms","start":"2026-04-03T02:19:08.073192Z","end":"2026-04-03T02:19:08.183108Z","steps":["trace[2125612909] 'process raft request' (duration: 109.1805ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:22.387022Z","caller":"traceutil/trace.go:171","msg":"trace[1006036330] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"436.596561ms","start":"2026-04-03T02:19:21.950403Z","end":"2026-04-03T02:19:22.386999Z","steps":["trace[1006036330] 'process raft request' (duration: 436.405057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:22.387164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:21.950387Z","time spent":"436.718594ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:19:22.395491Z","caller":"traceutil/trace.go:171","msg":"trace[1270026106] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"444.491796ms","start":"2026-04-03T02:19:21.950982Z","end":"2026-04-03T02:19:22.395474Z","steps":["trace[1270026106] 'process raft request' (duration: 444.350603ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:22.395614Z","caller":"traceutil/trace.go:171","msg":"trace[195717869] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"444.493666ms","start":"2026-04-03T02:19:21.951077Z","end":"2026-04-03T02:19:22.39557Z","steps":["trace[195717869] 'process raft request' (duration: 444.348473ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:22.395699Z","caller":"traceutil/trace.go:171","msg":"trace[1947849218] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"435.454106ms","start":"2026-04-03T02:19:21.960224Z","end":"2026-04-03T02:19:22.395678Z","steps":["trace[1947849218] 'process raft request' (duration: 435.236891ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:22.395686Z","caller":"traceutil/trace.go:171","msg":"trace[255885401] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"435.319623ms","start":"2026-04-03T02:19:21.960299Z","end":"2026-04-03T02:19:22.395619Z","steps":["trace[255885401] 'process raft request' (duration: 435.21434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:22.395756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:21.960203Z","time spent":"435.529197ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:19:22.395876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:21.960293Z","time spent":"435.488496ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:19:22.395904Z","caller":"traceutil/trace.go:171","msg":"trace[1396679287] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"429.044903ms","start":"2026-04-03T02:19:21.966844Z","end":"2026-04-03T02:19:22.395889Z","steps":["trace[1396679287] 'process raft request' (duration: 428.782448ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:22.395945Z","caller":"traceutil/trace.go:171","msg":"trace[697351569] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"423.633445ms","start":"2026-04-03T02:19:21.972304Z","end":"2026-04-03T02:19:22.395938Z","steps":["trace[697351569] 'process raft request' (duration: 423.400318ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:22.396016Z","caller":"traceutil/trace.go:171","msg":"trace[1809014314] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:540; }","duration":"367.773335ms","start":"2026-04-03T02:19:22.028221Z","end":"2026-04-03T02:19:22.395994Z","steps":["trace[1809014314] 'read index received' (duration: 358.651671ms)","trace[1809014314] 'applied index is now lower than readState.Index' (duration: 9.120734ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:19:22.396036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:21.97229Z","time spent":"423.720896ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:19:22.395894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:21.951072Z","time spent":"444.611199ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:19:22.396097Z","caller":"traceutil/trace.go:171","msg":"trace[1761631436] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"433.047693ms","start":"2026-04-03T02:19:21.963042Z","end":"2026-04-03T02:19:22.396089Z","steps":["trace[1761631436] 'process raft request' (duration: 432.535281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:22.396063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:21.96683Z","time spent":"429.112116ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:19:22.396136Z","caller":"traceutil/trace.go:171","msg":"trace[1446329507] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"268.455247ms","start":"2026-04-03T02:19:22.127676Z","end":"2026-04-03T02:19:22.396131Z","steps":["trace[1446329507] 'process raft request' (duration: 268.246782ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:22.396095Z","caller":"traceutil/trace.go:171","msg":"trace[1346029668] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"419.574444ms","start":"2026-04-03T02:19:21.976512Z","end":"2026-04-03T02:19:22.396087Z","steps":["trace[1346029668] 'process raft request' (duration: 419.261066ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:22.396115Z","caller":"traceutil/trace.go:171","msg":"trace[1920999387] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"406.408192ms","start":"2026-04-03T02:19:21.989702Z","end":"2026-04-03T02:19:22.396111Z","steps":["trace[1920999387] 'process raft request' (duration: 406.133615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:22.396306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:21.963024Z","time spent":"433.137075ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:19:22.396298Z","caller":"traceutil/trace.go:171","msg":"trace[1238005234] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"433.324159ms","start":"2026-04-03T02:19:21.962948Z","end":"2026-04-03T02:19:22.396272Z","steps":["trace[1238005234] 'process raft request' (duration: 432.600352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:22.396365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:21.989673Z","time spent":"406.649958ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:19:22.396281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:21.976498Z","time spent":"419.744018ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:19:22.396205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.01038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:19:22.39645Z","caller":"traceutil/trace.go:171","msg":"trace[1081613190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:530; }","duration":"368.344597ms","start":"2026-04-03T02:19:22.028092Z","end":"2026-04-03T02:19:22.396437Z","steps":["trace[1081613190] 'agreement among raft nodes before linearized reading' (duration: 368.056681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:22.396487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:22.02806Z","time spent":"368.413739ms","remote":"127.0.0.1:58468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-03T02:19:22.395602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:21.95095Z","time spent":"444.596858ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:19:22.396644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:21.962926Z","time spent":"433.434352ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:19:22.43016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.890556ms","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-04-03T02:19:22.430258Z","caller":"traceutil/trace.go:171","msg":"trace[1513516034] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:537; }","duration":"291.047749ms","start":"2026-04-03T02:19:22.139187Z","end":"2026-04-03T02:19:22.430234Z","steps":["trace[1513516034] 'agreement among raft nodes before linearized reading' (duration: 290.816014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:22.430366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.196214ms","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-04-03T02:19:22.430453Z","caller":"traceutil/trace.go:171","msg":"trace[1827661998] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:537; }","duration":"193.293236ms","start":"2026-04-03T02:19:22.237138Z","end":"2026-04-03T02:19:22.430432Z","steps":["trace[1827661998] 'agreement among raft nodes before linearized reading' (duration: 193.165883ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:26.023929Z","caller":"traceutil/trace.go:171","msg":"trace[1326099922] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"371.310817ms","start":"2026-04-03T02:19:25.65259Z","end":"2026-04-03T02:19:26.023901Z","steps":["trace[1326099922] 'process raft request' (duration: 371.01962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:26.02413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:25.652563Z","time spent":"371.457991ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:19:30.555353Z","caller":"traceutil/trace.go:171","msg":"trace[1687477663] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"429.430561ms","start":"2026-04-03T02:19:30.125896Z","end":"2026-04-03T02:19:30.555327Z","steps":["trace[1687477663] 'process raft request' (duration: 428.854238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:30.555523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:30.125868Z","time spent":"429.567214ms","remote":"127.0.0.1:58572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:19:30.591601Z","caller":"traceutil/trace.go:171","msg":"trace[1421163865] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:660; }","duration":"115.813746ms","start":"2026-04-03T02:19:30.475759Z","end":"2026-04-03T02:19:30.591573Z","steps":["trace[1421163865] 'read index received' (duration: 78.786199ms)","trace[1421163865] 'applied index is now lower than readState.Index' (duration: 37.026317ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:19:30.591663Z","caller":"traceutil/trace.go:171","msg":"trace[1601102434] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"176.046128ms","start":"2026-04-03T02:19:30.415571Z","end":"2026-04-03T02:19:30.591617Z","steps":["trace[1601102434] 'process raft request' (duration: 175.851713ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:30.591845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.895207ms","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-04-03T02:19:30.591905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.131483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rxflb\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-03T02:19:30.591983Z","caller":"traceutil/trace.go:171","msg":"trace[1271322457] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rxflb; range_end:; response_count:1; response_revision:632; }","duration":"116.284226ms","start":"2026-04-03T02:19:30.475679Z","end":"2026-04-03T02:19:30.591964Z","steps":["trace[1271322457] 'agreement among raft nodes before linearized reading' (duration: 116.067302ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:30.591921Z","caller":"traceutil/trace.go:171","msg":"trace[2068325867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"112.00974ms","start":"2026-04-03T02:19:30.479894Z","end":"2026-04-03T02:19:30.591904Z","steps":["trace[2068325867] 'agreement among raft nodes before linearized reading' (duration: 111.893127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:30.592223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.164819ms","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-04-03T02:19:30.592323Z","caller":"traceutil/trace.go:171","msg":"trace[1615342721] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"110.315862ms","start":"2026-04-03T02:19:30.481989Z","end":"2026-04-03T02:19:30.592305Z","steps":["trace[1615342721] 'agreement among raft nodes before linearized reading' (duration: 110.072217ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:31.394777Z","caller":"traceutil/trace.go:171","msg":"trace[620826678] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"797.609255ms","start":"2026-04-03T02:19:30.597141Z","end":"2026-04-03T02:19:31.39475Z","steps":["trace[620826678] 'process raft request' (duration: 797.257167ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:31.39494Z","caller":"traceutil/trace.go:171","msg":"trace[1695998000] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"797.754558ms","start":"2026-04-03T02:19:30.597156Z","end":"2026-04-03T02:19:31.39491Z","steps":["trace[1695998000] 'process raft request' (duration: 797.542794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:31.394951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:30.597116Z","time spent":"797.747448ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:19:31.395631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:30.597131Z","time spent":"797.867901ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:19:31.594724Z","caller":"traceutil/trace.go:171","msg":"trace[697986146] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"995.750199ms","start":"2026-04-03T02:19:30.598947Z","end":"2026-04-03T02:19:31.594698Z","steps":["trace[697986146] 'process raft request' (duration: 995.529374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:31.594908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:30.59892Z","time spent":"995.883222ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:19:31.595156Z","caller":"traceutil/trace.go:171","msg":"trace[1418597295] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:662; }","duration":"566.561733ms","start":"2026-04-03T02:19:31.028572Z","end":"2026-04-03T02:19:31.595133Z","steps":["trace[1418597295] 'read index received' (duration: 365.923812ms)","trace[1418597295] 'applied index is now lower than readState.Index' (duration: 200.636901ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:19:31.595188Z","caller":"traceutil/trace.go:171","msg":"trace[1234043230] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"989.518658ms","start":"2026-04-03T02:19:30.60564Z","end":"2026-04-03T02:19:31.595159Z","steps":["trace[1234043230] 'process raft request' (duration: 989.344204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:31.595289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.696746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:19:31.595306Z","caller":"traceutil/trace.go:171","msg":"trace[28925706] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"996.105407ms","start":"2026-04-03T02:19:30.599189Z","end":"2026-04-03T02:19:31.595294Z","steps":["trace[28925706] 'process raft request' (duration: 995.465473ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:31.595324Z","caller":"traceutil/trace.go:171","msg":"trace[1669407782] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"566.790378ms","start":"2026-04-03T02:19:31.028525Z","end":"2026-04-03T02:19:31.595315Z","steps":["trace[1669407782] 'agreement among raft nodes before linearized reading' (duration: 566.697086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:31.595377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:30.599176Z","time spent":"996.165088ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T02:19:31.595377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:30.605608Z","time spent":"989.681312ms","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:19:31.595605Z","caller":"traceutil/trace.go:171","msg":"trace[2062501175] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"979.898651ms","start":"2026-04-03T02:19:30.615696Z","end":"2026-04-03T02:19:31.595595Z","steps":["trace[2062501175] 'process raft request' (duration: 979.39143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:31.595689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:30.615683Z","time spent":"979.955423ms","remote":"127.0.0.1:58698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:19:31.595359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:31.028503Z","time spent":"566.84821ms","remote":"127.0.0.1:58468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-03T02:19:32.784495Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.172336156s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-03T02:19:33.02492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.156796ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T02:19:33.025029Z","caller":"traceutil/trace.go:171","msg":"trace[86044559] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"1.412927693s","start":"2026-04-03T02:19:31.612081Z","end":"2026-04-03T02:19:33.025008Z","steps":["trace[86044559] 'process raft request' (duration: 1.172608353s)","trace[86044559] 'compare' (duration: 240.038694ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:19:33.025083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:31.612066Z","time spent":"1.412995794s","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:19:33.943489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.837443ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-04-03T02:19:33.943871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.525616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:19:33.943927Z","caller":"traceutil/trace.go:171","msg":"trace[925248790] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"914.612857ms","start":"2026-04-03T02:19:33.029295Z","end":"2026-04-03T02:19:33.943908Z","steps":["trace[925248790] 'agreement among raft nodes before linearized reading' (duration: 914.517075ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:33.943898Z","caller":"traceutil/trace.go:171","msg":"trace[2121642854] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"912.465888ms","start":"2026-04-03T02:19:33.031396Z","end":"2026-04-03T02:19:33.943862Z","steps":["trace[2121642854] 'process raft request' (duration: 912.197202ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:33.943861Z","caller":"traceutil/trace.go:171","msg":"trace[564259851] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"914.411662ms","start":"2026-04-03T02:19:33.029332Z","end":"2026-04-03T02:19:33.943743Z","steps":["trace[564259851] 'read index received' (duration: 98.352054ms)","trace[564259851] 'applied index is now lower than readState.Index' (duration: 816.049688ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:19:33.944418Z","caller":"traceutil/trace.go:171","msg":"trace[554648614] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"910.679697ms","start":"2026-04-03T02:19:33.033698Z","end":"2026-04-03T02:19:33.944378Z","steps":["trace[554648614] 'process raft request' (duration: 910.406581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:33.944589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.737951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:19:33.944617Z","caller":"traceutil/trace.go:171","msg":"trace[1637360130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"344.787033ms","start":"2026-04-03T02:19:33.599822Z","end":"2026-04-03T02:19:33.944609Z","steps":["trace[1637360130] 'agreement among raft nodes before linearized reading' (duration: 344.646889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:33.944643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:33.599815Z","time spent":"344.821483ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-03T02:19:33.944647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.580611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-03T02:19:33.944656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:33.03138Z","time spent":"912.935029ms","remote":"127.0.0.1:58556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:19:33.944685Z","caller":"traceutil/trace.go:171","msg":"trace[1131595211] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"544.677272ms","start":"2026-04-03T02:19:33.399997Z","end":"2026-04-03T02:19:33.944674Z","steps":["trace[1131595211] 'agreement among raft nodes before linearized reading' (duration: 544.460567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:33.944798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:33.399952Z","time spent":"544.832895ms","remote":"127.0.0.1:58718","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-04-03T02:19:33.944968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.327984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-03T02:19:33.945004Z","caller":"traceutil/trace.go:171","msg":"trace[2057752661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"345.364625ms","start":"2026-04-03T02:19:33.599631Z","end":"2026-04-03T02:19:33.944996Z","steps":["trace[2057752661] 'agreement among raft nodes before linearized reading' (duration: 345.273453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:33.94503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:33.599571Z","time spent":"345.453577ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-03T02:19:33.945073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.979707ms","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-04-03T02:19:33.943969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:33.029276Z","time spent":"914.686529ms","remote":"127.0.0.1:58468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-03T02:19:33.944008Z","caller":"traceutil/trace.go:171","msg":"trace[315520004] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"911.993117ms","start":"2026-04-03T02:19:33.031984Z","end":"2026-04-03T02:19:33.943977Z","steps":["trace[315520004] 'process raft request' (duration: 911.731872ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:33.94424Z","caller":"traceutil/trace.go:171","msg":"trace[1202100963] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"910.700457ms","start":"2026-04-03T02:19:33.033528Z","end":"2026-04-03T02:19:33.944229Z","steps":["trace[1202100963] 'process raft request' (duration: 910.490952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:33.946031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:33.03352Z","time spent":"912.336155ms","remote":"127.0.0.1:58698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:19:33.945104Z","caller":"traceutil/trace.go:171","msg":"trace[982809639] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"544.039808ms","start":"2026-04-03T02:19:33.401054Z","end":"2026-04-03T02:19:33.945094Z","steps":["trace[982809639] 'agreement among raft nodes before linearized reading' (duration: 543.944726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:33.946218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:33.401033Z","time spent":"545.152094ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-03T02:19:33.947401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:33.031971Z","time spent":"913.536292ms","remote":"127.0.0.1:58556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T02:19:33.947703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:33.033689Z","time spent":"911.637419ms","remote":"127.0.0.1:58652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:19:35.995876Z","caller":"traceutil/trace.go:171","msg":"trace[928985926] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"351.39988ms","start":"2026-04-03T02:19:35.644452Z","end":"2026-04-03T02:19:35.995852Z","steps":["trace[928985926] 'process raft request' (duration: 351.175545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:35.996007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:35.644422Z","time spent":"351.523213ms","remote":"127.0.0.1:58538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T02:19:36.004222Z","caller":"traceutil/trace.go:171","msg":"trace[1859732619] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"161.069772ms","start":"2026-04-03T02:19:35.843105Z","end":"2026-04-03T02:19:36.004175Z","steps":["trace[1859732619] 'process raft request' (duration: 160.920019ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:49.916365Z","caller":"traceutil/trace.go:171","msg":"trace[2123573759] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"400.55317ms","start":"2026-04-03T02:19:49.515725Z","end":"2026-04-03T02:19:49.916278Z","steps":["trace[2123573759] 'process raft request' (duration: 400.299064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:49.916823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:49.515708Z","time spent":"400.895749ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:19:50.491635Z","caller":"traceutil/trace.go:171","msg":"trace[454239483] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"884.992871ms","start":"2026-04-03T02:19:49.606593Z","end":"2026-04-03T02:19:50.491586Z","steps":["trace[454239483] 'process raft request' (duration: 884.648413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:50.491821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"851.581392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:19:50.491868Z","caller":"traceutil/trace.go:171","msg":"trace[1602456974] linearizableReadLoop","detail":"{readStateIndex:842; appliedIndex:840; }","duration":"851.255115ms","start":"2026-04-03T02:19:49.640197Z","end":"2026-04-03T02:19:50.491452Z","steps":["trace[1602456974] 'read index received' (duration: 275.861156ms)","trace[1602456974] 'applied index is now lower than readState.Index' (duration: 575.392389ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:19:50.491929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:49.60655Z","time spent":"885.225675ms","remote":"127.0.0.1:58698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T02:19:50.491914Z","caller":"traceutil/trace.go:171","msg":"trace[704212256] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:806; }","duration":"851.765327ms","start":"2026-04-03T02:19:49.640128Z","end":"2026-04-03T02:19:50.491893Z","steps":["trace[704212256] 'agreement among raft nodes before linearized reading' (duration: 851.554342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:50.492309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.762815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-03T02:19:50.492318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.822692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-03T02:19:50.492344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.660934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:19:50.492361Z","caller":"traceutil/trace.go:171","msg":"trace[974694903] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:806; }","duration":"408.844467ms","start":"2026-04-03T02:19:50.083503Z","end":"2026-04-03T02:19:50.492347Z","steps":["trace[974694903] 'agreement among raft nodes before linearized reading' (duration: 408.664783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:50.492361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.800316ms","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-04-03T02:19:50.49237Z","caller":"traceutil/trace.go:171","msg":"trace[1144614479] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:806; }","duration":"404.903786ms","start":"2026-04-03T02:19:50.087452Z","end":"2026-04-03T02:19:50.492356Z","steps":["trace[1144614479] 'agreement among raft nodes before linearized reading' (duration: 404.719601ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:19:50.492405Z","caller":"traceutil/trace.go:171","msg":"trace[1784642581] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:806; }","duration":"207.789706ms","start":"2026-04-03T02:19:50.284602Z","end":"2026-04-03T02:19:50.492391Z","steps":["trace[1784642581] 'agreement among raft nodes before linearized reading' (duration: 207.604332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:50.492413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:50.083479Z","time spent":"408.925309ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-03T02:19:50.492419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:50.087432Z","time spent":"404.978837ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-03T02:19:50.492422Z","caller":"traceutil/trace.go:171","msg":"trace[1673741220] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:806; }","duration":"399.908309ms","start":"2026-04-03T02:19:50.092495Z","end":"2026-04-03T02:19:50.492403Z","steps":["trace[1673741220] 'agreement among raft nodes before linearized reading' (duration: 399.706444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:50.49247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:50.092463Z","time spent":"399.995491ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-03T02:19:50.492481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.436577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-03T02:19:50.492519Z","caller":"traceutil/trace.go:171","msg":"trace[1456010321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:806; }","duration":"417.519629ms","start":"2026-04-03T02:19:50.074987Z","end":"2026-04-03T02:19:50.492507Z","steps":["trace[1456010321] 'agreement among raft nodes before linearized reading' (duration: 417.350375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:50.492549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:50.07495Z","time spent":"417.592641ms","remote":"127.0.0.1:58718","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-04-03T02:19:50.492132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.877768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:19:50.492602Z","caller":"traceutil/trace.go:171","msg":"trace[565196695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:806; }","duration":"463.43637ms","start":"2026-04-03T02:19:50.029155Z","end":"2026-04-03T02:19:50.492592Z","steps":["trace[565196695] 'agreement among raft nodes before linearized reading' (duration: 462.871087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:19:50.492639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:50.029125Z","time spent":"463.506522ms","remote":"127.0.0.1:58468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-03T02:19:50.492769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T02:19:49.640097Z","time spent":"852.092714ms","remote":"127.0.0.1:58622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-04-03T02:21:29.102234Z","caller":"traceutil/trace.go:171","msg":"trace[625411485] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"100.0504ms","start":"2026-04-03T02:21:29.00213Z","end":"2026-04-03T02:21:29.102181Z","steps":["trace[625411485] 'process raft request' (duration: 99.696121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:29.151126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.21911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-03T02:21:29.151159Z","caller":"traceutil/trace.go:171","msg":"trace[1234201467] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"134.565429ms","start":"2026-04-03T02:21:29.016556Z","end":"2026-04-03T02:21:29.151122Z","steps":["trace[1234201467] 'process raft request' (duration: 134.315243ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:21:29.151216Z","caller":"traceutil/trace.go:171","msg":"trace[1701689640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1282; }","duration":"140.339093ms","start":"2026-04-03T02:21:29.010856Z","end":"2026-04-03T02:21:29.151195Z","steps":["trace[1701689640] 'agreement among raft nodes before linearized reading' (duration: 140.147508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:29.151285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.62162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:21:29.151381Z","caller":"traceutil/trace.go:171","msg":"trace[798805765] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1282; }","duration":"101.784543ms","start":"2026-04-03T02:21:29.049573Z","end":"2026-04-03T02:21:29.151358Z","steps":["trace[798805765] 'agreement among raft nodes before linearized reading' (duration: 101.584528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:29.151443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.241336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:21:29.151536Z","caller":"traceutil/trace.go:171","msg":"trace[2140581850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1282; }","duration":"137.37234ms","start":"2026-04-03T02:21:29.014143Z","end":"2026-04-03T02:21:29.151515Z","steps":["trace[2140581850] 'agreement among raft nodes before linearized reading' (duration: 137.077033ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:21:30.593277Z","caller":"traceutil/trace.go:171","msg":"trace[589398219] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"117.521586ms","start":"2026-04-03T02:21:30.475713Z","end":"2026-04-03T02:21:30.593234Z","steps":["trace[589398219] 'process raft request' (duration: 117.008393ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:21:37.381112Z","caller":"traceutil/trace.go:171","msg":"trace[1332665410] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"239.978195ms","start":"2026-04-03T02:21:37.141108Z","end":"2026-04-03T02:21:37.381086Z","steps":["trace[1332665410] 'process raft request' (duration: 239.817561ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:21:37.436805Z","caller":"traceutil/trace.go:171","msg":"trace[1447792397] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1385; }","duration":"219.30467ms","start":"2026-04-03T02:21:37.217475Z","end":"2026-04-03T02:21:37.43678Z","steps":["trace[1447792397] 'read index received' (duration: 163.427897ms)","trace[1447792397] 'applied index is now lower than readState.Index' (duration: 55.875633ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T02:21:37.437023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.114581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T02:21:37.437107Z","caller":"traceutil/trace.go:171","msg":"trace[778803394] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1327; }","duration":"208.222444ms","start":"2026-04-03T02:21:37.228866Z","end":"2026-04-03T02:21:37.437088Z","steps":["trace[778803394] 'agreement among raft nodes before linearized reading' (duration: 208.07848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:37.437269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.779782ms","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-04-03T02:21:37.437323Z","caller":"traceutil/trace.go:171","msg":"trace[1414548621] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1327; }","duration":"219.883194ms","start":"2026-04-03T02:21:37.217424Z","end":"2026-04-03T02:21:37.437307Z","steps":["trace[1414548621] 'agreement among raft nodes before linearized reading' (duration: 219.490685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:37.437297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.08449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-03T02:21:37.437484Z","caller":"traceutil/trace.go:171","msg":"trace[118792303] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"259.128543ms","start":"2026-04-03T02:21:37.177716Z","end":"2026-04-03T02:21:37.436845Z","steps":["trace[118792303] 'process raft request' (duration: 257.268366ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:37.437636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.421838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-03T02:21:37.437804Z","caller":"traceutil/trace.go:171","msg":"trace[260059550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1327; }","duration":"204.623013ms","start":"2026-04-03T02:21:37.233168Z","end":"2026-04-03T02:21:37.437791Z","steps":["trace[260059550] 'agreement among raft nodes before linearized reading' (duration: 203.804633ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:21:37.43751Z","caller":"traceutil/trace.go:171","msg":"trace[1453995619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1327; }","duration":"204.358717ms","start":"2026-04-03T02:21:37.233129Z","end":"2026-04-03T02:21:37.437488Z","steps":["trace[1453995619] 'agreement among raft nodes before linearized reading' (duration: 203.873825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:41.556329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.393953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-03T02:21:41.556408Z","caller":"traceutil/trace.go:171","msg":"trace[2017696721] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1340; }","duration":"182.530986ms","start":"2026-04-03T02:21:41.373858Z","end":"2026-04-03T02:21:41.556389Z","steps":["trace[2017696721] 'count revisions from in-memory index tree' (duration: 182.28222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:41.556935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.335814ms","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-04-03T02:21:41.557019Z","caller":"traceutil/trace.go:171","msg":"trace[675734259] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1340; }","duration":"132.470926ms","start":"2026-04-03T02:21:41.42453Z","end":"2026-04-03T02:21:41.557001Z","steps":["trace[675734259] 'range keys from in-memory index tree' (duration: 132.086448ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:21:41.663954Z","caller":"traceutil/trace.go:171","msg":"trace[307805352] linearizableReadLoop","detail":"{readStateIndex:1402; appliedIndex:1400; }","duration":"136.470516ms","start":"2026-04-03T02:21:41.527464Z","end":"2026-04-03T02:21:41.663934Z","steps":["trace[307805352] 'read index received' (duration: 62.806277ms)","trace[307805352] 'applied index is now lower than readState.Index' (duration: 73.663339ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T02:21:41.664065Z","caller":"traceutil/trace.go:171","msg":"trace[1434761307] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"147.691127ms","start":"2026-04-03T02:21:41.516363Z","end":"2026-04-03T02:21:41.664055Z","steps":["trace[1434761307] 'process raft request' (duration: 147.414361ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:21:41.664204Z","caller":"traceutil/trace.go:171","msg":"trace[2125417265] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"103.165035ms","start":"2026-04-03T02:21:41.56103Z","end":"2026-04-03T02:21:41.664195Z","steps":["trace[2125417265] 'process raft request' (duration: 102.860697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:41.664372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.896878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T02:21:41.664412Z","caller":"traceutil/trace.go:171","msg":"trace[2016636961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1342; }","duration":"136.949569ms","start":"2026-04-03T02:21:41.527452Z","end":"2026-04-03T02:21:41.664401Z","steps":["trace[2016636961] 'agreement among raft nodes before linearized reading' (duration: 136.819906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:41.664562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.386725ms","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-04-03T02:21:41.664596Z","caller":"traceutil/trace.go:171","msg":"trace[1258341730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1342; }","duration":"128.444747ms","start":"2026-04-03T02:21:41.536144Z","end":"2026-04-03T02:21:41.664588Z","steps":["trace[1258341730] 'agreement among raft nodes before linearized reading' (duration: 128.351144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:41.664725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.182436ms","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-04-03T02:21:41.664755Z","caller":"traceutil/trace.go:171","msg":"trace[458279908] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1342; }","duration":"119.235757ms","start":"2026-04-03T02:21:41.545512Z","end":"2026-04-03T02:21:41.664748Z","steps":["trace[458279908] 'agreement among raft nodes before linearized reading' (duration: 119.148994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T02:21:41.664961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.447907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-03T02:21:41.664998Z","caller":"traceutil/trace.go:171","msg":"trace[1748327668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1342; }","duration":"128.505107ms","start":"2026-04-03T02:21:41.536483Z","end":"2026-04-03T02:21:41.664989Z","steps":["trace[1748327668] 'agreement among raft nodes before linearized reading' (duration: 128.417035ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:21:41.915823Z","caller":"traceutil/trace.go:171","msg":"trace[374980855] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"245.183331ms","start":"2026-04-03T02:21:41.670619Z","end":"2026-04-03T02:21:41.915802Z","steps":["trace[374980855] 'process raft request' (duration: 245.11535ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:21:41.915831Z","caller":"traceutil/trace.go:171","msg":"trace[1449222064] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"245.510079ms","start":"2026-04-03T02:21:41.670295Z","end":"2026-04-03T02:21:41.915806Z","steps":["trace[1449222064] 'process raft request' (duration: 240.242328ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T02:21:42.880613Z","caller":"traceutil/trace.go:171","msg":"trace[1557354852] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"187.231585ms","start":"2026-04-03T02:21:42.693356Z","end":"2026-04-03T02:21:42.880588Z","steps":["trace[1557354852] 'process raft request' (duration: 187.055551ms)"],"step_count":1}