{"level":"warn","ts":"2026-06-05T04:24:55.217561Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T04:24:55.217634Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216: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.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216: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-06-05T04:24:55.217695Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T04:24:55.217712Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-06-05T04:24:55.21773Z","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-06-05T04:24:55.218458Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-06-05T04:24:55.218606Z","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.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216: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-06-05T04:24:55.223402Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.75152ms"} {"level":"info","ts":"2026-06-05T04:24:55.235205Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-06-05T04:24:55.235299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-06-05T04:24:55.235328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-06-05T04:24:55.235345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-05T04:24:55.235354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-06-05T04:24:55.235399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-06-05T04:24:55.248088Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-05T04:24:55.25195Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-05T04:24:55.25308Z","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-06-05T04:24:55.256842Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-05T04:24:55.25945Z","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-06-05T04:24:55.25954Z","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-06-05T04:24:55.259549Z","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-06-05T04:24:55.259652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-06-05T04:24:55.259854Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-06-05T04:24:55.257033Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-05T04:24:55.263102Z","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-06-05T04:24:55.263349Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-05T04:24:55.263383Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-05T04:24:55.263462Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-06-05T04:24:55.263476Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-06-05T04:24:55.335995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-06-05T04:24:55.336062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-06-05T04:24:55.336094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-06-05T04:24:55.336114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-06-05T04:24:55.336125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-06-05T04:24:55.336304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-06-05T04:24:55.336318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-06-05T04:24:55.337264Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:24:55.337975Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-06-05T04:24:55.338195Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T04:24:55.338247Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T04:24:55.338354Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-05T04:24:55.338461Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-05T04:24:55.338555Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:24:55.338679Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:24:55.338719Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T04:24:55.341257Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-05T04:24:55.343631Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"warn","ts":"2026-06-05T04:24:59.441648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.749716ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:24:59.441793Z","caller":"traceutil/trace.go:171","msg":"trace[1135787941] linearizableReadLoop","detail":"{readStateIndex:198; appliedIndex:197; }","duration":"911.875376ms","start":"2026-06-05T04:24:58.529901Z","end":"2026-06-05T04:24:59.441777Z","steps":["trace[1135787941] 'read index received' (duration: 208.540407ms)","trace[1135787941] 'applied index is now lower than readState.Index' (duration: 703.333739ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:24:59.441844Z","caller":"traceutil/trace.go:171","msg":"trace[427041625] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"1.022686206s","start":"2026-06-05T04:24:58.419114Z","end":"2026-06-05T04:24:59.4418Z","steps":["trace[427041625] 'process raft request' (duration: 319.286815ms)","trace[427041625] 'compare' (duration: 702.594162ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:24:59.441944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.895996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:24:59.441975Z","caller":"traceutil/trace.go:171","msg":"trace[1317064119] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:194; }","duration":"567.970688ms","start":"2026-06-05T04:24:58.873994Z","end":"2026-06-05T04:24:59.441965Z","steps":["trace[1317064119] 'agreement among raft nodes before linearized reading' (duration: 567.873535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:24:59.442002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.073051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:24:59.442059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:24:58.419103Z","time spent":"1.022861691s","remote":"127.0.0.1:35088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":726,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:24:59.442087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.851925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:24:59.44211Z","caller":"traceutil/trace.go:171","msg":"trace[1162824726] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:194; }","duration":"912.237975ms","start":"2026-06-05T04:24:58.529848Z","end":"2026-06-05T04:24:59.442086Z","steps":["trace[1162824726] 'agreement among raft nodes before linearized reading' (duration: 911.998299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:24:59.442074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.038064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-05T04:24:59.442114Z","caller":"traceutil/trace.go:171","msg":"trace[1329642525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:194; }","duration":"511.907857ms","start":"2026-06-05T04:24:58.930198Z","end":"2026-06-05T04:24:59.442106Z","steps":["trace[1329642525] 'agreement among raft nodes before linearized reading' (duration: 511.866576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:24:59.442163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:24:58.529827Z","time spent":"912.327837ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-06-05T04:24:59.44217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:24:58.930179Z","time spent":"511.980268ms","remote":"127.0.0.1:34812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:24:59.44219Z","caller":"traceutil/trace.go:171","msg":"trace[1291944659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:194; }","duration":"491.171756ms","start":"2026-06-05T04:24:58.950985Z","end":"2026-06-05T04:24:59.442157Z","steps":["trace[1291944659] 'agreement among raft nodes before linearized reading' (duration: 490.958451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:24:59.44224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:24:58.950975Z","time spent":"491.254008ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T04:24:59.442018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:24:58.873973Z","time spent":"568.03529ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T04:24:59.443527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.378166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-05T04:24:59.44366Z","caller":"traceutil/trace.go:171","msg":"trace[1485203940] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:194; }","duration":"492.55204ms","start":"2026-06-05T04:24:58.951088Z","end":"2026-06-05T04:24:59.44364Z","steps":["trace[1485203940] 'agreement among raft nodes before linearized reading' (duration: 492.375326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:24:59.443752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:24:58.951068Z","time spent":"492.670893ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-05T04:24:59.792211Z","caller":"traceutil/trace.go:171","msg":"trace[1812042279] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"344.555184ms","start":"2026-06-05T04:24:59.447619Z","end":"2026-06-05T04:24:59.792175Z","steps":["trace[1812042279] 'process raft request' (duration: 259.277439ms)","trace[1812042279] 'compare' (duration: 85.09818ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:24:59.792307Z","caller":"traceutil/trace.go:171","msg":"trace[1196843994] linearizableReadLoop","detail":"{readStateIndex:199; appliedIndex:198; }","duration":"344.153274ms","start":"2026-06-05T04:24:59.448125Z","end":"2026-06-05T04:24:59.792279Z","steps":["trace[1196843994] 'read index received' (duration: 258.89267ms)","trace[1196843994] 'applied index is now lower than readState.Index' (duration: 85.257324ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:24:59.792514Z","caller":"traceutil/trace.go:171","msg":"trace[1009866954] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"343.293253ms","start":"2026-06-05T04:24:59.449192Z","end":"2026-06-05T04:24:59.792486Z","steps":["trace[1009866954] 'process raft request' (duration: 343.009706ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:24:59.792601Z","caller":"traceutil/trace.go:171","msg":"trace[210787371] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"344.244577ms","start":"2026-06-05T04:24:59.448319Z","end":"2026-06-05T04:24:59.792564Z","steps":["trace[210787371] 'process raft request' (duration: 343.824737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:24:59.79276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:24:59.448307Z","time spent":"344.37898ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T04:24:59.792608Z","caller":"traceutil/trace.go:171","msg":"trace[1091071913] transaction","detail":"{read_only:false; response_revision:198; number_of_response:1; }","duration":"342.691848ms","start":"2026-06-05T04:24:59.449893Z","end":"2026-06-05T04:24:59.792585Z","steps":["trace[1091071913] 'process raft request' (duration: 342.35552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:24:59.792801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:24:59.447574Z","time spent":"344.730538ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:24:59.792589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.41776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-05T04:24:59.793053Z","caller":"traceutil/trace.go:171","msg":"trace[1100652790] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:197; }","duration":"344.938603ms","start":"2026-06-05T04:24:59.448099Z","end":"2026-06-05T04:24:59.793037Z","steps":["trace[1100652790] 'agreement among raft nodes before linearized reading' (duration: 344.287068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:24:59.793103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:24:59.448088Z","time spent":"345.000874ms","remote":"127.0.0.1:34892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-05T04:24:59.793186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:24:59.449887Z","time spent":"343.171299ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:24:59.793293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:24:59.449179Z","time spent":"343.792894ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:25:19.202488Z","caller":"traceutil/trace.go:171","msg":"trace[664631484] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"139.373279ms","start":"2026-06-05T04:25:19.063091Z","end":"2026-06-05T04:25:19.202464Z","steps":["trace[664631484] 'process raft request' (duration: 139.275067ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:19.202619Z","caller":"traceutil/trace.go:171","msg":"trace[1636750703] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"201.810473ms","start":"2026-06-05T04:25:19.000795Z","end":"2026-06-05T04:25:19.202606Z","steps":["trace[1636750703] 'process raft request' (duration: 175.326795ms)","trace[1636750703] 'compare' (duration: 25.929465ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:25:30.115555Z","caller":"traceutil/trace.go:171","msg":"trace[1288744293] linearizableReadLoop","detail":"{readStateIndex:465; appliedIndex:464; }","duration":"140.416414ms","start":"2026-06-05T04:25:29.975096Z","end":"2026-06-05T04:25:30.115513Z","steps":["trace[1288744293] 'read index received' (duration: 140.084476ms)","trace[1288744293] 'applied index is now lower than readState.Index' (duration: 330.418µs)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:25:30.115779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.668321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-05T04:25:30.11586Z","caller":"traceutil/trace.go:171","msg":"trace[1097278454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:449; }","duration":"140.801544ms","start":"2026-06-05T04:25:29.975041Z","end":"2026-06-05T04:25:30.115842Z","steps":["trace[1097278454] 'agreement among raft nodes before linearized reading' (duration: 140.64653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:30.115852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.733828ms","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-06-05T04:25:30.115918Z","caller":"traceutil/trace.go:171","msg":"trace[1316131784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:449; }","duration":"139.86053ms","start":"2026-06-05T04:25:29.976043Z","end":"2026-06-05T04:25:30.115904Z","steps":["trace[1316131784] 'agreement among raft nodes before linearized reading' (duration: 139.729507ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:30.115693Z","caller":"traceutil/trace.go:171","msg":"trace[1665812735] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"154.847341ms","start":"2026-06-05T04:25:29.960794Z","end":"2026-06-05T04:25:30.115641Z","steps":["trace[1665812735] 'process raft request' (duration: 154.517383ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:33.528339Z","caller":"traceutil/trace.go:171","msg":"trace[1471936174] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"271.223366ms","start":"2026-06-05T04:25:33.257081Z","end":"2026-06-05T04:25:33.528305Z","steps":["trace[1471936174] 'process raft request' (duration: 271.013621ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:33.534842Z","caller":"traceutil/trace.go:171","msg":"trace[711475151] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"270.427748ms","start":"2026-06-05T04:25:33.264392Z","end":"2026-06-05T04:25:33.534819Z","steps":["trace[711475151] 'process raft request' (duration: 270.211233ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:33.53506Z","caller":"traceutil/trace.go:171","msg":"trace[632236633] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"259.74062ms","start":"2026-06-05T04:25:33.275304Z","end":"2026-06-05T04:25:33.535045Z","steps":["trace[632236633] 'process raft request' (duration: 259.493465ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:33.535172Z","caller":"traceutil/trace.go:171","msg":"trace[601373538] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"270.305704ms","start":"2026-06-05T04:25:33.264851Z","end":"2026-06-05T04:25:33.535157Z","steps":["trace[601373538] 'process raft request' (duration: 269.810502ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:33.535263Z","caller":"traceutil/trace.go:171","msg":"trace[319468467] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"265.517589ms","start":"2026-06-05T04:25:33.269736Z","end":"2026-06-05T04:25:33.535253Z","steps":["trace[319468467] 'process raft request' (duration: 265.023638ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:33.535353Z","caller":"traceutil/trace.go:171","msg":"trace[1197075492] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"259.783762ms","start":"2026-06-05T04:25:33.27556Z","end":"2026-06-05T04:25:33.535343Z","steps":["trace[1197075492] 'process raft request' (duration: 259.397412ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:33.535429Z","caller":"traceutil/trace.go:171","msg":"trace[1117592093] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"260.025637ms","start":"2026-06-05T04:25:33.275394Z","end":"2026-06-05T04:25:33.535419Z","steps":["trace[1117592093] 'process raft request' (duration: 259.439453ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:33.53551Z","caller":"traceutil/trace.go:171","msg":"trace[1163249401] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"234.551981ms","start":"2026-06-05T04:25:33.300951Z","end":"2026-06-05T04:25:33.535503Z","steps":["trace[1163249401] 'process raft request' (duration: 234.170282ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:33.535571Z","caller":"traceutil/trace.go:171","msg":"trace[47526344] linearizableReadLoop","detail":"{readStateIndex:517; appliedIndex:506; }","duration":"126.017967ms","start":"2026-06-05T04:25:33.409509Z","end":"2026-06-05T04:25:33.535527Z","steps":["trace[47526344] 'read index received' (duration: 118.64695ms)","trace[47526344] 'applied index is now lower than readState.Index' (duration: 7.369917ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:25:33.535595Z","caller":"traceutil/trace.go:171","msg":"trace[1587967271] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"254.924163ms","start":"2026-06-05T04:25:33.280661Z","end":"2026-06-05T04:25:33.535585Z","steps":["trace[1587967271] 'process raft request' (duration: 254.34774ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:33.535562Z","caller":"traceutil/trace.go:171","msg":"trace[827998706] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"218.540317ms","start":"2026-06-05T04:25:33.316975Z","end":"2026-06-05T04:25:33.535515Z","steps":["trace[827998706] 'process raft request' (duration: 218.197158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:33.535758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.236703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-05T04:25:33.535796Z","caller":"traceutil/trace.go:171","msg":"trace[1926436903] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"200.821689ms","start":"2026-06-05T04:25:33.334962Z","end":"2026-06-05T04:25:33.535783Z","steps":["trace[1926436903] 'process raft request' (duration: 200.352608ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:33.535855Z","caller":"traceutil/trace.go:171","msg":"trace[1830991821] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:502; }","duration":"126.315915ms","start":"2026-06-05T04:25:33.40949Z","end":"2026-06-05T04:25:33.535806Z","steps":["trace[1830991821] 'agreement among raft nodes before linearized reading' (duration: 126.175131ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:34.124388Z","caller":"traceutil/trace.go:171","msg":"trace[1767118720] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"115.165015ms","start":"2026-06-05T04:25:34.009146Z","end":"2026-06-05T04:25:34.124311Z","steps":["trace[1767118720] 'process raft request' (duration: 62.824755ms)","trace[1767118720] 'compare' (duration: 50.805294ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:25:34.704721Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410867459770254,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T04:25:35.00282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.331056ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:25:35.003259Z","caller":"traceutil/trace.go:171","msg":"trace[1641125716] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"813.398452ms","start":"2026-06-05T04:25:34.189804Z","end":"2026-06-05T04:25:35.003203Z","steps":["trace[1641125716] 'process raft request' (duration: 654.554574ms)","trace[1641125716] 'compare' (duration: 158.06047ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:25:35.003436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:25:34.189785Z","time spent":"813.552235ms","remote":"127.0.0.1:34854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:25:35.003489Z","caller":"traceutil/trace.go:171","msg":"trace[1148056051] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"794.938787ms","start":"2026-06-05T04:25:34.208504Z","end":"2026-06-05T04:25:35.003442Z","steps":["trace[1148056051] 'process raft request' (duration: 794.471376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:35.003653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:25:34.208488Z","time spent":"795.07407ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:25:35.003714Z","caller":"traceutil/trace.go:171","msg":"trace[1530135253] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"790.001789ms","start":"2026-06-05T04:25:34.213633Z","end":"2026-06-05T04:25:35.003635Z","steps":["trace[1530135253] 'process raft request' (duration: 789.445415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:35.004008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:25:34.213626Z","time spent":"790.227584ms","remote":"127.0.0.1:34854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:25:35.004205Z","caller":"traceutil/trace.go:171","msg":"trace[208959381] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:566; }","duration":"800.313017ms","start":"2026-06-05T04:25:34.203868Z","end":"2026-06-05T04:25:35.00418Z","steps":["trace[208959381] 'read index received' (duration: 640.570188ms)","trace[208959381] 'applied index is now lower than readState.Index' (duration: 159.741749ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:25:35.004264Z","caller":"traceutil/trace.go:171","msg":"trace[851387064] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"777.756264ms","start":"2026-06-05T04:25:34.226451Z","end":"2026-06-05T04:25:35.004207Z","steps":["trace[851387064] 'process raft request' (duration: 777.21139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:35.004403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.849028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-05T04:25:35.004477Z","caller":"traceutil/trace.go:171","msg":"trace[1307277028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:552; }","duration":"803.002632ms","start":"2026-06-05T04:25:34.201463Z","end":"2026-06-05T04:25:35.004466Z","steps":["trace[1307277028] 'agreement among raft nodes before linearized reading' (duration: 802.793527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:35.004472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:25:34.226436Z","time spent":"777.914938ms","remote":"127.0.0.1:34854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T04:25:35.004512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:25:34.201438Z","time spent":"803.065874ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-05T04:25:39.910539Z","caller":"traceutil/trace.go:171","msg":"trace[549581560] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"147.195258ms","start":"2026-06-05T04:25:39.763295Z","end":"2026-06-05T04:25:39.91049Z","steps":["trace[549581560] 'process raft request' (duration: 146.625784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:40.400685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.33284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:25:40.400723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.039291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:25:40.400777Z","caller":"traceutil/trace.go:171","msg":"trace[1880648962] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:588; }","duration":"425.454494ms","start":"2026-06-05T04:25:39.975295Z","end":"2026-06-05T04:25:40.40075Z","steps":["trace[1880648962] 'range keys from in-memory index tree' (duration: 425.250258ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:40.400805Z","caller":"traceutil/trace.go:171","msg":"trace[767305325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"227.176885ms","start":"2026-06-05T04:25:40.173608Z","end":"2026-06-05T04:25:40.400785Z","steps":["trace[767305325] 'range keys from in-memory index tree' (duration: 226.952319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:40.400831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:25:39.975289Z","time spent":"425.531836ms","remote":"127.0.0.1:34960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-05T04:25:40.401316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.502666ms","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-06-05T04:25:40.40147Z","caller":"traceutil/trace.go:171","msg":"trace[766801386] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"211.714261ms","start":"2026-06-05T04:25:40.189729Z","end":"2026-06-05T04:25:40.401444Z","steps":["trace[766801386] 'range keys from in-memory index tree' (duration: 211.269532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:41.530931Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410867459770427,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-05T04:25:41.635568Z","caller":"traceutil/trace.go:171","msg":"trace[1516516083] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"605.585504ms","start":"2026-06-05T04:25:41.029954Z","end":"2026-06-05T04:25:41.63554Z","steps":["trace[1516516083] 'read index received' (duration: 589.047805ms)","trace[1516516083] 'applied index is now lower than readState.Index' (duration: 16.536419ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:25:41.636466Z","caller":"traceutil/trace.go:171","msg":"trace[1747054656] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"818.819614ms","start":"2026-06-05T04:25:40.817592Z","end":"2026-06-05T04:25:41.636412Z","steps":["trace[1747054656] 'process raft request' (duration: 801.788473ms)","trace[1747054656] 'compare' (duration: 15.76283ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:25:41.636526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.560628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-05T04:25:41.636585Z","caller":"traceutil/trace.go:171","msg":"trace[1117688195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:590; }","duration":"606.69178ms","start":"2026-06-05T04:25:41.029879Z","end":"2026-06-05T04:25:41.636571Z","steps":["trace[1117688195] 'agreement among raft nodes before linearized reading' (duration: 606.487856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:41.6366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.853721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-05T04:25:41.636614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:25:41.02985Z","time spent":"606.755862ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T04:25:41.636642Z","caller":"traceutil/trace.go:171","msg":"trace[219444069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"605.942493ms","start":"2026-06-05T04:25:41.030685Z","end":"2026-06-05T04:25:41.636628Z","steps":["trace[219444069] 'agreement among raft nodes before linearized reading' (duration: 605.83541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:41.636647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:25:40.817572Z","time spent":"818.983347ms","remote":"127.0.0.1:34884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036097,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:25:41.636674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:25:41.030659Z","time spent":"606.007175ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-05T04:25:41.636806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.543597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:25:41.636837Z","caller":"traceutil/trace.go:171","msg":"trace[56769607] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"462.611808ms","start":"2026-06-05T04:25:41.174214Z","end":"2026-06-05T04:25:41.636826Z","steps":["trace[56769607] 'agreement among raft nodes before linearized reading' (duration: 462.555447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:25:41.63687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:25:41.174192Z","time spent":"462.67205ms","remote":"127.0.0.1:34812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:25:52.559503Z","caller":"traceutil/trace.go:171","msg":"trace[1554210055] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"107.845569ms","start":"2026-06-05T04:25:52.451626Z","end":"2026-06-05T04:25:52.559471Z","steps":["trace[1554210055] 'process raft request' (duration: 107.234795ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:25:52.614435Z","caller":"traceutil/trace.go:171","msg":"trace[1774156760] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"132.105463ms","start":"2026-06-05T04:25:52.482303Z","end":"2026-06-05T04:25:52.614408Z","steps":["trace[1774156760] 'process raft request' (duration: 131.995781ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:26:31.257123Z","caller":"traceutil/trace.go:171","msg":"trace[755698128] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"102.445242ms","start":"2026-06-05T04:26:31.154647Z","end":"2026-06-05T04:26:31.257092Z","steps":["trace[755698128] 'process raft request' (duration: 102.221487ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:03.40263Z","caller":"traceutil/trace.go:171","msg":"trace[2032075634] linearizableReadLoop","detail":"{readStateIndex:1123; appliedIndex:1122; }","duration":"229.925626ms","start":"2026-06-05T04:27:03.172682Z","end":"2026-06-05T04:27:03.402607Z","steps":["trace[2032075634] 'read index received' (duration: 229.814373ms)","trace[2032075634] 'applied index is now lower than readState.Index' (duration: 110.143µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:03.402709Z","caller":"traceutil/trace.go:171","msg":"trace[2086813089] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"303.439637ms","start":"2026-06-05T04:27:03.099245Z","end":"2026-06-05T04:27:03.402684Z","steps":["trace[2086813089] 'process raft request' (duration: 303.235002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:03.402745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.045799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:27:03.402778Z","caller":"traceutil/trace.go:171","msg":"trace[1499784811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1083; }","duration":"230.129611ms","start":"2026-06-05T04:27:03.172638Z","end":"2026-06-05T04:27:03.402768Z","steps":["trace[1499784811] 'agreement among raft nodes before linearized reading' (duration: 230.063699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:03.402823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:03.099216Z","time spent":"303.54078ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:27:03.927053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.321382ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:27:03.92718Z","caller":"traceutil/trace.go:171","msg":"trace[1964026775] linearizableReadLoop","detail":"{readStateIndex:1124; appliedIndex:1123; }","duration":"523.519181ms","start":"2026-06-05T04:27:03.40364Z","end":"2026-06-05T04:27:03.927159Z","steps":["trace[1964026775] 'read index received' (duration: 274.030505ms)","trace[1964026775] 'applied index is now lower than readState.Index' (duration: 249.487136ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:27:03.9273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.651184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:27:03.927307Z","caller":"traceutil/trace.go:171","msg":"trace[1959641211] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"554.934654ms","start":"2026-06-05T04:27:03.372323Z","end":"2026-06-05T04:27:03.927257Z","steps":["trace[1959641211] 'process raft request' (duration: 305.312705ms)","trace[1959641211] 'compare' (duration: 249.119537ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:03.927351Z","caller":"traceutil/trace.go:171","msg":"trace[1442830241] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1084; }","duration":"523.721765ms","start":"2026-06-05T04:27:03.403617Z","end":"2026-06-05T04:27:03.927338Z","steps":["trace[1442830241] 'agreement among raft nodes before linearized reading' (duration: 523.642093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:03.927399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:03.403607Z","time spent":"523.782658ms","remote":"127.0.0.1:34824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T04:27:03.927407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.610822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-05T04:27:03.927437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:03.372293Z","time spent":"555.074858ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:27:03.927461Z","caller":"traceutil/trace.go:171","msg":"trace[63807311] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1084; }","duration":"119.706354ms","start":"2026-06-05T04:27:03.807739Z","end":"2026-06-05T04:27:03.927446Z","steps":["trace[63807311] 'agreement among raft nodes before linearized reading' (duration: 119.55765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:05.159601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.122498ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-05T04:27:06.159081Z","caller":"traceutil/trace.go:171","msg":"trace[570467550] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1131; }","duration":"210.811498ms","start":"2026-06-05T04:27:05.948239Z","end":"2026-06-05T04:27:06.15905Z","steps":["trace[570467550] 'read index received' (duration: 210.732606ms)","trace[570467550] 'applied index is now lower than readState.Index' (duration: 77.602µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:06.159236Z","caller":"traceutil/trace.go:171","msg":"trace[801434092] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"225.178436ms","start":"2026-06-05T04:27:05.934042Z","end":"2026-06-05T04:27:06.159221Z","steps":["trace[801434092] 'process raft request' (duration: 224.829137ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:06.159748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.476213ms","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-06-05T04:27:06.159833Z","caller":"traceutil/trace.go:171","msg":"trace[948324276] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1091; }","duration":"211.607947ms","start":"2026-06-05T04:27:05.948205Z","end":"2026-06-05T04:27:06.159813Z","steps":["trace[948324276] 'agreement among raft nodes before linearized reading' (duration: 211.354021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:06.498303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.370119ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:27:06.498898Z","caller":"traceutil/trace.go:171","msg":"trace[1062350577] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"198.771778ms","start":"2026-06-05T04:27:06.300059Z","end":"2026-06-05T04:27:06.49883Z","steps":["trace[1062350577] 'process raft request' (duration: 80.795444ms)","trace[1062350577] 'compare' (duration: 117.274657ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:27:22.766106Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410867459771761,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T04:27:23.266821Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410867459771761,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T04:27:23.584561Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.354586035s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T04:27:23.584905Z","caller":"traceutil/trace.go:171","msg":"trace[877207659] linearizableReadLoop","detail":"{readStateIndex:1241; appliedIndex:1240; }","duration":"1.318846391s","start":"2026-06-05T04:27:22.266034Z","end":"2026-06-05T04:27:23.584881Z","steps":["trace[877207659] 'read index received' (duration: 1.318679157s)","trace[877207659] 'applied index is now lower than readState.Index' (duration: 166.214µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:23.584936Z","caller":"traceutil/trace.go:171","msg":"trace[1975480118] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"1.355059846s","start":"2026-06-05T04:27:22.229853Z","end":"2026-06-05T04:27:23.584913Z","steps":["trace[1975480118] 'process raft request' (duration: 1.354901842s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:23.585046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:22.22983Z","time spent":"1.355156679s","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:27:23.5851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.319037376s","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-06-05T04:27:23.585135Z","caller":"traceutil/trace.go:171","msg":"trace[1123884890] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1195; }","duration":"1.319127508s","start":"2026-06-05T04:27:22.265996Z","end":"2026-06-05T04:27:23.585124Z","steps":["trace[1123884890] 'agreement among raft nodes before linearized reading' (duration: 1.318975264s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:23.58517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:22.265978Z","time spent":"1.31918271s","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-05T04:27:23.58522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.169365345s","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-06-05T04:27:23.58524Z","caller":"traceutil/trace.go:171","msg":"trace[2133773470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1195; }","duration":"1.169407927s","start":"2026-06-05T04:27:22.415827Z","end":"2026-06-05T04:27:23.585235Z","steps":["trace[2133773470] 'agreement among raft nodes before linearized reading' (duration: 1.169310684s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:23.585257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:22.415814Z","time spent":"1.169440047s","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-05T04:27:23.58522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.211215648s","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-06-05T04:27:23.585235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.471699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:27:23.585304Z","caller":"traceutil/trace.go:171","msg":"trace[736765434] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1195; }","duration":"1.211370641s","start":"2026-06-05T04:27:22.373911Z","end":"2026-06-05T04:27:23.585282Z","steps":["trace[736765434] 'agreement among raft nodes before linearized reading' (duration: 1.211119405s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:23.58531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.469453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-05T04:27:23.585341Z","caller":"traceutil/trace.go:171","msg":"trace[2095488271] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1195; }","duration":"410.633993ms","start":"2026-06-05T04:27:23.174678Z","end":"2026-06-05T04:27:23.585312Z","steps":["trace[2095488271] 'agreement among raft nodes before linearized reading' (duration: 410.434938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:23.585359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:22.37389Z","time spent":"1.211459543s","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-05T04:27:23.585369Z","caller":"traceutil/trace.go:171","msg":"trace[927696630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1195; }","duration":"996.724849ms","start":"2026-06-05T04:27:22.588629Z","end":"2026-06-05T04:27:23.585354Z","steps":["trace[927696630] 'agreement among raft nodes before linearized reading' (duration: 996.520844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:23.585339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.765256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:27:23.585404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:22.588609Z","time spent":"996.787351ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T04:27:23.585401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:23.174662Z","time spent":"410.726394ms","remote":"127.0.0.1:34812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:27:23.585435Z","caller":"traceutil/trace.go:171","msg":"trace[664600688] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1195; }","duration":"372.9315ms","start":"2026-06-05T04:27:23.212482Z","end":"2026-06-05T04:27:23.585413Z","steps":["trace[664600688] 'agreement among raft nodes before linearized reading' (duration: 372.707825ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:23.585487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:23.212461Z","time spent":"373.014422ms","remote":"127.0.0.1:37830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-06-05T04:27:35.808013Z","caller":"traceutil/trace.go:171","msg":"trace[346825926] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"127.998796ms","start":"2026-06-05T04:27:35.679986Z","end":"2026-06-05T04:27:35.807985Z","steps":["trace[346825926] 'process raft request' (duration: 127.165365ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:35.808469Z","caller":"traceutil/trace.go:171","msg":"trace[2098938443] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"127.964856ms","start":"2026-06-05T04:27:35.68048Z","end":"2026-06-05T04:27:35.808445Z","steps":["trace[2098938443] 'process raft request' (duration: 127.836623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:40.323627Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410867459771896,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-05T04:27:40.372616Z","caller":"traceutil/trace.go:171","msg":"trace[726449587] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"634.704173ms","start":"2026-06-05T04:27:39.737873Z","end":"2026-06-05T04:27:40.372577Z","steps":["trace[726449587] 'process raft request' (duration: 634.431526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:40.372757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:39.737849Z","time spent":"634.832156ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:27:40.619997Z","caller":"traceutil/trace.go:171","msg":"trace[1469069569] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1303; }","duration":"797.228894ms","start":"2026-06-05T04:27:39.822745Z","end":"2026-06-05T04:27:40.619974Z","steps":["trace[1469069569] 'read index received' (duration: 549.767148ms)","trace[1469069569] 'applied index is now lower than readState.Index' (duration: 247.460766ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:40.620153Z","caller":"traceutil/trace.go:171","msg":"trace[1201804735] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"345.600139ms","start":"2026-06-05T04:27:40.274517Z","end":"2026-06-05T04:27:40.620117Z","steps":["trace[1201804735] 'process raft request' (duration: 345.334973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:40.620232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.808421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:27:40.620285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.357725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-05T04:27:40.620298Z","caller":"traceutil/trace.go:171","msg":"trace[105105904] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1256; }","duration":"165.919203ms","start":"2026-06-05T04:27:40.454365Z","end":"2026-06-05T04:27:40.620284Z","steps":["trace[105105904] 'agreement among raft nodes before linearized reading' (duration: 165.817041ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:40.620314Z","caller":"traceutil/trace.go:171","msg":"trace[820421158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1256; }","duration":"792.402347ms","start":"2026-06-05T04:27:39.827902Z","end":"2026-06-05T04:27:40.620304Z","steps":["trace[820421158] 'agreement among raft nodes before linearized reading' (duration: 792.322535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:40.620342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:39.827893Z","time spent":"792.441609ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T04:27:40.620337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:40.274495Z","time spent":"345.743103ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:27:40.620193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.434099ms","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-06-05T04:27:40.620467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.067444ms","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-06-05T04:27:40.620516Z","caller":"traceutil/trace.go:171","msg":"trace[40537072] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1256; }","duration":"797.796758ms","start":"2026-06-05T04:27:39.822708Z","end":"2026-06-05T04:27:40.620505Z","steps":["trace[40537072] 'agreement among raft nodes before linearized reading' (duration: 797.379298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:40.620552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:39.822693Z","time spent":"797.850239ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-05T04:27:40.620554Z","caller":"traceutil/trace.go:171","msg":"trace[776202459] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1256; }","duration":"793.226297ms","start":"2026-06-05T04:27:39.827309Z","end":"2026-06-05T04:27:40.620536Z","steps":["trace[776202459] 'agreement among raft nodes before linearized reading' (duration: 792.93515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:40.620596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:39.827299Z","time spent":"793.288879ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-05T04:27:40.620656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.190203ms","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":"warn","ts":"2026-06-05T04:27:40.620656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.897712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:27:40.620691Z","caller":"traceutil/trace.go:171","msg":"trace[1213792399] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1256; }","duration":"797.250094ms","start":"2026-06-05T04:27:39.823432Z","end":"2026-06-05T04:27:40.620682Z","steps":["trace[1213792399] 'agreement among raft nodes before linearized reading' (duration: 797.150021ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:40.620701Z","caller":"traceutil/trace.go:171","msg":"trace[1040108399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1256; }","duration":"449.967805ms","start":"2026-06-05T04:27:40.170722Z","end":"2026-06-05T04:27:40.62069Z","steps":["trace[1040108399] 'agreement among raft nodes before linearized reading' (duration: 449.908223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:40.620715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:39.823421Z","time spent":"797.288406ms","remote":"127.0.0.1:35014","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-06-05T04:27:40.620739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:40.17071Z","time spent":"450.022636ms","remote":"127.0.0.1:34812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T04:27:40.620772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.692757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-05T04:27:40.620852Z","caller":"traceutil/trace.go:171","msg":"trace[925060110] range","detail":"{range_begin:/registry/masterleases/199.204.45.216; range_end:; response_count:1; response_revision:1256; }","duration":"783.806309ms","start":"2026-06-05T04:27:39.837026Z","end":"2026-06-05T04:27:40.620832Z","steps":["trace[925060110] 'agreement among raft nodes before linearized reading' (duration: 783.530802ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:40.620887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.065184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-05T04:27:40.620895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:39.837017Z","time spent":"783.870132ms","remote":"127.0.0.1:34838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.216\" "} {"level":"info","ts":"2026-06-05T04:27:40.620922Z","caller":"traceutil/trace.go:171","msg":"trace[1984289224] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1256; }","duration":"798.182787ms","start":"2026-06-05T04:27:39.822729Z","end":"2026-06-05T04:27:40.620912Z","steps":["trace[1984289224] 'agreement among raft nodes before linearized reading' (duration: 797.458709ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:40.621014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:39.82271Z","time spent":"798.233649ms","remote":"127.0.0.1:35014","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-06-05T04:27:41.124406Z","caller":"traceutil/trace.go:171","msg":"trace[323073645] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"462.62688ms","start":"2026-06-05T04:27:40.661757Z","end":"2026-06-05T04:27:41.124384Z","steps":["trace[323073645] 'process raft request' (duration: 408.44238ms)","trace[323073645] 'compare' (duration: 53.847902ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:27:41.124545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:40.661739Z","time spent":"462.739423ms","remote":"127.0.0.1:34838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:27:42.852128Z","caller":"traceutil/trace.go:171","msg":"trace[605971276] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1313; }","duration":"245.957699ms","start":"2026-06-05T04:27:42.606146Z","end":"2026-06-05T04:27:42.852104Z","steps":["trace[605971276] 'read index received' (duration: 245.748264ms)","trace[605971276] 'applied index is now lower than readState.Index' (duration: 208.215µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:42.852326Z","caller":"traceutil/trace.go:171","msg":"trace[498207174] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"473.577005ms","start":"2026-06-05T04:27:42.378594Z","end":"2026-06-05T04:27:42.852171Z","steps":["trace[498207174] 'process raft request' (duration: 473.36081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:42.852468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.01275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-05T04:27:42.852508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.779695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-05T04:27:42.852534Z","caller":"traceutil/trace.go:171","msg":"trace[597952442] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1264; }","duration":"160.163394ms","start":"2026-06-05T04:27:42.692354Z","end":"2026-06-05T04:27:42.852517Z","steps":["trace[597952442] 'agreement among raft nodes before linearized reading' (duration: 159.913848ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:42.852581Z","caller":"traceutil/trace.go:171","msg":"trace[586843069] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1264; }","duration":"152.873577ms","start":"2026-06-05T04:27:42.699685Z","end":"2026-06-05T04:27:42.852559Z","steps":["trace[586843069] 'agreement among raft nodes before linearized reading' (duration: 152.702003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:42.852594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.856057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-05T04:27:42.85262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.777925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-05T04:27:42.85266Z","caller":"traceutil/trace.go:171","msg":"trace[2005763125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1264; }","duration":"152.956279ms","start":"2026-06-05T04:27:42.699687Z","end":"2026-06-05T04:27:42.852644Z","steps":["trace[2005763125] 'agreement among raft nodes before linearized reading' (duration: 152.757335ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:42.852668Z","caller":"traceutil/trace.go:171","msg":"trace[617808112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1264; }","duration":"152.886618ms","start":"2026-06-05T04:27:42.699767Z","end":"2026-06-05T04:27:42.852654Z","steps":["trace[617808112] 'agreement among raft nodes before linearized reading' (duration: 152.775475ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:42.852512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.759595ms","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-06-05T04:27:42.852804Z","caller":"traceutil/trace.go:171","msg":"trace[1859925995] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1264; }","duration":"153.069312ms","start":"2026-06-05T04:27:42.699713Z","end":"2026-06-05T04:27:42.852782Z","steps":["trace[1859925995] 'agreement among raft nodes before linearized reading' (duration: 152.633771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:42.852595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:42.378569Z","time spent":"473.838941ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:27:42.852323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.147524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:27:42.853143Z","caller":"traceutil/trace.go:171","msg":"trace[338280062] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1264; }","duration":"247.000074ms","start":"2026-06-05T04:27:42.606108Z","end":"2026-06-05T04:27:42.853108Z","steps":["trace[338280062] 'agreement among raft nodes before linearized reading' (duration: 246.109713ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:43.292596Z","caller":"traceutil/trace.go:171","msg":"trace[374899809] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"434.8997ms","start":"2026-06-05T04:27:42.857672Z","end":"2026-06-05T04:27:43.292572Z","steps":["trace[374899809] 'process raft request' (duration: 342.29304ms)","trace[374899809] 'compare' (duration: 92.490977ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:27:43.292716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:42.857651Z","time spent":"435.001142ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:27:43.316818Z","caller":"traceutil/trace.go:171","msg":"trace[287627032] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"459.020054ms","start":"2026-06-05T04:27:42.857755Z","end":"2026-06-05T04:27:43.316775Z","steps":["trace[287627032] 'process raft request' (duration: 458.85166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:43.317017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:42.857734Z","time spent":"459.210248ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:27:43.317367Z","caller":"traceutil/trace.go:171","msg":"trace[462270380] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"459.540076ms","start":"2026-06-05T04:27:42.857789Z","end":"2026-06-05T04:27:43.317329Z","steps":["trace[462270380] 'process raft request' (duration: 458.949272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:43.317513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:42.857767Z","time spent":"459.673129ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:27:43.317588Z","caller":"traceutil/trace.go:171","msg":"trace[123045825] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"459.667009ms","start":"2026-06-05T04:27:42.85791Z","end":"2026-06-05T04:27:43.317577Z","steps":["trace[123045825] 'process raft request' (duration: 459.28816ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:43.317644Z","caller":"traceutil/trace.go:171","msg":"trace[1785358073] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"458.739397ms","start":"2026-06-05T04:27:42.858894Z","end":"2026-06-05T04:27:43.317633Z","steps":["trace[1785358073] 'process raft request' (duration: 458.411549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:43.317688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:42.857901Z","time spent":"459.73435ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:27:43.317701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:42.858884Z","time spent":"458.784658ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:27:43.317518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.995139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:27:43.317805Z","caller":"traceutil/trace.go:171","msg":"trace[360386943] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1269; }","duration":"143.326057ms","start":"2026-06-05T04:27:43.174469Z","end":"2026-06-05T04:27:43.317795Z","steps":["trace[360386943] 'agreement among raft nodes before linearized reading' (duration: 142.951278ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:43.317371Z","caller":"traceutil/trace.go:171","msg":"trace[1204584348] linearizableReadLoop","detail":"{readStateIndex:1319; appliedIndex:1314; }","duration":"142.836445ms","start":"2026-06-05T04:27:43.174512Z","end":"2026-06-05T04:27:43.317348Z","steps":["trace[1204584348] 'read index received' (duration: 25.467946ms)","trace[1204584348] 'applied index is now lower than readState.Index' (duration: 117.367459ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:44.987535Z","caller":"traceutil/trace.go:171","msg":"trace[1851953457] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"128.644352ms","start":"2026-06-05T04:27:44.858826Z","end":"2026-06-05T04:27:44.987471Z","steps":["trace[1851953457] 'process raft request' (duration: 128.445977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:45.847092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.445102ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-05T04:27:45.84719Z","caller":"traceutil/trace.go:171","msg":"trace[821634202] linearizableReadLoop","detail":"{readStateIndex:1321; appliedIndex:1320; }","duration":"673.322697ms","start":"2026-06-05T04:27:45.17385Z","end":"2026-06-05T04:27:45.847173Z","steps":["trace[821634202] 'read index received' (duration: 49.702µs)","trace[821634202] 'applied index is now lower than readState.Index' (duration: 673.271495ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:27:45.847447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.594293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:27:45.847477Z","caller":"traceutil/trace.go:171","msg":"trace[2086563411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1270; }","duration":"673.665585ms","start":"2026-06-05T04:27:45.173802Z","end":"2026-06-05T04:27:45.847467Z","steps":["trace[2086563411] 'agreement among raft nodes before linearized reading' (duration: 673.599053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:45.847506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:45.173783Z","time spent":"673.716366ms","remote":"127.0.0.1:34812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:27:46.293676Z","caller":"traceutil/trace.go:171","msg":"trace[657659191] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1321; }","duration":"446.43394ms","start":"2026-06-05T04:27:45.847216Z","end":"2026-06-05T04:27:46.29365Z","steps":["trace[657659191] 'read index received' (duration: 446.271876ms)","trace[657659191] 'applied index is now lower than readState.Index' (duration: 160.734µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:46.293788Z","caller":"traceutil/trace.go:171","msg":"trace[254161258] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"710.322962ms","start":"2026-06-05T04:27:45.583433Z","end":"2026-06-05T04:27:46.293756Z","steps":["trace[254161258] 'process raft request' (duration: 710.025484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:46.293886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.647094ms","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":"warn","ts":"2026-06-05T04:27:46.293954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.357793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T04:27:46.293992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.858139ms","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-06-05T04:27:46.294045Z","caller":"traceutil/trace.go:171","msg":"trace[1113824948] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1271; }","duration":"997.956611ms","start":"2026-06-05T04:27:45.296077Z","end":"2026-06-05T04:27:46.294033Z","steps":["trace[1113824948] 'agreement among raft nodes before linearized reading' (duration: 997.806167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:46.294067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:45.296056Z","time spent":"998.007242ms","remote":"127.0.0.1:35014","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-06-05T04:27:46.294081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.33723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-05T04:27:46.294097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.013822ms","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-06-05T04:27:46.294107Z","caller":"traceutil/trace.go:171","msg":"trace[558677922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1271; }","duration":"972.362781ms","start":"2026-06-05T04:27:45.321737Z","end":"2026-06-05T04:27:46.2941Z","steps":["trace[558677922] 'agreement among raft nodes before linearized reading' (duration: 972.292329ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:46.293956Z","caller":"traceutil/trace.go:171","msg":"trace[2023460157] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1271; }","duration":"971.732196ms","start":"2026-06-05T04:27:45.322207Z","end":"2026-06-05T04:27:46.29394Z","steps":["trace[2023460157] 'agreement among raft nodes before linearized reading' (duration: 971.469649ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:46.294155Z","caller":"traceutil/trace.go:171","msg":"trace[1716817103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1271; }","duration":"972.108705ms","start":"2026-06-05T04:27:45.322032Z","end":"2026-06-05T04:27:46.294141Z","steps":["trace[1716817103] 'agreement among raft nodes before linearized reading' (duration: 971.969851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:46.294179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:45.32217Z","time spent":"972.003122ms","remote":"127.0.0.1:35014","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-06-05T04:27:46.293903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.777446ms","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-06-05T04:27:46.294209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:45.322003Z","time spent":"972.187287ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-05T04:27:46.29423Z","caller":"traceutil/trace.go:171","msg":"trace[1341807422] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1271; }","duration":"972.154155ms","start":"2026-06-05T04:27:45.32207Z","end":"2026-06-05T04:27:46.294224Z","steps":["trace[1341807422] 'agreement among raft nodes before linearized reading' (duration: 971.705805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:46.294248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:45.322049Z","time spent":"972.192587ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T04:27:46.294159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:45.321713Z","time spent":"972.439393ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T04:27:46.294007Z","caller":"traceutil/trace.go:171","msg":"trace[1535986380] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1271; }","duration":"445.440845ms","start":"2026-06-05T04:27:45.848555Z","end":"2026-06-05T04:27:46.293996Z","steps":["trace[1535986380] 'agreement among raft nodes before linearized reading' (duration: 445.375654ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:46.294318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:45.848537Z","time spent":"445.777833ms","remote":"127.0.0.1:34824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T04:27:46.295025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:45.583412Z","time spent":"711.529692ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:27:46.441314Z","caller":"traceutil/trace.go:171","msg":"trace[1228638020] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"142.499257ms","start":"2026-06-05T04:27:46.298783Z","end":"2026-06-05T04:27:46.441282Z","steps":["trace[1228638020] 'process raft request' (duration: 73.430617ms)","trace[1228638020] 'compare' (duration: 68.799344ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:46.485771Z","caller":"traceutil/trace.go:171","msg":"trace[994436662] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1322; }","duration":"183.813196ms","start":"2026-06-05T04:27:46.301936Z","end":"2026-06-05T04:27:46.485749Z","steps":["trace[994436662] 'read index received' (duration: 70.2934ms)","trace[994436662] 'applied index is now lower than readState.Index' (duration: 113.518786ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:27:46.485888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.930309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:27:46.485921Z","caller":"traceutil/trace.go:171","msg":"trace[35904355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"183.99533ms","start":"2026-06-05T04:27:46.301915Z","end":"2026-06-05T04:27:46.485911Z","steps":["trace[35904355] 'agreement among raft nodes before linearized reading' (duration: 183.924728ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:46.485987Z","caller":"traceutil/trace.go:171","msg":"trace[233749294] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"186.175673ms","start":"2026-06-05T04:27:46.299798Z","end":"2026-06-05T04:27:46.485974Z","steps":["trace[233749294] 'process raft request' (duration: 185.664021ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:46.48603Z","caller":"traceutil/trace.go:171","msg":"trace[538824270] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"185.953427ms","start":"2026-06-05T04:27:46.300062Z","end":"2026-06-05T04:27:46.486015Z","steps":["trace[538824270] 'process raft request' (duration: 185.489326ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:46.48618Z","caller":"traceutil/trace.go:171","msg":"trace[995453004] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"186.838788ms","start":"2026-06-05T04:27:46.299228Z","end":"2026-06-05T04:27:46.486067Z","steps":["trace[995453004] 'process raft request' (duration: 186.103771ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:46.486167Z","caller":"traceutil/trace.go:171","msg":"trace[635612211] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"185.630359ms","start":"2026-06-05T04:27:46.300482Z","end":"2026-06-05T04:27:46.486112Z","steps":["trace[635612211] 'process raft request' (duration: 185.23082ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:47.248847Z","caller":"traceutil/trace.go:171","msg":"trace[1699001398] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"133.032268ms","start":"2026-06-05T04:27:47.115775Z","end":"2026-06-05T04:27:47.248808Z","steps":["trace[1699001398] 'process raft request' (duration: 111.602219ms)","trace[1699001398] 'compare' (duration: 21.209613ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:53.459501Z","caller":"traceutil/trace.go:171","msg":"trace[1616567231] linearizableReadLoop","detail":"{readStateIndex:1396; appliedIndex:1395; }","duration":"283.961549ms","start":"2026-06-05T04:27:53.175524Z","end":"2026-06-05T04:27:53.459486Z","steps":["trace[1616567231] 'read index received' (duration: 283.831245ms)","trace[1616567231] 'applied index is now lower than readState.Index' (duration: 129.824µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:53.459527Z","caller":"traceutil/trace.go:171","msg":"trace[200122888] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"376.082508ms","start":"2026-06-05T04:27:53.083421Z","end":"2026-06-05T04:27:53.459504Z","steps":["trace[200122888] 'process raft request' (duration: 375.971734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:53.459619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.881987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:27:53.459641Z","caller":"traceutil/trace.go:171","msg":"trace[119785742] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1344; }","duration":"283.948809ms","start":"2026-06-05T04:27:53.175686Z","end":"2026-06-05T04:27:53.459635Z","steps":["trace[119785742] 'agreement among raft nodes before linearized reading' (duration: 283.880237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:53.459641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:53.083399Z","time spent":"376.180951ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:27:53.459815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.259866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-76h8q\" ","response":"range_response_count:1 size:12642"} {"level":"info","ts":"2026-06-05T04:27:53.460079Z","caller":"traceutil/trace.go:171","msg":"trace[1000244408] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-76h8q; range_end:; response_count:1; response_revision:1344; }","duration":"284.523723ms","start":"2026-06-05T04:27:53.175486Z","end":"2026-06-05T04:27:53.46001Z","steps":["trace[1000244408] 'agreement among raft nodes before linearized reading' (duration: 284.094223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:54.024302Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410867459772055,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T04:27:55.33033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:54.142806Z","time spent":"1.187517845s","remote":"127.0.0.1:39378","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-05T04:27:55.330791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.070544ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T04:27:55.33099Z","caller":"traceutil/trace.go:171","msg":"trace[178668786] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"1.826260006s","start":"2026-06-05T04:27:53.504713Z","end":"2026-06-05T04:27:55.330973Z","steps":["trace[178668786] 'process raft request' (duration: 1.826171824s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.331064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:53.504699Z","time spent":"1.826330848s","remote":"127.0.0.1:35026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:27:55.331061Z","caller":"traceutil/trace.go:171","msg":"trace[2077680003] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"1.827100957s","start":"2026-06-05T04:27:53.503914Z","end":"2026-06-05T04:27:55.331015Z","steps":["trace[2077680003] 'process raft request' (duration: 971.725516ms)","trace[2077680003] 'compare' (duration: 854.150331ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:27:55.331594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:53.503888Z","time spent":"1.827602209s","remote":"127.0.0.1:34938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":925,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:27:55.837293Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.361603876s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T04:27:55.837652Z","caller":"traceutil/trace.go:171","msg":"trace[1593107226] linearizableReadLoop","detail":"{readStateIndex:1400; appliedIndex:1397; }","duration":"2.31346276s","start":"2026-06-05T04:27:53.524165Z","end":"2026-06-05T04:27:55.837628Z","steps":["trace[1593107226] 'read index received' (duration: 951.488325ms)","trace[1593107226] 'applied index is now lower than readState.Index' (duration: 1.361973405s)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:27:55.837722Z","caller":"traceutil/trace.go:171","msg":"trace[1216210923] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"2.326230919s","start":"2026-06-05T04:27:53.511457Z","end":"2026-06-05T04:27:55.837688Z","steps":["trace[1216210923] 'process raft request' (duration: 2.326021674s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.837816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.313631254s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T04:27:55.837859Z","caller":"traceutil/trace.go:171","msg":"trace[2122144861] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1348; }","duration":"2.313726737s","start":"2026-06-05T04:27:53.524121Z","end":"2026-06-05T04:27:55.837848Z","steps":["trace[2122144861] 'agreement among raft nodes before linearized reading' (duration: 2.313625164s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.837872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:53.511448Z","time spent":"2.326345463s","remote":"127.0.0.1:35242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10921,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:27:55.837896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:53.524107Z","time spent":"2.313779338s","remote":"127.0.0.1:35190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-05T04:27:55.838471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.184681746s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T04:27:55.838522Z","caller":"traceutil/trace.go:171","msg":"trace[2027500106] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1349; }","duration":"2.184765448s","start":"2026-06-05T04:27:53.653747Z","end":"2026-06-05T04:27:55.838513Z","steps":["trace[2027500106] 'agreement among raft nodes before linearized reading' (duration: 2.184685376s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.838544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:53.653727Z","time spent":"2.184811458s","remote":"127.0.0.1:35144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":29,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-06-05T04:27:55.838591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.311072464s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-05T04:27:55.838657Z","caller":"traceutil/trace.go:171","msg":"trace[1142670212] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1349; }","duration":"1.311176256s","start":"2026-06-05T04:27:54.527463Z","end":"2026-06-05T04:27:55.838639Z","steps":["trace[1142670212] 'agreement among raft nodes before linearized reading' (duration: 1.310968891s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.838697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:54.527446Z","time spent":"1.311242818s","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T04:27:55.83877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.31381294s","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-06-05T04:27:55.838799Z","caller":"traceutil/trace.go:171","msg":"trace[638820551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1349; }","duration":"1.313865141s","start":"2026-06-05T04:27:54.524927Z","end":"2026-06-05T04:27:55.838792Z","steps":["trace[638820551] 'agreement among raft nodes before linearized reading' (duration: 1.313728078s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.838824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:54.524917Z","time spent":"1.313898482s","remote":"127.0.0.1:35014","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-06-05T04:27:55.838904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315135163s","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-06-05T04:27:55.83892Z","caller":"traceutil/trace.go:171","msg":"trace[1117817981] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1349; }","duration":"1.315158403s","start":"2026-06-05T04:27:54.523756Z","end":"2026-06-05T04:27:55.838914Z","steps":["trace[1117817981] 'agreement among raft nodes before linearized reading' (duration: 1.315111152s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.838936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:54.523752Z","time spent":"1.315179674s","remote":"127.0.0.1:35014","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-06-05T04:27:55.839015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.226942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:27:55.839048Z","caller":"traceutil/trace.go:171","msg":"trace[2011855042] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1349; }","duration":"665.291053ms","start":"2026-06-05T04:27:55.173747Z","end":"2026-06-05T04:27:55.839038Z","steps":["trace[2011855042] 'agreement among raft nodes before linearized reading' (duration: 665.246412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.839089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315343037s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-05T04:27:55.839076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.265475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"warn","ts":"2026-06-05T04:27:55.839105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:55.173729Z","time spent":"665.368435ms","remote":"127.0.0.1:34812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T04:27:55.839126Z","caller":"traceutil/trace.go:171","msg":"trace[264909828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1349; }","duration":"1.315381459s","start":"2026-06-05T04:27:54.523723Z","end":"2026-06-05T04:27:55.839105Z","steps":["trace[264909828] 'agreement among raft nodes before linearized reading' (duration: 1.315324748s)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:55.839127Z","caller":"traceutil/trace.go:171","msg":"trace[1874212991] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1349; }","duration":"248.358508ms","start":"2026-06-05T04:27:55.590753Z","end":"2026-06-05T04:27:55.839111Z","steps":["trace[1874212991] 'agreement among raft nodes before linearized reading' (duration: 248.212285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.839148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:54.523712Z","time spent":"1.31543174s","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T04:27:55.839241Z","caller":"traceutil/trace.go:171","msg":"trace[1755027532] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"375.081973ms","start":"2026-06-05T04:27:55.464147Z","end":"2026-06-05T04:27:55.839229Z","steps":["trace[1755027532] 'process raft request' (duration: 374.208112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.839321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:55.464122Z","time spent":"375.144005ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T04:27:55.839337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.362886936s","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-06-05T04:27:55.839359Z","caller":"traceutil/trace.go:171","msg":"trace[199130187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1349; }","duration":"1.362942658s","start":"2026-06-05T04:27:54.476409Z","end":"2026-06-05T04:27:55.839351Z","steps":["trace[199130187] 'agreement among raft nodes before linearized reading' (duration: 1.362884526s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.839375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:54.47639Z","time spent":"1.362980899s","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-05T04:27:55.839386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.526418542s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-05T04:27:55.839403Z","caller":"traceutil/trace.go:171","msg":"trace[1302302906] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1349; }","duration":"1.526471434s","start":"2026-06-05T04:27:54.312926Z","end":"2026-06-05T04:27:55.839397Z","steps":["trace[1302302906] 'agreement among raft nodes before linearized reading' (duration: 1.526423683s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.839415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:54.312906Z","time spent":"1.526506185s","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-05T04:27:55.839473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.741276749s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-05T04:27:55.839484Z","caller":"traceutil/trace.go:171","msg":"trace[638635270] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1349; }","duration":"1.74131902s","start":"2026-06-05T04:27:54.098161Z","end":"2026-06-05T04:27:55.83948Z","steps":["trace[638635270] 'agreement among raft nodes before linearized reading' (duration: 1.741286869s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.839494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:54.098143Z","time spent":"1.741348991s","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-05T04:27:55.839535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.872812311s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-05T04:27:55.839537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.627964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T04:27:55.839546Z","caller":"traceutil/trace.go:171","msg":"trace[1008446679] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1349; }","duration":"1.872826201s","start":"2026-06-05T04:27:53.966716Z","end":"2026-06-05T04:27:55.839543Z","steps":["trace[1008446679] 'agreement among raft nodes before linearized reading' (duration: 1.872803141s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.839558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:53.966663Z","time spent":"1.872892333s","remote":"127.0.0.1:40678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-06-05T04:27:55.839666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.136269154s","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":"info","ts":"2026-06-05T04:27:55.839687Z","caller":"traceutil/trace.go:171","msg":"trace[1018471291] 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:1349; }","duration":"2.136331106s","start":"2026-06-05T04:27:53.703349Z","end":"2026-06-05T04:27:55.83968Z","steps":["trace[1018471291] 'agreement among raft nodes before linearized reading' (duration: 2.136289045s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:27:55.839701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:27:53.703334Z","time spent":"2.136363896s","remote":"127.0.0.1:37924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-06-05T04:27:55.839559Z","caller":"traceutil/trace.go:171","msg":"trace[1579722174] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1349; }","duration":"198.678816ms","start":"2026-06-05T04:27:55.640873Z","end":"2026-06-05T04:27:55.839552Z","steps":["trace[1579722174] 'agreement among raft nodes before linearized reading' (duration: 198.640865ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:27:58.156409Z","caller":"traceutil/trace.go:171","msg":"trace[2031417480] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"106.999288ms","start":"2026-06-05T04:27:58.049382Z","end":"2026-06-05T04:27:58.156381Z","steps":["trace[2031417480] 'process raft request' (duration: 106.848345ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:28:01.312476Z","caller":"traceutil/trace.go:171","msg":"trace[1663377142] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"457.490027ms","start":"2026-06-05T04:28:00.854959Z","end":"2026-06-05T04:28:01.312449Z","steps":["trace[1663377142] 'process raft request' (duration: 457.284282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:28:01.312624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:28:00.854941Z","time spent":"457.61042ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:28:01.4204Z","caller":"traceutil/trace.go:171","msg":"trace[897749757] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"565.342625ms","start":"2026-06-05T04:28:00.855016Z","end":"2026-06-05T04:28:01.420359Z","steps":["trace[897749757] 'process raft request' (duration: 564.644458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T04:28:01.42063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T04:28:00.855002Z","time spent":"565.53548ms","remote":"127.0.0.1:35014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T04:28:01.420804Z","caller":"traceutil/trace.go:171","msg":"trace[1524594902] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"297.872315ms","start":"2026-06-05T04:28:01.122703Z","end":"2026-06-05T04:28:01.420576Z","steps":["trace[1524594902] 'process raft request' (duration: 297.592408ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:28:02.138116Z","caller":"traceutil/trace.go:171","msg":"trace[421863145] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"203.992385ms","start":"2026-06-05T04:28:01.934088Z","end":"2026-06-05T04:28:02.13808Z","steps":["trace[421863145] 'process raft request' (duration: 203.805629ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:28:02.138326Z","caller":"traceutil/trace.go:171","msg":"trace[1154205373] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"204.423575ms","start":"2026-06-05T04:28:01.933867Z","end":"2026-06-05T04:28:02.138291Z","steps":["trace[1154205373] 'process raft request' (duration: 167.946233ms)","trace[1154205373] 'compare' (duration: 35.803695ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:28:02.138336Z","caller":"traceutil/trace.go:171","msg":"trace[674996838] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"203.644496ms","start":"2026-06-05T04:28:01.934673Z","end":"2026-06-05T04:28:02.138317Z","steps":["trace[674996838] 'process raft request' (duration: 203.504563ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:28:02.138335Z","caller":"traceutil/trace.go:171","msg":"trace[1413135] transaction","detail":"{read_only:false; response_revision:1385; number_of_response:1; }","duration":"204.091467ms","start":"2026-06-05T04:28:01.934211Z","end":"2026-06-05T04:28:02.138302Z","steps":["trace[1413135] 'process raft request' (duration: 203.803909ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:28:02.138445Z","caller":"traceutil/trace.go:171","msg":"trace[1802952320] linearizableReadLoop","detail":"{readStateIndex:1440; appliedIndex:1436; }","duration":"175.402733ms","start":"2026-06-05T04:28:01.96295Z","end":"2026-06-05T04:28:02.138353Z","steps":["trace[1802952320] 'read index received' (duration: 138.850059ms)","trace[1802952320] 'applied index is now lower than readState.Index' (duration: 36.550914ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:28:02.139299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.761412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-05T04:28:02.139369Z","caller":"traceutil/trace.go:171","msg":"trace[512516617] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1386; }","duration":"176.424858ms","start":"2026-06-05T04:28:01.962921Z","end":"2026-06-05T04:28:02.139346Z","steps":["trace[512516617] 'agreement among raft nodes before linearized reading' (duration: 175.67179ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:28:12.308929Z","caller":"traceutil/trace.go:171","msg":"trace[1599825670] transaction","detail":"{read_only:false; response_revision:1433; number_of_response:1; }","duration":"105.951763ms","start":"2026-06-05T04:28:12.202958Z","end":"2026-06-05T04:28:12.30891Z","steps":["trace[1599825670] 'process raft request' (duration: 105.830191ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:28:12.310692Z","caller":"traceutil/trace.go:171","msg":"trace[839346270] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"107.423049ms","start":"2026-06-05T04:28:12.20324Z","end":"2026-06-05T04:28:12.310663Z","steps":["trace[839346270] 'process raft request' (duration: 107.03577ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:29:02.766452Z","caller":"traceutil/trace.go:171","msg":"trace[1199568016] linearizableReadLoop","detail":"{readStateIndex:1727; appliedIndex:1724; }","duration":"112.375388ms","start":"2026-06-05T04:29:02.654052Z","end":"2026-06-05T04:29:02.766428Z","steps":["trace[1199568016] 'read index received' (duration: 18.312242ms)","trace[1199568016] 'applied index is now lower than readState.Index' (duration: 94.062226ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:29:02.766525Z","caller":"traceutil/trace.go:171","msg":"trace[1314107769] transaction","detail":"{read_only:false; response_revision:1661; number_of_response:1; }","duration":"179.467462ms","start":"2026-06-05T04:29:02.587029Z","end":"2026-06-05T04:29:02.766496Z","steps":["trace[1314107769] 'process raft request' (duration: 130.321423ms)","trace[1314107769] 'compare' (duration: 48.975985ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T04:29:02.766706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.628675ms","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-06-05T04:29:02.766767Z","caller":"traceutil/trace.go:171","msg":"trace[1766709368] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1661; }","duration":"112.739587ms","start":"2026-06-05T04:29:02.654015Z","end":"2026-06-05T04:29:02.766755Z","steps":["trace[1766709368] 'agreement among raft nodes before linearized reading' (duration: 112.545072ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:29:10.917531Z","caller":"traceutil/trace.go:171","msg":"trace[1698244014] transaction","detail":"{read_only:false; response_revision:1695; number_of_response:1; }","duration":"206.907226ms","start":"2026-06-05T04:29:10.710595Z","end":"2026-06-05T04:29:10.917502Z","steps":["trace[1698244014] 'process raft request' (duration: 139.604527ms)","trace[1698244014] 'compare' (duration: 66.94973ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T04:29:31.207994Z","caller":"traceutil/trace.go:171","msg":"trace[1464548916] transaction","detail":"{read_only:false; response_revision:1790; number_of_response:1; }","duration":"118.05426ms","start":"2026-06-05T04:29:31.089916Z","end":"2026-06-05T04:29:31.20797Z","steps":["trace[1464548916] 'process raft request' (duration: 117.814493ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:29:31.208323Z","caller":"traceutil/trace.go:171","msg":"trace[1796260324] transaction","detail":"{read_only:false; response_revision:1791; number_of_response:1; }","duration":"118.289856ms","start":"2026-06-05T04:29:31.090021Z","end":"2026-06-05T04:29:31.208311Z","steps":["trace[1796260324] 'process raft request' (duration: 117.909716ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:29:56.722824Z","caller":"traceutil/trace.go:171","msg":"trace[1449299534] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"113.327264ms","start":"2026-06-05T04:29:56.609476Z","end":"2026-06-05T04:29:56.722803Z","steps":["trace[1449299534] 'process raft request' (duration: 112.168004ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:30:05.51547Z","caller":"traceutil/trace.go:171","msg":"trace[1648750430] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"149.937815ms","start":"2026-06-05T04:30:05.365513Z","end":"2026-06-05T04:30:05.515451Z","steps":["trace[1648750430] 'process raft request' (duration: 149.822032ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:30:05.534986Z","caller":"traceutil/trace.go:171","msg":"trace[633807206] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"168.282617ms","start":"2026-06-05T04:30:05.366682Z","end":"2026-06-05T04:30:05.534965Z","steps":["trace[633807206] 'process raft request' (duration: 163.79995ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:31:42.038282Z","caller":"traceutil/trace.go:171","msg":"trace[885435217] transaction","detail":"{read_only:false; response_revision:2411; number_of_response:1; }","duration":"114.535006ms","start":"2026-06-05T04:31:41.923729Z","end":"2026-06-05T04:31:42.038264Z","steps":["trace[885435217] 'process raft request' (duration: 114.267479ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T04:31:49.78283Z","caller":"traceutil/trace.go:171","msg":"trace[1132026579] transaction","detail":"{read_only:false; response_revision:2450; number_of_response:1; }","duration":"173.202833ms","start":"2026-06-05T04:31:49.609597Z","end":"2026-06-05T04:31:49.7828Z","steps":["trace[1132026579] 'process raft request' (duration: 172.971508ms)"],"step_count":1}