{"level":"warn","ts":"2026-04-16T06:05:09.147496Z","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-16T06:05:09.147633Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78: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.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-16T06:05:09.147786Z","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-16T06:05:09.147833Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-16T06:05:09.147884Z","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-16T06:05:09.149083Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-04-16T06:05:09.149264Z","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.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-16T06:05:09.26791Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"104.774838ms"} {"level":"info","ts":"2026-04-16T06:05:09.310408Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-04-16T06:05:09.310623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T06:05:09.310669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-04-16T06:05:09.310697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T06:05:09.310733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-04-16T06:05:09.310822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-04-16T06:05:09.347165Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T06:05:09.352066Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T06:05:09.362151Z","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-16T06:05:09.370473Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T06:05:09.371746Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T06:05:09.371944Z","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-16T06:05:09.372107Z","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-16T06:05:09.372131Z","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-16T06:05:09.37526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-04-16T06:05:09.375365Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-16T06:05:09.378109Z","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-16T06:05:09.378291Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-16T06:05:09.378423Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-16T06:05:09.378498Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T06:05:09.378552Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T06:05:09.51147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T06:05:09.511561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T06:05:09.511617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-04-16T06:05:09.511642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-04-16T06:05:09.51166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-16T06:05:09.511678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-04-16T06:05:09.5117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-16T06:05:09.512697Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:09.513937Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T06:05:09.514021Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:05:09.513979Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:05:09.516316Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:09.516474Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:09.516528Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:09.516844Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T06:05:09.516891Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T06:05:09.518539Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T06:05:09.518905Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"warn","ts":"2026-04-16T06:05:35.289823Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603953589502711,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:05:35.437039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.648566382s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:35.437205Z","caller":"traceutil/trace.go:171","msg":"trace[1471934590] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:457; }","duration":"2.648797905s","start":"2026-04-16T06:05:32.788384Z","end":"2026-04-16T06:05:35.437182Z","steps":["trace[1471934590] 'range keys from in-memory index tree' (duration: 2.648471081s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:35.437234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.338811ms","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-16T06:05:35.437289Z","caller":"traceutil/trace.go:171","msg":"trace[1515573758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:457; }","duration":"904.461462ms","start":"2026-04-16T06:05:34.532812Z","end":"2026-04-16T06:05:35.437274Z","steps":["trace[1515573758] 'range keys from in-memory index tree' (duration: 904.19343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:35.437277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:32.788362Z","time spent":"2.648902686s","remote":"127.0.0.1:33456","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-16T06:05:35.437317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:34.532773Z","time spent":"904.537953ms","remote":"127.0.0.1:33730","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-16T06:05:35.437313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.837520036s","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-16T06:05:35.437477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.48073482s","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-16T06:05:35.437478Z","caller":"traceutil/trace.go:171","msg":"trace[1088197274] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:457; }","duration":"1.837784009s","start":"2026-04-16T06:05:33.599664Z","end":"2026-04-16T06:05:35.437448Z","steps":["trace[1088197274] 'range keys from in-memory index tree' (duration: 1.837348974s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:35.437519Z","caller":"traceutil/trace.go:171","msg":"trace[82947864] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:457; }","duration":"2.480807852s","start":"2026-04-16T06:05:32.956701Z","end":"2026-04-16T06:05:35.437509Z","steps":["trace[82947864] 'range keys from in-memory index tree' (duration: 2.480629859s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:35.437545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:33.599635Z","time spent":"1.83789617s","remote":"127.0.0.1:33730","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-16T06:05:35.437553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:32.956683Z","time spent":"2.480863362s","remote":"127.0.0.1:33730","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-16T06:05:35.437675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.120507497s","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-16T06:05:35.43777Z","caller":"traceutil/trace.go:171","msg":"trace[1363299226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:457; }","duration":"2.120669329s","start":"2026-04-16T06:05:33.317079Z","end":"2026-04-16T06:05:35.437748Z","steps":["trace[1363299226] 'range keys from in-memory index tree' (duration: 2.120386966s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:35.437821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:33.317057Z","time spent":"2.12075374s","remote":"127.0.0.1:33730","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-16T06:05:35.438051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.566687705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-16T06:05:35.438103Z","caller":"traceutil/trace.go:171","msg":"trace[1881971480] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:457; }","duration":"2.566767675s","start":"2026-04-16T06:05:32.871325Z","end":"2026-04-16T06:05:35.438092Z","steps":["trace[1881971480] 'range keys from in-memory index tree' (duration: 2.566615644s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:35.43813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:32.871306Z","time spent":"2.566818116s","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.78\" "} {"level":"info","ts":"2026-04-16T06:05:35.660487Z","caller":"traceutil/trace.go:171","msg":"trace[1599755159] linearizableReadLoop","detail":"{readStateIndex:473; appliedIndex:472; }","duration":"871.454393ms","start":"2026-04-16T06:05:34.789006Z","end":"2026-04-16T06:05:35.66046Z","steps":["trace[1599755159] 'read index received' (duration: 871.347932ms)","trace[1599755159] 'applied index is now lower than readState.Index' (duration: 105.581µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:35.660605Z","caller":"traceutil/trace.go:171","msg":"trace[1778893468] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"915.074071ms","start":"2026-04-16T06:05:34.745512Z","end":"2026-04-16T06:05:35.660586Z","steps":["trace[1778893468] 'process raft request' (duration: 914.785957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:35.660714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.685157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:35.660968Z","caller":"traceutil/trace.go:171","msg":"trace[569360112] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:458; }","duration":"871.95784ms","start":"2026-04-16T06:05:34.788956Z","end":"2026-04-16T06:05:35.660914Z","steps":["trace[569360112] 'agreement among raft nodes before linearized reading' (duration: 871.669506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:35.661087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:34.788936Z","time spent":"872.131842ms","remote":"127.0.0.1:33470","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-16T06:05:35.661715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:34.745489Z","time spent":"915.370965ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:35.706586Z","caller":"traceutil/trace.go:171","msg":"trace[503618855] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"264.12741ms","start":"2026-04-16T06:05:35.442433Z","end":"2026-04-16T06:05:35.70656Z","steps":["trace[503618855] 'process raft request' (duration: 263.886817ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:35.706593Z","caller":"traceutil/trace.go:171","msg":"trace[703061702] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"263.330911ms","start":"2026-04-16T06:05:35.44324Z","end":"2026-04-16T06:05:35.706571Z","steps":["trace[703061702] 'process raft request' (duration: 263.23874ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:35.706904Z","caller":"traceutil/trace.go:171","msg":"trace[1265980901] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"262.089927ms","start":"2026-04-16T06:05:35.444769Z","end":"2026-04-16T06:05:35.706859Z","steps":["trace[1265980901] 'process raft request' (duration: 261.769164ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:35.707167Z","caller":"traceutil/trace.go:171","msg":"trace[2134239752] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"261.769203ms","start":"2026-04-16T06:05:35.445381Z","end":"2026-04-16T06:05:35.70715Z","steps":["trace[2134239752] 'process raft request' (duration: 261.448029ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:35.84789Z","caller":"traceutil/trace.go:171","msg":"trace[32215429] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"183.27041ms","start":"2026-04-16T06:05:35.664595Z","end":"2026-04-16T06:05:35.847865Z","steps":["trace[32215429] 'process raft request' (duration: 179.386045ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:35.848006Z","caller":"traceutil/trace.go:171","msg":"trace[1297681787] linearizableReadLoop","detail":"{readStateIndex:479; appliedIndex:473; }","duration":"177.885917ms","start":"2026-04-16T06:05:35.670093Z","end":"2026-04-16T06:05:35.847979Z","steps":["trace[1297681787] 'read index received' (duration: 36.15953ms)","trace[1297681787] 'applied index is now lower than readState.Index' (duration: 141.723097ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:35.84805Z","caller":"traceutil/trace.go:171","msg":"trace[1871020651] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"140.172719ms","start":"2026-04-16T06:05:35.707848Z","end":"2026-04-16T06:05:35.848021Z","steps":["trace[1871020651] 'process raft request' (duration: 140.051738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:35.848304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.18699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:35.848358Z","caller":"traceutil/trace.go:171","msg":"trace[257833551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:464; }","duration":"178.286072ms","start":"2026-04-16T06:05:35.670056Z","end":"2026-04-16T06:05:35.848342Z","steps":["trace[257833551] 'agreement among raft nodes before linearized reading' (duration: 178.014779ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:39.497739Z","caller":"traceutil/trace.go:171","msg":"trace[1736116185] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"324.017509ms","start":"2026-04-16T06:05:39.173698Z","end":"2026-04-16T06:05:39.497715Z","steps":["trace[1736116185] 'process raft request' (duration: 323.881327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:39.497896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.17368Z","time spent":"324.16172ms","remote":"127.0.0.1:33508","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-16T06:05:39.526491Z","caller":"traceutil/trace.go:171","msg":"trace[474015812] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"340.802492ms","start":"2026-04-16T06:05:39.185662Z","end":"2026-04-16T06:05:39.526464Z","steps":["trace[474015812] 'process raft request' (duration: 340.55729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:39.526614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.185643Z","time spent":"340.906244ms","remote":"127.0.0.1:33508","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-16T06:05:39.526611Z","caller":"traceutil/trace.go:171","msg":"trace[2116801896] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"312.380726ms","start":"2026-04-16T06:05:39.214187Z","end":"2026-04-16T06:05:39.526568Z","steps":["trace[2116801896] 'process raft request' (duration: 312.227693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:39.526752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.21417Z","time spent":"312.519047ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:39.527903Z","caller":"traceutil/trace.go:171","msg":"trace[1358934170] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"303.836457ms","start":"2026-04-16T06:05:39.22296Z","end":"2026-04-16T06:05:39.526796Z","steps":["trace[1358934170] 'process raft request' (duration: 303.526133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:39.528083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.222925Z","time spent":"305.066191ms","remote":"127.0.0.1:33508","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-16T06:05:39.526816Z","caller":"traceutil/trace.go:171","msg":"trace[1809740986] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"310.569735ms","start":"2026-04-16T06:05:39.216204Z","end":"2026-04-16T06:05:39.526774Z","steps":["trace[1809740986] 'process raft request' (duration: 310.2454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:39.528334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.216196Z","time spent":"312.098802ms","remote":"127.0.0.1:33508","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-16T06:05:39.528369Z","caller":"traceutil/trace.go:171","msg":"trace[1955704124] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"284.373701ms","start":"2026-04-16T06:05:39.243975Z","end":"2026-04-16T06:05:39.528349Z","steps":["trace[1955704124] 'process raft request' (duration: 282.689313ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:39.528448Z","caller":"traceutil/trace.go:171","msg":"trace[2019120750] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"293.894003ms","start":"2026-04-16T06:05:39.232942Z","end":"2026-04-16T06:05:39.526836Z","steps":["trace[2019120750] 'process raft request' (duration: 293.616919ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:39.528486Z","caller":"traceutil/trace.go:171","msg":"trace[706551639] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"290.604354ms","start":"2026-04-16T06:05:39.237858Z","end":"2026-04-16T06:05:39.528462Z","steps":["trace[706551639] 'process raft request' (duration: 288.762243ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:39.529105Z","caller":"traceutil/trace.go:171","msg":"trace[2003701091] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"295.687652ms","start":"2026-04-16T06:05:39.232857Z","end":"2026-04-16T06:05:39.528544Z","steps":["trace[2003701091] 'process raft request' (duration: 293.657268ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:39.529264Z","caller":"traceutil/trace.go:171","msg":"trace[2010675993] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"337.720567ms","start":"2026-04-16T06:05:39.191497Z","end":"2026-04-16T06:05:39.529218Z","steps":["trace[2010675993] 'process raft request' (duration: 334.874854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:39.529315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.191479Z","time spent":"337.806648ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:39.530314Z","caller":"traceutil/trace.go:171","msg":"trace[1873504375] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"268.57354ms","start":"2026-04-16T06:05:39.261703Z","end":"2026-04-16T06:05:39.530277Z","steps":["trace[1873504375] 'process raft request' (duration: 265.07098ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:39.530581Z","caller":"traceutil/trace.go:171","msg":"trace[1688988835] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"179.788755ms","start":"2026-04-16T06:05:39.350476Z","end":"2026-04-16T06:05:39.530265Z","steps":["trace[1688988835] 'process raft request' (duration: 179.156228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:40.21992Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603953589502799,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:05:40.720416Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603953589502799,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:05:40.949655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.000769ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:40.949708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:40.345191Z","time spent":"604.509135ms","remote":"127.0.0.1:46146","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-16T06:05:40.949768Z","caller":"traceutil/trace.go:171","msg":"trace[742442716] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:514; }","duration":"709.124702ms","start":"2026-04-16T06:05:40.240627Z","end":"2026-04-16T06:05:40.949751Z","steps":["trace[742442716] 'range keys from in-memory index tree' (duration: 708.986589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:41.221299Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603953589502799,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:05:41.721968Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603953589502799,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:05:41.758778Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.229924048s","expected-duration":"1s"} {"level":"info","ts":"2026-04-16T06:05:41.759663Z","caller":"traceutil/trace.go:171","msg":"trace[379083621] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"2.256843419s","start":"2026-04-16T06:05:39.502784Z","end":"2026-04-16T06:05:41.759628Z","steps":["trace[379083621] 'process raft request' (duration: 2.256348822s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:41.759857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.502758Z","time spent":"2.257019531s","remote":"127.0.0.1:33980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:41.759917Z","caller":"traceutil/trace.go:171","msg":"trace[1834145749] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"2.255625995s","start":"2026-04-16T06:05:39.504275Z","end":"2026-04-16T06:05:41.759901Z","steps":["trace[1834145749] 'process raft request' (duration: 2.25522676s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:41.759929Z","caller":"traceutil/trace.go:171","msg":"trace[224032488] transaction","detail":"{read_only:false; number_of_response:1; response_revision:516; }","duration":"2.254258289s","start":"2026-04-16T06:05:39.505605Z","end":"2026-04-16T06:05:41.759863Z","steps":["trace[224032488] 'process raft request' (duration: 2.254083117s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:41.760002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.504262Z","time spent":"2.255691355s","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:41.760846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.505595Z","time spent":"2.254465331s","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:41.785965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999956712s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-16T06:05:41.786814Z","caller":"traceutil/trace.go:171","msg":"trace[1777442827] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000865433s","start":"2026-04-16T06:05:39.785922Z","end":"2026-04-16T06:05:41.786787Z","steps":["trace[1777442827] 'agreement among raft nodes before linearized reading' (duration: 1.999970973s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:41.787196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.785912Z","time spent":"2.001174667s","remote":"127.0.0.1:33456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/16 06:05:41 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-16T06:05:43.565977Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.781195757s","expected-duration":"1s"} {"level":"info","ts":"2026-04-16T06:05:43.638094Z","caller":"traceutil/trace.go:171","msg":"trace[1254694532] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"4.082757106s","start":"2026-04-16T06:05:39.555318Z","end":"2026-04-16T06:05:43.638075Z","steps":["trace[1254694532] 'process raft request' (duration: 4.082672685s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:43.638188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.555284Z","time spent":"4.082852517s","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:43.63829Z","caller":"traceutil/trace.go:171","msg":"trace[663260263] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:531; }","duration":"3.919290549s","start":"2026-04-16T06:05:39.718991Z","end":"2026-04-16T06:05:43.638282Z","steps":["trace[663260263] 'read index received' (duration: 2.040132957s)","trace[663260263] 'applied index is now lower than readState.Index' (duration: 1.879156922s)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:43.638391Z","caller":"traceutil/trace.go:171","msg":"trace[1229966780] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"4.040235595s","start":"2026-04-16T06:05:39.598147Z","end":"2026-04-16T06:05:43.638383Z","steps":["trace[1229966780] 'process raft request' (duration: 4.039869271s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:43.638371Z","caller":"traceutil/trace.go:171","msg":"trace[898816663] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"4.096754108s","start":"2026-04-16T06:05:39.541587Z","end":"2026-04-16T06:05:43.638341Z","steps":["trace[898816663] 'process raft request' (duration: 4.096194532s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:43.638421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.598124Z","time spent":"4.040282536s","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:43.638478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.541526Z","time spent":"4.096898579s","remote":"127.0.0.1:33980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:43.638381Z","caller":"traceutil/trace.go:171","msg":"trace[1085424022] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"4.096669866s","start":"2026-04-16T06:05:39.541621Z","end":"2026-04-16T06:05:43.638291Z","steps":["trace[1085424022] 'process raft request' (duration: 4.096205081s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:43.63862Z","caller":"traceutil/trace.go:171","msg":"trace[2116131187] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"4.096238562s","start":"2026-04-16T06:05:39.542376Z","end":"2026-04-16T06:05:43.638615Z","steps":["trace[2116131187] 'process raft request' (duration: 4.095505334s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:43.638652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.542368Z","time spent":"4.096272852s","remote":"127.0.0.1:33980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:43.638708Z","caller":"traceutil/trace.go:171","msg":"trace[57038083] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"4.096378543s","start":"2026-04-16T06:05:39.542325Z","end":"2026-04-16T06:05:43.638704Z","steps":["trace[57038083] 'process raft request' (duration: 4.095522524s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:43.638747Z","caller":"traceutil/trace.go:171","msg":"trace[1654802090] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"4.094578752s","start":"2026-04-16T06:05:39.544161Z","end":"2026-04-16T06:05:43.63874Z","steps":["trace[1654802090] 'process raft request' (duration: 4.093747913s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:43.638749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.540365Z","time spent":"4.098357286s","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:43.638788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.544151Z","time spent":"4.094616063s","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:43.638857Z","caller":"traceutil/trace.go:171","msg":"trace[1855912509] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"4.09087243s","start":"2026-04-16T06:05:39.54798Z","end":"2026-04-16T06:05:43.638853Z","steps":["trace[1855912509] 'process raft request' (duration: 4.08997872s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:43.638886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.54796Z","time spent":"4.09091113s","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:43.63855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.919567242s","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-16T06:05:43.638997Z","caller":"traceutil/trace.go:171","msg":"trace[1479126584] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:525; }","duration":"3.920044399s","start":"2026-04-16T06:05:39.718948Z","end":"2026-04-16T06:05:43.638992Z","steps":["trace[1479126584] 'agreement among raft nodes before linearized reading' (duration: 3.919565433s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:43.639015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.718927Z","time spent":"3.920083069s","remote":"127.0.0.1:33730","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-16T06:05:43.638245Z","caller":"traceutil/trace.go:171","msg":"trace[1192405204] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"4.106209448s","start":"2026-04-16T06:05:39.532007Z","end":"2026-04-16T06:05:43.638216Z","steps":["trace[1192405204] 'process raft request' (duration: 4.034249333s)","trace[1192405204] 'compare' (duration: 70.433188ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:43.639248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.531986Z","time spent":"4.107169109s","remote":"127.0.0.1:33980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:43.639907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.541592Z","time spent":"4.097493817s","remote":"127.0.0.1:33980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:43.787199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000247649s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-16T06:05:43.787286Z","caller":"traceutil/trace.go:171","msg":"trace[1586487295] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000388111s","start":"2026-04-16T06:05:41.786878Z","end":"2026-04-16T06:05:43.787266Z","steps":["trace[1586487295] 'agreement among raft nodes before linearized reading' (duration: 2.00028317s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:43.787335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.786859Z","time spent":"2.000466262s","remote":"127.0.0.1:33470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T06:05:44.006651Z","caller":"traceutil/trace.go:171","msg":"trace[2131520959] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"2.240246832s","start":"2026-04-16T06:05:41.766364Z","end":"2026-04-16T06:05:44.006611Z","steps":["trace[2131520959] 'process raft request' (duration: 2.195511239s)","trace[2131520959] 'compare' (duration: 44.47931ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:44.006757Z","caller":"traceutil/trace.go:171","msg":"trace[1589223169] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.882357527s","start":"2026-04-16T06:05:42.12437Z","end":"2026-04-16T06:05:44.006727Z","steps":["trace[1589223169] 'process raft request' (duration: 1.882271326s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:44.006769Z","caller":"traceutil/trace.go:171","msg":"trace[1121523756] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"2.221401316s","start":"2026-04-16T06:05:41.785352Z","end":"2026-04-16T06:05:44.006754Z","steps":["trace[1121523756] 'process raft request' (duration: 2.221208613s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:44.00696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.785322Z","time spent":"2.221513956s","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:44.006957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:42.124344Z","time spent":"1.882471708s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:44.007052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.766343Z","time spent":"2.240406103s","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:44.007118Z","caller":"traceutil/trace.go:171","msg":"trace[1606773316] transaction","detail":"{read_only:false; number_of_response:1; response_revision:526; }","duration":"2.239556374s","start":"2026-04-16T06:05:41.767544Z","end":"2026-04-16T06:05:44.0071Z","steps":["trace[1606773316] 'process raft request' (duration: 2.238955768s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:44.007176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135383669s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-16T06:05:44.007198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.767517Z","time spent":"2.239637125s","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10112,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:44.007222Z","caller":"traceutil/trace.go:171","msg":"trace[210426650] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:528; }","duration":"1.135460891s","start":"2026-04-16T06:05:42.871747Z","end":"2026-04-16T06:05:44.007208Z","steps":["trace[210426650] 'agreement among raft nodes before linearized reading' (duration: 1.13537141s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:44.007257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.434059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:44.007267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:42.871729Z","time spent":"1.135527381s","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.78\" "} {"level":"info","ts":"2026-04-16T06:05:44.007293Z","caller":"traceutil/trace.go:171","msg":"trace[1300799427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:528; }","duration":"637.497509ms","start":"2026-04-16T06:05:43.369787Z","end":"2026-04-16T06:05:44.007284Z","steps":["trace[1300799427] 'agreement among raft nodes before linearized reading' (duration: 637.437459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:44.007315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:43.369749Z","time spent":"637.56216ms","remote":"127.0.0.1:33456","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-16T06:05:44.007351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.236203739s","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-16T06:05:44.007383Z","caller":"traceutil/trace.go:171","msg":"trace[1507704222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:528; }","duration":"4.236245099s","start":"2026-04-16T06:05:39.771128Z","end":"2026-04-16T06:05:44.007373Z","steps":["trace[1507704222] 'agreement among raft nodes before linearized reading' (duration: 4.236186569s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:44.007409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.771121Z","time spent":"4.23628224s","remote":"127.0.0.1:33730","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-16T06:05:44.007473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.236858216s","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-16T06:05:44.007625Z","caller":"traceutil/trace.go:171","msg":"trace[1037092383] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:543; }","duration":"368.384564ms","start":"2026-04-16T06:05:43.638307Z","end":"2026-04-16T06:05:44.006692Z","steps":["trace[1037092383] 'read index received' (duration: 323.651161ms)","trace[1037092383] 'applied index is now lower than readState.Index' (duration: 44.732533ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:44.00773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.240644151s","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-16T06:05:44.007784Z","caller":"traceutil/trace.go:171","msg":"trace[1179871071] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:528; }","duration":"4.240733642s","start":"2026-04-16T06:05:39.767038Z","end":"2026-04-16T06:05:44.007772Z","steps":["trace[1179871071] 'agreement among raft nodes before linearized reading' (duration: 4.240630431s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:44.00782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.767013Z","time spent":"4.240798952s","remote":"127.0.0.1:33730","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":"info","ts":"2026-04-16T06:05:44.008195Z","caller":"traceutil/trace.go:171","msg":"trace[1093228166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:528; }","duration":"4.237020128s","start":"2026-04-16T06:05:39.77058Z","end":"2026-04-16T06:05:44.0076Z","steps":["trace[1093228166] 'agreement among raft nodes before linearized reading' (duration: 4.236825096s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:44.008432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:39.770574Z","time spent":"4.237783457s","remote":"127.0.0.1:33730","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-16T06:05:44.010884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.939506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a6c134d2c045cb\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-04-16T06:05:44.01442Z","caller":"traceutil/trace.go:171","msg":"trace[736535807] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18a6c134d2c045cb; range_end:; response_count:1; response_revision:534; }","duration":"219.496707ms","start":"2026-04-16T06:05:43.794898Z","end":"2026-04-16T06:05:44.014395Z","steps":["trace[736535807] 'agreement among raft nodes before linearized reading' (duration: 215.903415ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:44.011007Z","caller":"traceutil/trace.go:171","msg":"trace[1533282522] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"361.17438ms","start":"2026-04-16T06:05:43.649815Z","end":"2026-04-16T06:05:44.01099Z","steps":["trace[1533282522] 'process raft request' (duration: 360.426692ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:44.012038Z","caller":"traceutil/trace.go:171","msg":"trace[1315670870] transaction","detail":"{read_only:false; number_of_response:0; response_revision:529; }","duration":"367.060998ms","start":"2026-04-16T06:05:43.644946Z","end":"2026-04-16T06:05:44.012007Z","steps":["trace[1315670870] 'process raft request' (duration: 365.200356ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:44.012088Z","caller":"traceutil/trace.go:171","msg":"trace[1962264615] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"369.391586ms","start":"2026-04-16T06:05:43.642686Z","end":"2026-04-16T06:05:44.012078Z","steps":["trace[1962264615] 'process raft request' (duration: 367.17733ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:44.012132Z","caller":"traceutil/trace.go:171","msg":"trace[1290543652] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"349.177704ms","start":"2026-04-16T06:05:43.662946Z","end":"2026-04-16T06:05:44.012124Z","steps":["trace[1290543652] 'process raft request' (duration: 347.454424ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:44.014002Z","caller":"traceutil/trace.go:171","msg":"trace[713272162] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"360.837167ms","start":"2026-04-16T06:05:43.653132Z","end":"2026-04-16T06:05:44.013969Z","steps":["trace[713272162] 'process raft request' (duration: 357.183905ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:44.012162Z","caller":"traceutil/trace.go:171","msg":"trace[1111833817] transaction","detail":"{read_only:false; number_of_response:1; response_revision:529; }","duration":"364.150814ms","start":"2026-04-16T06:05:43.648002Z","end":"2026-04-16T06:05:44.012153Z","steps":["trace[1111833817] 'process raft request' (duration: 362.190112ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:44.014694Z","caller":"traceutil/trace.go:171","msg":"trace[1068558091] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"306.760227ms","start":"2026-04-16T06:05:43.707919Z","end":"2026-04-16T06:05:44.014679Z","steps":["trace[1068558091] 'process raft request' (duration: 302.757451ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:44.014754Z","caller":"traceutil/trace.go:171","msg":"trace[1040259369] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"321.696608ms","start":"2026-04-16T06:05:43.693037Z","end":"2026-04-16T06:05:44.014733Z","steps":["trace[1040259369] 'process raft request' (duration: 317.50983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:44.015537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.810911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:44.017376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:43.649807Z","time spent":"367.491203ms","remote":"127.0.0.1:33980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:44.017726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:43.64494Z","time spent":"372.684932ms","remote":"127.0.0.1:33980","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-16T06:05:44.017791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:43.642669Z","time spent":"375.08199ms","remote":"127.0.0.1:33730","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-16T06:05:44.019771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:43.662934Z","time spent":"356.76881ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:44.020135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:43.693007Z","time spent":"327.033019ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:44.020178Z","caller":"traceutil/trace.go:171","msg":"trace[724784584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:534; }","duration":"224.502225ms","start":"2026-04-16T06:05:43.79566Z","end":"2026-04-16T06:05:44.020163Z","steps":["trace[724784584] 'agreement among raft nodes before linearized reading' (duration: 219.657949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:44.020371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:43.653123Z","time spent":"367.20392ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:44.020506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:43.647994Z","time spent":"372.47714ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7375,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:44.020646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:43.70789Z","time spent":"312.721575ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:44.202121Z","caller":"traceutil/trace.go:171","msg":"trace[1348019107] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"117.04042ms","start":"2026-04-16T06:05:44.085051Z","end":"2026-04-16T06:05:44.202092Z","steps":["trace[1348019107] 'process raft request' (duration: 92.799452ms)","trace[1348019107] 'compare' (duration: 24.006674ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:44.20264Z","caller":"traceutil/trace.go:171","msg":"trace[2101547780] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:564; }","duration":"101.097277ms","start":"2026-04-16T06:05:44.101486Z","end":"2026-04-16T06:05:44.202583Z","steps":["trace[2101547780] 'read index received' (duration: 76.405924ms)","trace[2101547780] 'applied index is now lower than readState.Index' (duration: 24.690343ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:44.202841Z","caller":"traceutil/trace.go:171","msg":"trace[1617570954] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"111.900281ms","start":"2026-04-16T06:05:44.09091Z","end":"2026-04-16T06:05:44.20281Z","steps":["trace[1617570954] 'process raft request' (duration: 111.336394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:44.203192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.824531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a6c134d2c045cb\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-04-16T06:05:44.203404Z","caller":"traceutil/trace.go:171","msg":"trace[370214298] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18a6c134d2c045cb; range_end:; response_count:1; response_revision:544; }","duration":"120.076344ms","start":"2026-04-16T06:05:44.08331Z","end":"2026-04-16T06:05:44.203386Z","steps":["trace[370214298] 'agreement among raft nodes before linearized reading' (duration: 119.68276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:44.236904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.846213ms","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-16T06:05:44.237016Z","caller":"traceutil/trace.go:171","msg":"trace[2045358324] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:545; }","duration":"133.996524ms","start":"2026-04-16T06:05:44.102998Z","end":"2026-04-16T06:05:44.236995Z","steps":["trace[2045358324] 'agreement among raft nodes before linearized reading' (duration: 133.205095ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:50.795542Z","caller":"traceutil/trace.go:171","msg":"trace[1551050061] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"415.027508ms","start":"2026-04-16T06:05:50.380496Z","end":"2026-04-16T06:05:50.795523Z","steps":["trace[1551050061] 'read index received' (duration: 414.058477ms)","trace[1551050061] 'applied index is now lower than readState.Index' (duration: 968.041µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:50.795604Z","caller":"traceutil/trace.go:171","msg":"trace[449675749] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"419.636799ms","start":"2026-04-16T06:05:50.375952Z","end":"2026-04-16T06:05:50.795589Z","steps":["trace[449675749] 'process raft request' (duration: 418.836781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:50.79567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.115038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:50.795707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.375928Z","time spent":"419.711631ms","remote":"127.0.0.1:33548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:50.795761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.143327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:50.795791Z","caller":"traceutil/trace.go:171","msg":"trace[1205768436] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:608; }","duration":"377.208928ms","start":"2026-04-16T06:05:50.418575Z","end":"2026-04-16T06:05:50.795784Z","steps":["trace[1205768436] 'agreement among raft nodes before linearized reading' (duration: 377.164877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:50.795817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.418561Z","time spent":"377.248428ms","remote":"127.0.0.1:47294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:05:50.79587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.078743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:50.795926Z","caller":"traceutil/trace.go:171","msg":"trace[896905586] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:608; }","duration":"397.169734ms","start":"2026-04-16T06:05:50.398744Z","end":"2026-04-16T06:05:50.795914Z","steps":["trace[896905586] 'agreement among raft nodes before linearized reading' (duration: 397.073283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:50.795955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.398723Z","time spent":"397.222614ms","remote":"127.0.0.1:47284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:05:50.796011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.300375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:50.796047Z","caller":"traceutil/trace.go:171","msg":"trace[271338704] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:608; }","duration":"397.355956ms","start":"2026-04-16T06:05:50.398684Z","end":"2026-04-16T06:05:50.79604Z","steps":["trace[271338704] 'agreement among raft nodes before linearized reading' (duration: 397.298066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:50.796075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.398673Z","time spent":"397.392947ms","remote":"127.0.0.1:47284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:05:50.796059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.742549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:50.796129Z","caller":"traceutil/trace.go:171","msg":"trace[1139308836] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:608; }","duration":"396.82507ms","start":"2026-04-16T06:05:50.399285Z","end":"2026-04-16T06:05:50.79611Z","steps":["trace[1139308836] 'agreement among raft nodes before linearized reading' (duration: 396.722409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:50.79609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.013065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:50.796169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.399275Z","time spent":"396.883841ms","remote":"127.0.0.1:47274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-04-16T06:05:50.796193Z","caller":"traceutil/trace.go:171","msg":"trace[179245955] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:608; }","duration":"377.155647ms","start":"2026-04-16T06:05:50.419017Z","end":"2026-04-16T06:05:50.796172Z","steps":["trace[179245955] 'agreement among raft nodes before linearized reading' (duration: 376.943694ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:50.795722Z","caller":"traceutil/trace.go:171","msg":"trace[580843814] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:608; }","duration":"415.185349ms","start":"2026-04-16T06:05:50.380526Z","end":"2026-04-16T06:05:50.795711Z","steps":["trace[580843814] 'agreement among raft nodes before linearized reading' (duration: 415.109148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:50.796242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.41901Z","time spent":"377.221387ms","remote":"127.0.0.1:47294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:05:50.796247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.380521Z","time spent":"415.710564ms","remote":"127.0.0.1:47274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:05:50.795672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.156279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:50.796322Z","caller":"traceutil/trace.go:171","msg":"trace[1329618805] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:608; }","duration":"415.848116ms","start":"2026-04-16T06:05:50.380465Z","end":"2026-04-16T06:05:50.796313Z","steps":["trace[1329618805] 'agreement among raft nodes before linearized reading' (duration: 415.155689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:50.796366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.380446Z","time spent":"415.904798ms","remote":"127.0.0.1:47274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:05:50.795725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.722322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:50.796438Z","caller":"traceutil/trace.go:171","msg":"trace[2040231792] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:608; }","duration":"377.453712ms","start":"2026-04-16T06:05:50.418975Z","end":"2026-04-16T06:05:50.796428Z","steps":["trace[2040231792] 'agreement among raft nodes before linearized reading' (duration: 376.729263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:50.796482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.418964Z","time spent":"377.506182ms","remote":"127.0.0.1:47294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-04-16T06:05:51.157157Z","caller":"traceutil/trace.go:171","msg":"trace[239489163] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"339.902163ms","start":"2026-04-16T06:05:50.817226Z","end":"2026-04-16T06:05:51.157128Z","steps":["trace[239489163] 'process raft request' (duration: 339.749011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.157337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.817209Z","time spent":"340.034854ms","remote":"127.0.0.1:33640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:52.026454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.654809ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:05:52.026797Z","caller":"traceutil/trace.go:171","msg":"trace[2131827605] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"1.173925658s","start":"2026-04-16T06:05:50.852832Z","end":"2026-04-16T06:05:52.026757Z","steps":["trace[2131827605] 'process raft request' (duration: 884.767183ms)","trace[2131827605] 'compare' (duration: 288.530957ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:52.026978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.852815Z","time spent":"1.174064859s","remote":"127.0.0.1:33778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:52.094776Z","caller":"traceutil/trace.go:171","msg":"trace[594306556] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:631; }","duration":"307.871046ms","start":"2026-04-16T06:05:51.786881Z","end":"2026-04-16T06:05:52.094752Z","steps":["trace[594306556] 'read index received' (duration: 103.461µs)","trace[594306556] 'applied index is now lower than readState.Index' (duration: 307.766155ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:52.094952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.047037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:52.09499Z","caller":"traceutil/trace.go:171","msg":"trace[1876822921] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"308.158928ms","start":"2026-04-16T06:05:51.786822Z","end":"2026-04-16T06:05:52.094981Z","steps":["trace[1876822921] 'agreement among raft nodes before linearized reading' (duration: 308.056827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:52.095029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:51.786798Z","time spent":"308.22263ms","remote":"127.0.0.1:33456","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-16T06:05:52.201867Z","caller":"traceutil/trace.go:171","msg":"trace[260403317] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"102.317516ms","start":"2026-04-16T06:05:52.099533Z","end":"2026-04-16T06:05:52.201851Z","steps":["trace[260403317] 'process raft request' (duration: 102.215095ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:52.202179Z","caller":"traceutil/trace.go:171","msg":"trace[129630822] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"102.438728ms","start":"2026-04-16T06:05:52.099732Z","end":"2026-04-16T06:05:52.202171Z","steps":["trace[129630822] 'process raft request' (duration: 102.097174ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:52.202185Z","caller":"traceutil/trace.go:171","msg":"trace[202682335] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"101.70521ms","start":"2026-04-16T06:05:52.100449Z","end":"2026-04-16T06:05:52.202154Z","steps":["trace[202682335] 'process raft request' (duration: 101.580888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.372228Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603953589503060,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:05:53.873465Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603953589503060,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:05:54.374391Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603953589503060,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:05:54.563634Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.076005296s","expected-duration":"1s"} {"level":"info","ts":"2026-04-16T06:05:54.565765Z","caller":"traceutil/trace.go:171","msg":"trace[382132902] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:637; }","duration":"1.693776574s","start":"2026-04-16T06:05:52.871964Z","end":"2026-04-16T06:05:54.565741Z","steps":["trace[382132902] 'read index received' (duration: 1.692071524s)","trace[382132902] 'applied index is now lower than readState.Index' (duration: 1.70404ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:54.565883Z","caller":"traceutil/trace.go:171","msg":"trace[214785138] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"2.079361193s","start":"2026-04-16T06:05:52.486513Z","end":"2026-04-16T06:05:54.565874Z","steps":["trace[214785138] 'process raft request' (duration: 2.077827046s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:54.565981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.486488Z","time spent":"2.079423585s","remote":"127.0.0.1:33548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036197,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:54.566242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.19263109s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:54.566322Z","caller":"traceutil/trace.go:171","msg":"trace[1405165050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"1.192764193s","start":"2026-04-16T06:05:53.373537Z","end":"2026-04-16T06:05:54.566301Z","steps":["trace[1405165050] 'agreement among raft nodes before linearized reading' (duration: 1.192643602s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:54.566368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.373517Z","time spent":"1.192842773s","remote":"127.0.0.1:33456","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-16T06:05:54.566566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.013211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:54.566774Z","caller":"traceutil/trace.go:171","msg":"trace[748062329] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"780.275624ms","start":"2026-04-16T06:05:53.786488Z","end":"2026-04-16T06:05:54.566764Z","steps":["trace[748062329] 'agreement among raft nodes before linearized reading' (duration: 780.055472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:54.5668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.786466Z","time spent":"780.329284ms","remote":"127.0.0.1:33470","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-16T06:05:54.566804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.736127ms","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-16T06:05:54.566866Z","caller":"traceutil/trace.go:171","msg":"trace[835177232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"437.839158ms","start":"2026-04-16T06:05:54.129007Z","end":"2026-04-16T06:05:54.566847Z","steps":["trace[835177232] 'agreement among raft nodes before linearized reading' (duration: 437.495884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:54.566908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:54.128987Z","time spent":"437.911448ms","remote":"127.0.0.1:33730","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-16T06:05:54.566945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.547108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-16T06:05:54.567068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.695099969s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-16T06:05:54.567063Z","caller":"traceutil/trace.go:171","msg":"trace[1133012992] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"361.692901ms","start":"2026-04-16T06:05:54.205341Z","end":"2026-04-16T06:05:54.567034Z","steps":["trace[1133012992] 'agreement among raft nodes before linearized reading' (duration: 361.099083ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:54.567112Z","caller":"traceutil/trace.go:171","msg":"trace[62417269] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:616; }","duration":"1.6951675s","start":"2026-04-16T06:05:52.871934Z","end":"2026-04-16T06:05:54.567101Z","steps":["trace[62417269] 'agreement among raft nodes before linearized reading' (duration: 1.695044138s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:54.567136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:54.205301Z","time spent":"361.825672ms","remote":"127.0.0.1:33730","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-16T06:05:54.567147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.871919Z","time spent":"1.69522118s","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.78\" "} {"level":"warn","ts":"2026-04-16T06:05:54.567145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.981322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-16T06:05:54.567044Z","caller":"traceutil/trace.go:171","msg":"trace[562853231] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"515.184661ms","start":"2026-04-16T06:05:54.051829Z","end":"2026-04-16T06:05:54.567014Z","steps":["trace[562853231] 'process raft request' (duration: 513.834215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:54.567104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.097035ms","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-16T06:05:54.567351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:54.0518Z","time spent":"515.444524ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:54.567348Z","caller":"traceutil/trace.go:171","msg":"trace[1919215327] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"362.419359ms","start":"2026-04-16T06:05:54.204871Z","end":"2026-04-16T06:05:54.56729Z","steps":["trace[1919215327] 'agreement among raft nodes before linearized reading' (duration: 361.69749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:54.567474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:54.204843Z","time spent":"362.612971ms","remote":"127.0.0.1:33730","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-16T06:05:54.567218Z","caller":"traceutil/trace.go:171","msg":"trace[1717792775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"361.043863ms","start":"2026-04-16T06:05:54.206138Z","end":"2026-04-16T06:05:54.567182Z","steps":["trace[1717792775] 'agreement among raft nodes before linearized reading' (duration: 360.891241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:54.568063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:54.206131Z","time spent":"361.896392ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T06:05:56.499212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.715921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:56.500107Z","caller":"traceutil/trace.go:171","msg":"trace[1969403824] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"470.127628ms","start":"2026-04-16T06:05:56.029907Z","end":"2026-04-16T06:05:56.500035Z","steps":["trace[1969403824] 'process raft request' (duration: 468.961954ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:56.500266Z","caller":"traceutil/trace.go:171","msg":"trace[2112982882] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:637; }","duration":"524.580552ms","start":"2026-04-16T06:05:55.975421Z","end":"2026-04-16T06:05:56.500002Z","steps":["trace[2112982882] 'range keys from in-memory index tree' (duration: 523.61703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:56.500385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:55.975409Z","time spent":"524.942275ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T06:05:56.500381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:56.029882Z","time spent":"470.36214ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:56.520491Z","caller":"traceutil/trace.go:171","msg":"trace[1983580291] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"452.040065ms","start":"2026-04-16T06:05:56.068403Z","end":"2026-04-16T06:05:56.520443Z","steps":["trace[1983580291] 'process raft request' (duration: 451.358728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:56.520691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:56.068368Z","time spent":"452.214367ms","remote":"127.0.0.1:33548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:06:00.230461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.176021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:06:00.230576Z","caller":"traceutil/trace.go:171","msg":"trace[1492209374] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"240.535292ms","start":"2026-04-16T06:05:59.990023Z","end":"2026-04-16T06:06:00.230558Z","steps":["trace[1492209374] 'process raft request' (duration: 98.196849ms)","trace[1492209374] 'compare' (duration: 141.998909ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:00.262265Z","caller":"traceutil/trace.go:171","msg":"trace[894153480] linearizableReadLoop","detail":"{readStateIndex:736; appliedIndex:734; }","duration":"125.666276ms","start":"2026-04-16T06:06:00.136582Z","end":"2026-04-16T06:06:00.262248Z","steps":["trace[894153480] 'read index received' (duration: 125.460833ms)","trace[894153480] 'applied index is now lower than readState.Index' (duration: 204.823µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:06:00.262413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.819458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-04-16T06:06:00.262442Z","caller":"traceutil/trace.go:171","msg":"trace[913963587] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:710; }","duration":"125.885939ms","start":"2026-04-16T06:06:00.136547Z","end":"2026-04-16T06:06:00.262433Z","steps":["trace[913963587] 'agreement among raft nodes before linearized reading' (duration: 125.769288ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:00.262719Z","caller":"traceutil/trace.go:171","msg":"trace[59027674] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"215.40202ms","start":"2026-04-16T06:06:00.047309Z","end":"2026-04-16T06:06:00.262711Z","steps":["trace[59027674] 'process raft request' (duration: 214.779053ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:00.262838Z","caller":"traceutil/trace.go:171","msg":"trace[1031652475] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"214.750613ms","start":"2026-04-16T06:06:00.04808Z","end":"2026-04-16T06:06:00.262831Z","steps":["trace[1031652475] 'process raft request' (duration: 214.132496ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:00.420874Z","caller":"traceutil/trace.go:171","msg":"trace[1632139783] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"112.972134ms","start":"2026-04-16T06:06:00.307868Z","end":"2026-04-16T06:06:00.42084Z","steps":["trace[1632139783] 'process raft request' (duration: 77.129873ms)","trace[1632139783] 'compare' (duration: 35.368046ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:00.689353Z","caller":"traceutil/trace.go:171","msg":"trace[1797087270] linearizableReadLoop","detail":"{readStateIndex:739; appliedIndex:738; }","duration":"153.387916ms","start":"2026-04-16T06:06:00.535941Z","end":"2026-04-16T06:06:00.689329Z","steps":["trace[1797087270] 'read index received' (duration: 153.042472ms)","trace[1797087270] 'applied index is now lower than readState.Index' (duration: 344.324µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:00.689569Z","caller":"traceutil/trace.go:171","msg":"trace[122581203] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"179.473918ms","start":"2026-04-16T06:06:00.510073Z","end":"2026-04-16T06:06:00.689547Z","steps":["trace[122581203] 'process raft request' (duration: 179.028714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:00.689679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.67458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-04-16T06:06:00.689744Z","caller":"traceutil/trace.go:171","msg":"trace[672375764] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:713; }","duration":"153.820801ms","start":"2026-04-16T06:06:00.535905Z","end":"2026-04-16T06:06:00.689725Z","steps":["trace[672375764] 'agreement among raft nodes before linearized reading' (duration: 153.593329ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:01.330351Z","caller":"traceutil/trace.go:171","msg":"trace[606262252] linearizableReadLoop","detail":"{readStateIndex:754; appliedIndex:753; }","duration":"241.259556ms","start":"2026-04-16T06:06:01.089068Z","end":"2026-04-16T06:06:01.330327Z","steps":["trace[606262252] 'read index received' (duration: 240.682859ms)","trace[606262252] 'applied index is now lower than readState.Index' (duration: 575.547µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:01.330417Z","caller":"traceutil/trace.go:171","msg":"trace[144235316] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"284.281487ms","start":"2026-04-16T06:06:01.046116Z","end":"2026-04-16T06:06:01.330397Z","steps":["trace[144235316] 'process raft request' (duration: 283.6126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:01.33053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.428187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-04-16T06:06:01.330606Z","caller":"traceutil/trace.go:171","msg":"trace[1396378416] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:728; }","duration":"241.554ms","start":"2026-04-16T06:06:01.089035Z","end":"2026-04-16T06:06:01.330589Z","steps":["trace[1396378416] 'agreement among raft nodes before linearized reading' (duration: 241.370128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:01.330699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.610689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:833"} {"level":"warn","ts":"2026-04-16T06:06:01.330711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.135749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-04-16T06:06:01.330787Z","caller":"traceutil/trace.go:171","msg":"trace[1345071600] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:728; }","duration":"241.710171ms","start":"2026-04-16T06:06:01.089035Z","end":"2026-04-16T06:06:01.330745Z","steps":["trace[1345071600] 'agreement among raft nodes before linearized reading' (duration: 241.404968ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:01.330845Z","caller":"traceutil/trace.go:171","msg":"trace[304205722] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:728; }","duration":"194.259201ms","start":"2026-04-16T06:06:01.136543Z","end":"2026-04-16T06:06:01.330802Z","steps":["trace[304205722] 'agreement among raft nodes before linearized reading' (duration: 193.966268ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:03.739293Z","caller":"traceutil/trace.go:171","msg":"trace[148183963] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:767; }","duration":"172.038218ms","start":"2026-04-16T06:06:03.567232Z","end":"2026-04-16T06:06:03.73927Z","steps":["trace[148183963] 'read index received' (duration: 171.835536ms)","trace[148183963] 'applied index is now lower than readState.Index' (duration: 201.922µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:03.739366Z","caller":"traceutil/trace.go:171","msg":"trace[402503411] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"176.975493ms","start":"2026-04-16T06:06:03.562358Z","end":"2026-04-16T06:06:03.739333Z","steps":["trace[402503411] 'process raft request' (duration: 176.76285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.739465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.20249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.739501Z","caller":"traceutil/trace.go:171","msg":"trace[1772100070] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:740; }","duration":"172.26047ms","start":"2026-04-16T06:06:03.56723Z","end":"2026-04-16T06:06:03.73949Z","steps":["trace[1772100070] 'agreement among raft nodes before linearized reading' (duration: 172.176559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.739584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.822645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.739675Z","caller":"traceutil/trace.go:171","msg":"trace[495096210] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:740; }","duration":"171.944256ms","start":"2026-04-16T06:06:03.567712Z","end":"2026-04-16T06:06:03.739657Z","steps":["trace[495096210] 'agreement among raft nodes before linearized reading' (duration: 171.791574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.739596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.16135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.739813Z","caller":"traceutil/trace.go:171","msg":"trace[1823127522] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:740; }","duration":"172.409513ms","start":"2026-04-16T06:06:03.567384Z","end":"2026-04-16T06:06:03.739794Z","steps":["trace[1823127522] 'agreement among raft nodes before linearized reading' (duration: 172.116079ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:05.999402Z","caller":"traceutil/trace.go:171","msg":"trace[934851659] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"160.997981ms","start":"2026-04-16T06:06:05.838379Z","end":"2026-04-16T06:06:05.999377Z","steps":["trace[934851659] 'process raft request' (duration: 160.765157ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:06.215865Z","caller":"traceutil/trace.go:171","msg":"trace[2078508296] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"148.775862ms","start":"2026-04-16T06:06:06.067066Z","end":"2026-04-16T06:06:06.215842Z","steps":["trace[2078508296] 'process raft request' (duration: 148.646051ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:06.228481Z","caller":"traceutil/trace.go:171","msg":"trace[1558060238] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"157.949974ms","start":"2026-04-16T06:06:06.070517Z","end":"2026-04-16T06:06:06.228467Z","steps":["trace[1558060238] 'process raft request' (duration: 157.862223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:06.91217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.116575ms","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-16T06:06:06.912293Z","caller":"traceutil/trace.go:171","msg":"trace[2106622299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:761; }","duration":"103.261356ms","start":"2026-04-16T06:06:06.809019Z","end":"2026-04-16T06:06:06.91228Z","steps":["trace[2106622299] 'agreement among raft nodes before linearized reading' (duration: 103.027424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:06.912478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.039174ms","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-16T06:06:06.912628Z","caller":"traceutil/trace.go:171","msg":"trace[47165671] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:761; }","duration":"102.221216ms","start":"2026-04-16T06:06:06.810399Z","end":"2026-04-16T06:06:06.912621Z","steps":["trace[47165671] 'agreement among raft nodes before linearized reading' (duration: 102.017483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:06.912769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.682432ms","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-16T06:06:06.913065Z","caller":"traceutil/trace.go:171","msg":"trace[1312257831] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:761; }","duration":"103.778333ms","start":"2026-04-16T06:06:06.809048Z","end":"2026-04-16T06:06:06.912827Z","steps":["trace[1312257831] 'agreement among raft nodes before linearized reading' (duration: 103.51721ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:08.261481Z","caller":"traceutil/trace.go:171","msg":"trace[2041973592] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"334.336436ms","start":"2026-04-16T06:06:07.927104Z","end":"2026-04-16T06:06:08.26144Z","steps":["trace[2041973592] 'process raft request' (duration: 333.959852ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:08.261788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.927078Z","time spent":"334.549558ms","remote":"127.0.0.1:33640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5034,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:06:09.018665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.046757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T06:06:09.018755Z","caller":"traceutil/trace.go:171","msg":"trace[1972526164] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:775; }","duration":"100.19856ms","start":"2026-04-16T06:06:08.918536Z","end":"2026-04-16T06:06:09.018735Z","steps":["trace[1972526164] 'range keys from in-memory index tree' (duration: 99.867436ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:09.125145Z","caller":"traceutil/trace.go:171","msg":"trace[1081256954] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"100.582074ms","start":"2026-04-16T06:06:09.024534Z","end":"2026-04-16T06:06:09.125116Z","steps":["trace[1081256954] 'process raft request' (duration: 100.475652ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:09.125242Z","caller":"traceutil/trace.go:171","msg":"trace[354985408] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"101.509424ms","start":"2026-04-16T06:06:09.023704Z","end":"2026-04-16T06:06:09.125213Z","steps":["trace[354985408] 'process raft request' (duration: 101.262951ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:09.12517Z","caller":"traceutil/trace.go:171","msg":"trace[495818213] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"101.516474ms","start":"2026-04-16T06:06:09.023608Z","end":"2026-04-16T06:06:09.125124Z","steps":["trace[495818213] 'process raft request' (duration: 101.21214ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:12.54734Z","caller":"traceutil/trace.go:171","msg":"trace[906830424] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"164.87289ms","start":"2026-04-16T06:06:12.382442Z","end":"2026-04-16T06:06:12.547315Z","steps":["trace[906830424] 'process raft request' (duration: 164.685648ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:12.843526Z","caller":"traceutil/trace.go:171","msg":"trace[228316915] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"243.375456ms","start":"2026-04-16T06:06:12.600123Z","end":"2026-04-16T06:06:12.843498Z","steps":["trace[228316915] 'process raft request' (duration: 243.090303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:13.571336Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603953589503413,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:06:14.071886Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603953589503413,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:06:14.547625Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.576648922s","expected-duration":"1s"} {"level":"info","ts":"2026-04-16T06:06:14.548025Z","caller":"traceutil/trace.go:171","msg":"trace[1909821974] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:825; }","duration":"1.477169945s","start":"2026-04-16T06:06:13.070831Z","end":"2026-04-16T06:06:14.548001Z","steps":["trace[1909821974] 'read index received' (duration: 1.476963083s)","trace[1909821974] 'applied index is now lower than readState.Index' (duration: 203.692µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:14.548167Z","caller":"traceutil/trace.go:171","msg":"trace[825886855] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"1.604451569s","start":"2026-04-16T06:06:12.943585Z","end":"2026-04-16T06:06:14.548036Z","steps":["trace[825886855] 'process raft request' (duration: 1.604262487s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:14.548341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:12.943564Z","time spent":"1.604705772s","remote":"127.0.0.1:33640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:06:14.548613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.519389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:14.548706Z","caller":"traceutil/trace.go:171","msg":"trace[900025538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:795; }","duration":"763.649021ms","start":"2026-04-16T06:06:13.785044Z","end":"2026-04-16T06:06:14.548693Z","steps":["trace[900025538] 'agreement among raft nodes before linearized reading' (duration: 763.5368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:14.548769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:13.785023Z","time spent":"763.736262ms","remote":"127.0.0.1:33470","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-16T06:06:14.54883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.414349702s","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-16T06:06:14.548876Z","caller":"traceutil/trace.go:171","msg":"trace[1811768690] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:795; }","duration":"1.414450753s","start":"2026-04-16T06:06:13.134414Z","end":"2026-04-16T06:06:14.548865Z","steps":["trace[1811768690] 'agreement among raft nodes before linearized reading' (duration: 1.413684894s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:14.548846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.477975904s","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":"warn","ts":"2026-04-16T06:06:14.548919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:13.13439Z","time spent":"1.414519114s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-16T06:06:14.548938Z","caller":"traceutil/trace.go:171","msg":"trace[1699803941] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:795; }","duration":"1.478144526s","start":"2026-04-16T06:06:13.070777Z","end":"2026-04-16T06:06:14.548921Z","steps":["trace[1699803941] 'agreement among raft nodes before linearized reading' (duration: 1.477285416s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:14.549194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405527686s","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-16T06:06:14.549239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.439513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-16T06:06:14.549054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:13.070754Z","time spent":"1.478285868s","remote":"127.0.0.1:33602","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-16T06:06:14.549432Z","caller":"traceutil/trace.go:171","msg":"trace[1748991431] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:795; }","duration":"933.596825ms","start":"2026-04-16T06:06:13.615754Z","end":"2026-04-16T06:06:14.549351Z","steps":["trace[1748991431] 'agreement among raft nodes before linearized reading' (duration: 933.353122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:14.549535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176150878s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:06:14.54928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405588667s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-16T06:06:14.549627Z","caller":"traceutil/trace.go:171","msg":"trace[1580681551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:795; }","duration":"1.405988761s","start":"2026-04-16T06:06:13.143629Z","end":"2026-04-16T06:06:14.549618Z","steps":["trace[1580681551] 'agreement among raft nodes before linearized reading' (duration: 1.405533766s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:14.550689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:13.143605Z","time spent":"1.407045232s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T06:06:14.54959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:13.61569Z","time spent":"933.874318ms","remote":"127.0.0.1:33794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-04-16T06:06:14.549287Z","caller":"traceutil/trace.go:171","msg":"trace[581672689] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:795; }","duration":"1.405636367s","start":"2026-04-16T06:06:13.143629Z","end":"2026-04-16T06:06:14.549265Z","steps":["trace[581672689] 'agreement among raft nodes before linearized reading' (duration: 1.405385874s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:14.552102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:13.143617Z","time spent":"1.408471728s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T06:06:14.549393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405772528s","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-16T06:06:14.552251Z","caller":"traceutil/trace.go:171","msg":"trace[1179228246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:795; }","duration":"1.40866714s","start":"2026-04-16T06:06:13.143569Z","end":"2026-04-16T06:06:14.552236Z","steps":["trace[1179228246] 'agreement among raft nodes before linearized reading' (duration: 1.405646037s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:14.552291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:13.143548Z","time spent":"1.408727561s","remote":"127.0.0.1:33730","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":"info","ts":"2026-04-16T06:06:14.549739Z","caller":"traceutil/trace.go:171","msg":"trace[1387207001] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:795; }","duration":"1.176221218s","start":"2026-04-16T06:06:13.373342Z","end":"2026-04-16T06:06:14.549563Z","steps":["trace[1387207001] 'agreement among raft nodes before linearized reading' (duration: 1.174771522s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:14.552409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:13.373325Z","time spent":"1.17907739s","remote":"127.0.0.1:33456","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-16T06:06:18.451037Z","caller":"traceutil/trace.go:171","msg":"trace[2023309340] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"239.81955ms","start":"2026-04-16T06:06:18.211192Z","end":"2026-04-16T06:06:18.451012Z","steps":["trace[2023309340] 'process raft request' (duration: 238.156182ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:38.945962Z","caller":"traceutil/trace.go:171","msg":"trace[1428196226] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"138.510848ms","start":"2026-04-16T06:06:38.807422Z","end":"2026-04-16T06:06:38.945932Z","steps":["trace[1428196226] 'process raft request' (duration: 75.889617ms)","trace[1428196226] 'compare' (duration: 62.438898ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:38.946167Z","caller":"traceutil/trace.go:171","msg":"trace[857719465] linearizableReadLoop","detail":"{readStateIndex:1042; appliedIndex:1040; }","duration":"106.839512ms","start":"2026-04-16T06:06:38.839299Z","end":"2026-04-16T06:06:38.946138Z","steps":["trace[857719465] 'read index received' (duration: 44.230341ms)","trace[857719465] 'applied index is now lower than readState.Index' (duration: 62.606641ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:38.946257Z","caller":"traceutil/trace.go:171","msg":"trace[169527442] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"138.739451ms","start":"2026-04-16T06:06:38.807506Z","end":"2026-04-16T06:06:38.946245Z","steps":["trace[169527442] 'process raft request' (duration: 138.386486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:38.94635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.038645ms","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-16T06:06:38.946374Z","caller":"traceutil/trace.go:171","msg":"trace[51190503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1005; }","duration":"107.103436ms","start":"2026-04-16T06:06:38.839262Z","end":"2026-04-16T06:06:38.946365Z","steps":["trace[51190503] 'agreement among raft nodes before linearized reading' (duration: 106.966094ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:46.324761Z","caller":"traceutil/trace.go:171","msg":"trace[1651471222] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"124.162913ms","start":"2026-04-16T06:06:46.20057Z","end":"2026-04-16T06:06:46.324732Z","steps":["trace[1651471222] 'process raft request' (duration: 123.945173ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:47.147207Z","caller":"traceutil/trace.go:171","msg":"trace[1855722887] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"108.26506ms","start":"2026-04-16T06:06:47.038918Z","end":"2026-04-16T06:06:47.147183Z","steps":["trace[1855722887] 'process raft request' (duration: 108.079142ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:47.461182Z","caller":"traceutil/trace.go:171","msg":"trace[2077195268] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"422.027267ms","start":"2026-04-16T06:06:47.039132Z","end":"2026-04-16T06:06:47.461159Z","steps":["trace[2077195268] 'process raft request' (duration: 421.840289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:47.46132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:47.039112Z","time spent":"422.143293ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:06:47.46144Z","caller":"traceutil/trace.go:171","msg":"trace[44688668] linearizableReadLoop","detail":"{readStateIndex:1071; appliedIndex:1068; }","duration":"365.020727ms","start":"2026-04-16T06:06:47.096399Z","end":"2026-04-16T06:06:47.461419Z","steps":["trace[44688668] 'read index received' (duration: 50.600831ms)","trace[44688668] 'applied index is now lower than readState.Index' (duration: 314.418486ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:47.461526Z","caller":"traceutil/trace.go:171","msg":"trace[196383783] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"421.783296ms","start":"2026-04-16T06:06:47.039721Z","end":"2026-04-16T06:06:47.461505Z","steps":["trace[196383783] 'process raft request' (duration: 421.403129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:47.461606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:47.039714Z","time spent":"421.85413ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:06:47.461762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.33108ms","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-16T06:06:47.461853Z","caller":"traceutil/trace.go:171","msg":"trace[1327930051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1033; }","duration":"365.473026ms","start":"2026-04-16T06:06:47.096361Z","end":"2026-04-16T06:06:47.461834Z","steps":["trace[1327930051] 'agreement among raft nodes before linearized reading' (duration: 365.173833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:47.461913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:47.096346Z","time spent":"365.54239ms","remote":"127.0.0.1:33730","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":"info","ts":"2026-04-16T06:06:57.659822Z","caller":"traceutil/trace.go:171","msg":"trace[325409872] linearizableReadLoop","detail":"{readStateIndex:1111; appliedIndex:1109; }","duration":"130.292893ms","start":"2026-04-16T06:06:57.529512Z","end":"2026-04-16T06:06:57.659805Z","steps":["trace[325409872] 'read index received' (duration: 6.789661ms)","trace[325409872] 'applied index is now lower than readState.Index' (duration: 123.502092ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:06:57.659981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.45996ms","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-16T06:06:57.660008Z","caller":"traceutil/trace.go:171","msg":"trace[281503174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1070; }","duration":"130.526453ms","start":"2026-04-16T06:06:57.529474Z","end":"2026-04-16T06:06:57.66Z","steps":["trace[281503174] 'agreement among raft nodes before linearized reading' (duration: 130.398707ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:57.659976Z","caller":"traceutil/trace.go:171","msg":"trace[1708929134] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"142.762879ms","start":"2026-04-16T06:06:57.517161Z","end":"2026-04-16T06:06:57.659923Z","steps":["trace[1708929134] 'process raft request' (duration: 130.838734ms)","trace[1708929134] 'compare' (duration: 11.729717ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:59.732486Z","caller":"traceutil/trace.go:171","msg":"trace[1005469402] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"186.63759ms","start":"2026-04-16T06:06:59.545823Z","end":"2026-04-16T06:06:59.732461Z","steps":["trace[1005469402] 'process raft request' (duration: 186.206761ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:30.132952Z","caller":"traceutil/trace.go:171","msg":"trace[85992897] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"209.934824ms","start":"2026-04-16T06:07:29.922976Z","end":"2026-04-16T06:07:30.132911Z","steps":["trace[85992897] 'process raft request' (duration: 149.638469ms)","trace[85992897] 'compare' (duration: 60.1661ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:31.639718Z","caller":"traceutil/trace.go:171","msg":"trace[72218550] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"179.905662ms","start":"2026-04-16T06:07:31.45979Z","end":"2026-04-16T06:07:31.639695Z","steps":["trace[72218550] 'process raft request' (duration: 179.791038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:33.040794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.768118ms","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-16T06:07:33.040872Z","caller":"traceutil/trace.go:171","msg":"trace[1814779219] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1185; }","duration":"103.900772ms","start":"2026-04-16T06:07:32.936956Z","end":"2026-04-16T06:07:33.040857Z","steps":["trace[1814779219] 'range keys from in-memory index tree' (duration: 103.603653ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:33.438106Z","caller":"traceutil/trace.go:171","msg":"trace[1921053965] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"181.711486ms","start":"2026-04-16T06:07:33.256368Z","end":"2026-04-16T06:07:33.438079Z","steps":["trace[1921053965] 'process raft request' (duration: 181.224649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:40.380373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.750545ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:07:40.380503Z","caller":"traceutil/trace.go:171","msg":"trace[945957704] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1208; }","duration":"139.89556ms","start":"2026-04-16T06:07:40.240592Z","end":"2026-04-16T06:07:40.380488Z","steps":["trace[945957704] 'range keys from in-memory index tree' (duration: 139.734664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:40.380734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.697096ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:07:40.38082Z","caller":"traceutil/trace.go:171","msg":"trace[379166384] linearizableReadLoop","detail":"{readStateIndex:1259; appliedIndex:1258; }","duration":"123.175397ms","start":"2026-04-16T06:07:40.257633Z","end":"2026-04-16T06:07:40.380808Z","steps":["trace[379166384] 'read index received' (duration: 67.203µs)","trace[379166384] 'applied index is now lower than readState.Index' (duration: 123.107094ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:40.381027Z","caller":"traceutil/trace.go:171","msg":"trace[506320805] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"350.8501ms","start":"2026-04-16T06:07:40.030045Z","end":"2026-04-16T06:07:40.380895Z","steps":["trace[506320805] 'process raft request' (duration: 127.926646ms)","trace[506320805] 'compare' (duration: 222.576663ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:07:40.381133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.498419ms","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-16T06:07:40.381186Z","caller":"traceutil/trace.go:171","msg":"trace[59862003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1209; }","duration":"123.587331ms","start":"2026-04-16T06:07:40.257588Z","end":"2026-04-16T06:07:40.381175Z","steps":["trace[59862003] 'agreement among raft nodes before linearized reading' (duration: 123.258319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:40.381359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:07:40.030022Z","time spent":"351.09636ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:07:40.630744Z","caller":"traceutil/trace.go:171","msg":"trace[284913935] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"280.14322ms","start":"2026-04-16T06:07:40.350564Z","end":"2026-04-16T06:07:40.630708Z","steps":["trace[284913935] 'process raft request' (duration: 198.507663ms)","trace[284913935] 'compare' (duration: 80.941513ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:40.631123Z","caller":"traceutil/trace.go:171","msg":"trace[1165457025] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"245.630249ms","start":"2026-04-16T06:07:40.385102Z","end":"2026-04-16T06:07:40.630732Z","steps":["trace[1165457025] 'process raft request' (duration: 245.027148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:41.155976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.500941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:07:41.156084Z","caller":"traceutil/trace.go:171","msg":"trace[1613812702] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1211; }","duration":"376.655926ms","start":"2026-04-16T06:07:40.7794Z","end":"2026-04-16T06:07:41.156056Z","steps":["trace[1613812702] 'count revisions from in-memory index tree' (duration: 376.417998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:41.156139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:07:40.779381Z","time spent":"376.743719ms","remote":"127.0.0.1:47208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:07:41.156479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.938293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:07:41.156558Z","caller":"traceutil/trace.go:171","msg":"trace[615455149] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1211; }","duration":"371.045567ms","start":"2026-04-16T06:07:40.785494Z","end":"2026-04-16T06:07:41.15654Z","steps":["trace[615455149] 'range keys from in-memory index tree' (duration: 370.82318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:41.156603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:07:40.785485Z","time spent":"371.109869ms","remote":"127.0.0.1:33456","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-16T06:07:54.709199Z","caller":"traceutil/trace.go:171","msg":"trace[1762687659] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"183.595238ms","start":"2026-04-16T06:07:54.52558Z","end":"2026-04-16T06:07:54.709175Z","steps":["trace[1762687659] 'process raft request' (duration: 183.453134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:55.211822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.989839ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:07:55.211925Z","caller":"traceutil/trace.go:171","msg":"trace[1396590937] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1326; }","duration":"502.76649ms","start":"2026-04-16T06:07:54.709141Z","end":"2026-04-16T06:07:55.211908Z","steps":["trace[1396590937] 'read index received' (duration: 181.524454ms)","trace[1396590937] 'applied index is now lower than readState.Index' (duration: 321.240516ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:55.212003Z","caller":"traceutil/trace.go:171","msg":"trace[40332338] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"539.170072ms","start":"2026-04-16T06:07:54.672811Z","end":"2026-04-16T06:07:55.211981Z","steps":["trace[40332338] 'process raft request' (duration: 217.942056ms)","trace[40332338] 'compare' (duration: 320.75538ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:07:55.212084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:07:54.67279Z","time spent":"539.253505ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:07:55.212125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.850537ms","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-16T06:07:55.212151Z","caller":"traceutil/trace.go:171","msg":"trace[763193432] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1273; }","duration":"535.899949ms","start":"2026-04-16T06:07:54.676243Z","end":"2026-04-16T06:07:55.212143Z","steps":["trace[763193432] 'agreement among raft nodes before linearized reading' (duration: 535.755674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:55.212179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:07:54.676232Z","time spent":"535.94056ms","remote":"127.0.0.1:33730","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-16T06:07:55.212344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.710894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-b623d42a-765b-4c02-8514-dadd8908ab77\" ","response":"range_response_count:1 size:2243"} {"level":"info","ts":"2026-04-16T06:07:55.212379Z","caller":"traceutil/trace.go:171","msg":"trace[539740746] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-b623d42a-765b-4c02-8514-dadd8908ab77; range_end:; response_count:1; response_revision:1273; }","duration":"469.778936ms","start":"2026-04-16T06:07:54.742588Z","end":"2026-04-16T06:07:55.212367Z","steps":["trace[539740746] 'agreement among raft nodes before linearized reading' (duration: 469.659352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:55.212374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.688383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:07:55.212413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:07:54.742571Z","time spent":"469.833798ms","remote":"127.0.0.1:59314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":1,"response size":2266,"request content":"key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-b623d42a-765b-4c02-8514-dadd8908ab77\" "} {"level":"info","ts":"2026-04-16T06:07:55.212441Z","caller":"traceutil/trace.go:171","msg":"trace[199139333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1273; }","duration":"426.803027ms","start":"2026-04-16T06:07:54.785621Z","end":"2026-04-16T06:07:55.212424Z","steps":["trace[199139333] 'agreement among raft nodes before linearized reading' (duration: 426.661202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:55.212489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:07:54.785599Z","time spent":"426.881729ms","remote":"127.0.0.1:33456","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-16T06:07:55.325631Z","caller":"traceutil/trace.go:171","msg":"trace[1794721200] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1274; }","duration":"109.754948ms","start":"2026-04-16T06:07:55.215858Z","end":"2026-04-16T06:07:55.325613Z","steps":["trace[1794721200] 'process raft request' (duration: 109.17746ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:55.328569Z","caller":"traceutil/trace.go:171","msg":"trace[73948028] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"111.387859ms","start":"2026-04-16T06:07:55.217171Z","end":"2026-04-16T06:07:55.328559Z","steps":["trace[73948028] 'process raft request' (duration: 111.10212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:58.352099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.200788ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T06:07:58.352184Z","caller":"traceutil/trace.go:171","msg":"trace[1888127360] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1353; }","duration":"207.086431ms","start":"2026-04-16T06:07:58.145082Z","end":"2026-04-16T06:07:58.352168Z","steps":["trace[1888127360] 'read index received' (duration: 14.840511ms)","trace[1888127360] 'applied index is now lower than readState.Index' (duration: 192.24474ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:07:58.352311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.227965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-16T06:07:58.352345Z","caller":"traceutil/trace.go:171","msg":"trace[1352497811] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1298; }","duration":"207.306738ms","start":"2026-04-16T06:07:58.145028Z","end":"2026-04-16T06:07:58.352335Z","steps":["trace[1352497811] 'agreement among raft nodes before linearized reading' (duration: 207.176314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:59.581375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.234355ms","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-16T06:07:59.581525Z","caller":"traceutil/trace.go:171","msg":"trace[516252364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1301; }","duration":"236.431782ms","start":"2026-04-16T06:07:59.345067Z","end":"2026-04-16T06:07:59.581499Z","steps":["trace[516252364] 'range keys from in-memory index tree' (duration: 236.022889ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:00.653924Z","caller":"traceutil/trace.go:171","msg":"trace[429349919] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1360; }","duration":"233.051047ms","start":"2026-04-16T06:08:00.420852Z","end":"2026-04-16T06:08:00.653903Z","steps":["trace[429349919] 'read index received' (duration: 232.931453ms)","trace[429349919] 'applied index is now lower than readState.Index' (duration: 118.634µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:08:00.654181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.312776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-16T06:08:00.65425Z","caller":"traceutil/trace.go:171","msg":"trace[1439875249] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1305; }","duration":"233.428449ms","start":"2026-04-16T06:08:00.420803Z","end":"2026-04-16T06:08:00.654232Z","steps":["trace[1439875249] 'agreement among raft nodes before linearized reading' (duration: 233.207382ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:00.654193Z","caller":"traceutil/trace.go:171","msg":"trace[1433540705] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"677.673063ms","start":"2026-04-16T06:07:59.976304Z","end":"2026-04-16T06:08:00.653977Z","steps":["trace[1433540705] 'process raft request' (duration: 677.450056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:00.654451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:07:59.976278Z","time spent":"678.084526ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:08:00.841586Z","caller":"traceutil/trace.go:171","msg":"trace[1644035410] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"183.811978ms","start":"2026-04-16T06:08:00.657747Z","end":"2026-04-16T06:08:00.841559Z","steps":["trace[1644035410] 'process raft request' (duration: 176.144882ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:01.789441Z","caller":"traceutil/trace.go:171","msg":"trace[129485424] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1364; }","duration":"182.384792ms","start":"2026-04-16T06:08:01.607037Z","end":"2026-04-16T06:08:01.789422Z","steps":["trace[129485424] 'read index received' (duration: 182.295409ms)","trace[129485424] 'applied index is now lower than readState.Index' (duration: 88.563µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:01.789529Z","caller":"traceutil/trace.go:171","msg":"trace[1851622012] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"189.83878ms","start":"2026-04-16T06:08:01.599676Z","end":"2026-04-16T06:08:01.789515Z","steps":["trace[1851622012] 'process raft request' (duration: 189.617403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:01.789612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.568457ms","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-16T06:08:01.789646Z","caller":"traceutil/trace.go:171","msg":"trace[566645286] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1309; }","duration":"182.65859ms","start":"2026-04-16T06:08:01.606978Z","end":"2026-04-16T06:08:01.789637Z","steps":["trace[566645286] 'agreement among raft nodes before linearized reading' (duration: 182.514535ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:02.985922Z","caller":"traceutil/trace.go:171","msg":"trace[711212357] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1367; }","duration":"107.921811ms","start":"2026-04-16T06:08:02.877974Z","end":"2026-04-16T06:08:02.985896Z","steps":["trace[711212357] 'read index received' (duration: 107.746985ms)","trace[711212357] 'applied index is now lower than readState.Index' (duration: 173.366µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:02.985965Z","caller":"traceutil/trace.go:171","msg":"trace[725933689] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"136.634398ms","start":"2026-04-16T06:08:02.84931Z","end":"2026-04-16T06:08:02.985945Z","steps":["trace[725933689] 'process raft request' (duration: 136.396161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:02.986325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.332764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-16T06:08:02.98641Z","caller":"traceutil/trace.go:171","msg":"trace[1781730563] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:1312; }","duration":"108.469738ms","start":"2026-04-16T06:08:02.877921Z","end":"2026-04-16T06:08:02.986391Z","steps":["trace[1781730563] 'agreement among raft nodes before linearized reading' (duration: 108.082856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:03.185518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.268609ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-16T06:08:03.186021Z","caller":"traceutil/trace.go:171","msg":"trace[309962015] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"194.575426ms","start":"2026-04-16T06:08:02.991421Z","end":"2026-04-16T06:08:03.185996Z","steps":["trace[309962015] 'process raft request' (duration: 194.209615ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:03.514379Z","caller":"traceutil/trace.go:171","msg":"trace[90575161] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"202.2763ms","start":"2026-04-16T06:08:03.312016Z","end":"2026-04-16T06:08:03.514292Z","steps":["trace[90575161] 'process raft request' (duration: 202.139495ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:07.732444Z","caller":"traceutil/trace.go:171","msg":"trace[1335060750] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"207.125694ms","start":"2026-04-16T06:08:07.525287Z","end":"2026-04-16T06:08:07.732413Z","steps":["trace[1335060750] 'process raft request' (duration: 190.64744ms)","trace[1335060750] 'compare' (duration: 16.200296ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:08.128601Z","caller":"traceutil/trace.go:171","msg":"trace[1995451215] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"185.531162ms","start":"2026-04-16T06:08:07.943043Z","end":"2026-04-16T06:08:08.128574Z","steps":["trace[1995451215] 'process raft request' (duration: 97.395293ms)","trace[1995451215] 'compare' (duration: 88.016085ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:08:08.439467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.891526ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T06:08:08.875118Z","caller":"traceutil/trace.go:171","msg":"trace[424663988] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"162.428025ms","start":"2026-04-16T06:08:08.71266Z","end":"2026-04-16T06:08:08.875088Z","steps":["trace[424663988] 'process raft request' (duration: 162.246449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:09.429347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.747663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-16T06:08:09.429438Z","caller":"traceutil/trace.go:171","msg":"trace[1591880312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1337; }","duration":"203.884467ms","start":"2026-04-16T06:08:09.225535Z","end":"2026-04-16T06:08:09.429419Z","steps":["trace[1591880312] 'range keys from in-memory index tree' (duration: 203.590808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:09.429697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.798581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T06:08:09.430029Z","caller":"traceutil/trace.go:171","msg":"trace[1220877318] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1337; }","duration":"420.180562ms","start":"2026-04-16T06:08:09.009824Z","end":"2026-04-16T06:08:09.430005Z","steps":["trace[1220877318] 'range keys from in-memory index tree' (duration: 419.599526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:09.430107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:09.009794Z","time spent":"420.296236ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-16T06:08:09.553299Z","caller":"traceutil/trace.go:171","msg":"trace[1270066508] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"118.389967ms","start":"2026-04-16T06:08:09.434882Z","end":"2026-04-16T06:08:09.553272Z","steps":["trace[1270066508] 'process raft request' (duration: 118.215652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:09.815257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.255158ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:08:09.815577Z","caller":"traceutil/trace.go:171","msg":"trace[448694168] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"380.03418ms","start":"2026-04-16T06:08:09.435509Z","end":"2026-04-16T06:08:09.815543Z","steps":["trace[448694168] 'process raft request' (duration: 247.40141ms)","trace[448694168] 'compare' (duration: 132.111294ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:09.815668Z","caller":"traceutil/trace.go:171","msg":"trace[27364404] linearizableReadLoop","detail":"{readStateIndex:1397; appliedIndex:1396; }","duration":"322.993565ms","start":"2026-04-16T06:08:09.49265Z","end":"2026-04-16T06:08:09.815644Z","steps":["trace[27364404] 'read index received' (duration: 60.631921ms)","trace[27364404] 'applied index is now lower than readState.Index' (duration: 262.358464ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:08:09.815737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:09.43549Z","time spent":"380.161544ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:08:09.815931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.231663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:08:09.816101Z","caller":"traceutil/trace.go:171","msg":"trace[862317853] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1341; }","duration":"323.46136ms","start":"2026-04-16T06:08:09.492608Z","end":"2026-04-16T06:08:09.816069Z","steps":["trace[862317853] 'agreement among raft nodes before linearized reading' (duration: 323.13858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:09.816166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:09.49259Z","time spent":"323.562742ms","remote":"127.0.0.1:33866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-04-16T06:08:09.816226Z","caller":"traceutil/trace.go:171","msg":"trace[929107193] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"146.686219ms","start":"2026-04-16T06:08:09.669506Z","end":"2026-04-16T06:08:09.816192Z","steps":["trace[929107193] 'process raft request' (duration: 145.979408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:10.233778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.213224ms","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-16T06:08:10.233862Z","caller":"traceutil/trace.go:171","msg":"trace[43451334] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1342; }","duration":"101.347107ms","start":"2026-04-16T06:08:10.132497Z","end":"2026-04-16T06:08:10.233844Z","steps":["trace[43451334] 'range keys from in-memory index tree' (duration: 101.044779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:27.656622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.65561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:08:27.656685Z","caller":"traceutil/trace.go:171","msg":"trace[1750696613] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1401; }","duration":"372.768553ms","start":"2026-04-16T06:08:27.283904Z","end":"2026-04-16T06:08:27.656673Z","steps":["trace[1750696613] 'count revisions from in-memory index tree' (duration: 372.581789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:27.656713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:27.283886Z","time spent":"372.820415ms","remote":"127.0.0.1:33698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:08:27.656761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.69781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:root-ca-cert-publisher\" ","response":"range_response_count:1 size:763"} {"level":"info","ts":"2026-04-16T06:08:27.656825Z","caller":"traceutil/trace.go:171","msg":"trace[1680499437] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:root-ca-cert-publisher; range_end:; response_count:1; response_revision:1401; }","duration":"450.834043ms","start":"2026-04-16T06:08:27.205971Z","end":"2026-04-16T06:08:27.656805Z","steps":["trace[1680499437] 'range keys from in-memory index tree' (duration: 450.467073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:27.656856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.743535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:route-controller\" ","response":"range_response_count:1 size:739"} {"level":"warn","ts":"2026-04-16T06:08:27.656906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:27.205901Z","time spent":"450.971827ms","remote":"127.0.0.1:33818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":786,"request content":"key:\"/registry/clusterrolebindings/system:controller:root-ca-cert-publisher\" "} {"level":"info","ts":"2026-04-16T06:08:27.656931Z","caller":"traceutil/trace.go:171","msg":"trace[539798044] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:route-controller; range_end:; response_count:1; response_revision:1401; }","duration":"379.856018ms","start":"2026-04-16T06:08:27.277057Z","end":"2026-04-16T06:08:27.656913Z","steps":["trace[539798044] 'range keys from in-memory index tree' (duration: 379.653393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:27.657033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:27.277034Z","time spent":"379.981872ms","remote":"127.0.0.1:33818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":762,"request content":"key:\"/registry/clusterrolebindings/system:controller:route-controller\" "} {"level":"info","ts":"2026-04-16T06:08:27.657456Z","caller":"traceutil/trace.go:171","msg":"trace[588561755] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"180.950097ms","start":"2026-04-16T06:08:27.476492Z","end":"2026-04-16T06:08:27.657442Z","steps":["trace[588561755] 'process raft request' (duration: 155.633756ms)","trace[588561755] 'compare' (duration: 24.176419ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:08:30.233204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.631358ms","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-16T06:08:30.233274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.619221ms","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-16T06:08:30.23334Z","caller":"traceutil/trace.go:171","msg":"trace[1003895906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1410; }","duration":"104.726554ms","start":"2026-04-16T06:08:30.128599Z","end":"2026-04-16T06:08:30.233325Z","steps":["trace[1003895906] 'range keys from in-memory index tree' (duration: 104.391265ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:30.233332Z","caller":"traceutil/trace.go:171","msg":"trace[907992151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1410; }","duration":"196.801363ms","start":"2026-04-16T06:08:30.036501Z","end":"2026-04-16T06:08:30.233303Z","steps":["trace[907992151] 'range keys from in-memory index tree' (duration: 196.404712ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:30.473796Z","caller":"traceutil/trace.go:171","msg":"trace[1540210196] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"279.604738ms","start":"2026-04-16T06:08:30.194164Z","end":"2026-04-16T06:08:30.473769Z","steps":["trace[1540210196] 'process raft request' (duration: 279.443333ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:30.479357Z","caller":"traceutil/trace.go:171","msg":"trace[429211944] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"240.843168ms","start":"2026-04-16T06:08:30.238453Z","end":"2026-04-16T06:08:30.479296Z","steps":["trace[429211944] 'process raft request' (duration: 240.469028ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:30.479423Z","caller":"traceutil/trace.go:171","msg":"trace[127071690] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"240.90298ms","start":"2026-04-16T06:08:30.238498Z","end":"2026-04-16T06:08:30.479401Z","steps":["trace[127071690] 'process raft request' (duration: 240.613282ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:38.907567Z","caller":"traceutil/trace.go:171","msg":"trace[1180955369] linearizableReadLoop","detail":"{readStateIndex:1504; appliedIndex:1502; }","duration":"342.373401ms","start":"2026-04-16T06:08:38.56517Z","end":"2026-04-16T06:08:38.907543Z","steps":["trace[1180955369] 'read index received' (duration: 342.146015ms)","trace[1180955369] 'applied index is now lower than readState.Index' (duration: 226.216µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:38.907928Z","caller":"traceutil/trace.go:171","msg":"trace[812363273] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"390.420398ms","start":"2026-04-16T06:08:38.517476Z","end":"2026-04-16T06:08:38.907896Z","steps":["trace[812363273] 'process raft request' (duration: 390.030876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:38.90799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.839376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system::leader-locking-kube-scheduler\" ","response":"range_response_count:1 size:661"} {"level":"info","ts":"2026-04-16T06:08:38.908037Z","caller":"traceutil/trace.go:171","msg":"trace[1588632988] range","detail":"{range_begin:/registry/roles/kube-system/system::leader-locking-kube-scheduler; range_end:; response_count:1; response_revision:1440; }","duration":"324.937519ms","start":"2026-04-16T06:08:38.583086Z","end":"2026-04-16T06:08:38.908023Z","steps":["trace[1588632988] 'agreement among raft nodes before linearized reading' (duration: 324.823336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:38.908047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.027131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:08:38.907847Z","caller":"traceutil/trace.go:171","msg":"trace[1197496081] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"390.632293ms","start":"2026-04-16T06:08:38.517179Z","end":"2026-04-16T06:08:38.907812Z","steps":["trace[1197496081] 'process raft request' (duration: 390.195851ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:38.908138Z","caller":"traceutil/trace.go:171","msg":"trace[803813228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1440; }","duration":"122.165524ms","start":"2026-04-16T06:08:38.785953Z","end":"2026-04-16T06:08:38.908118Z","steps":["trace[803813228] 'agreement among raft nodes before linearized reading' (duration: 122.00613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:38.908182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:38.517169Z","time spent":"390.960533ms","remote":"127.0.0.1:33730","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-16T06:08:38.908077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:38.583062Z","time spent":"325.00667ms","remote":"127.0.0.1:33778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":684,"request content":"key:\"/registry/roles/kube-system/system::leader-locking-kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T06:08:38.908297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.805864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system::leader-locking-kube-controller-manager\" ","response":"range_response_count:1 size:688"} {"level":"info","ts":"2026-04-16T06:08:38.908463Z","caller":"traceutil/trace.go:171","msg":"trace[1993820048] range","detail":"{range_begin:/registry/roles/kube-system/system::leader-locking-kube-controller-manager; range_end:; response_count:1; response_revision:1440; }","duration":"343.241495ms","start":"2026-04-16T06:08:38.56514Z","end":"2026-04-16T06:08:38.908381Z","steps":["trace[1993820048] 'agreement among raft nodes before linearized reading' (duration: 342.742892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:38.908541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:38.565124Z","time spent":"343.404579ms","remote":"127.0.0.1:33778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":711,"request content":"key:\"/registry/roles/kube-system/system::leader-locking-kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T06:08:38.908831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:38.51747Z","time spent":"390.531781ms","remote":"127.0.0.1:33730","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-16T06:08:45.93564Z","caller":"traceutil/trace.go:171","msg":"trace[610818505] transaction","detail":"{read_only:false; response_revision:1462; number_of_response:1; }","duration":"103.630964ms","start":"2026-04-16T06:08:45.831984Z","end":"2026-04-16T06:08:45.935615Z","steps":["trace[610818505] 'process raft request' (duration: 103.515711ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:46.13157Z","caller":"traceutil/trace.go:171","msg":"trace[157698178] transaction","detail":"{read_only:false; response_revision:1463; number_of_response:1; }","duration":"119.181645ms","start":"2026-04-16T06:08:46.012359Z","end":"2026-04-16T06:08:46.131541Z","steps":["trace[157698178] 'process raft request' (duration: 119.039131ms)"],"step_count":1}