{"level":"warn","ts":"2026-04-22T06:06:17.799091Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T06:06:17.799215Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169: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.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-22T06:06:17.799427Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T06:06:17.799449Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-04-22T06:06:17.799518Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T06:06:17.80086Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-04-22T06:06:17.801034Z","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.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-22T06:06:17.805364Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.056808ms"} {"level":"info","ts":"2026-04-22T06:06:17.817358Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-04-22T06:06:17.817447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T06:06:17.817495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-04-22T06:06:17.817511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T06:06:17.817526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-04-22T06:06:17.817597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-04-22T06:06:17.82515Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T06:06:17.828164Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T06:06:17.82963Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-22T06:06:17.832103Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T06:06:17.83226Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T06:06:17.832386Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T06:06:17.832462Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T06:06:17.83247Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T06:06:17.833331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-04-22T06:06:17.833411Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-04-22T06:06:17.835642Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T06:06:17.835843Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-04-22T06:06:17.835926Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T06:06:17.835967Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T06:06:17.835945Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-04-22T06:06:18.218336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T06:06:18.21839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T06:06:18.21843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-04-22T06:06:18.218451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-04-22T06:06:18.218466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-04-22T06:06:18.218487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-04-22T06:06:18.218505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-04-22T06:06:18.405364Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:06:18.405599Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T06:06:18.405802Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T06:06:18.405831Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T06:06:18.405973Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T06:06:18.406104Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T06:06:18.408311Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T06:06:18.409984Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-04-22T06:06:18.527752Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:06:18.527926Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:06:18.527988Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:06:50.998741Z","caller":"traceutil/trace.go:171","msg":"trace[593580584] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"217.316527ms","start":"2026-04-22T06:06:50.78139Z","end":"2026-04-22T06:06:50.998706Z","steps":["trace[593580584] 'process raft request' (duration: 216.514028ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:53.114186Z","caller":"traceutil/trace.go:171","msg":"trace[1790053348] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"119.513716ms","start":"2026-04-22T06:06:52.994603Z","end":"2026-04-22T06:06:53.114117Z","steps":["trace[1790053348] 'process raft request' (duration: 118.931131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:53.660983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.743602ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:06:53.661193Z","caller":"traceutil/trace.go:171","msg":"trace[263676104] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"418.944919ms","start":"2026-04-22T06:06:53.242232Z","end":"2026-04-22T06:06:53.661177Z","steps":["trace[263676104] 'read index received' (duration: 197.551842ms)","trace[263676104] 'applied index is now lower than readState.Index' (duration: 221.392087ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:06:53.661331Z","caller":"traceutil/trace.go:171","msg":"trace[1252856924] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"484.772855ms","start":"2026-04-22T06:06:53.176496Z","end":"2026-04-22T06:06:53.661268Z","steps":["trace[1252856924] 'process raft request' (duration: 484.622352ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:53.661359Z","caller":"traceutil/trace.go:171","msg":"trace[1206874822] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"526.934581ms","start":"2026-04-22T06:06:53.134388Z","end":"2026-04-22T06:06:53.661323Z","steps":["trace[1206874822] 'process raft request' (duration: 305.249066ms)","trace[1206874822] 'compare' (duration: 220.617729ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:06:53.661518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:53.134367Z","time spent":"527.081545ms","remote":"127.0.0.1:60406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:06:53.66139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.160485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-22T06:06:53.661602Z","caller":"traceutil/trace.go:171","msg":"trace[1281042201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:617; }","duration":"419.410911ms","start":"2026-04-22T06:06:53.242179Z","end":"2026-04-22T06:06:53.661589Z","steps":["trace[1281042201] 'agreement among raft nodes before linearized reading' (duration: 419.047212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:53.661604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:53.176464Z","time spent":"484.973371ms","remote":"127.0.0.1:60680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T06:06:53.661648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:53.242116Z","time spent":"419.519053ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-22T06:06:55.223057Z","caller":"traceutil/trace.go:171","msg":"trace[130972738] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"113.790444ms","start":"2026-04-22T06:06:55.109244Z","end":"2026-04-22T06:06:55.223035Z","steps":["trace[130972738] 'process raft request' (duration: 113.6599ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:55.544202Z","caller":"traceutil/trace.go:171","msg":"trace[1230754430] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"217.215796ms","start":"2026-04-22T06:06:55.326955Z","end":"2026-04-22T06:06:55.544171Z","steps":["trace[1230754430] 'process raft request' (duration: 217.123264ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:55.544432Z","caller":"traceutil/trace.go:171","msg":"trace[95456531] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"220.665779ms","start":"2026-04-22T06:06:55.323742Z","end":"2026-04-22T06:06:55.544408Z","steps":["trace[95456531] 'process raft request' (duration: 188.986042ms)","trace[95456531] 'compare' (duration: 31.174605ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:06:55.550821Z","caller":"traceutil/trace.go:171","msg":"trace[10983751] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:667; }","duration":"117.602888ms","start":"2026-04-22T06:06:55.433202Z","end":"2026-04-22T06:06:55.550804Z","steps":["trace[10983751] 'read index received' (duration: 79.508433ms)","trace[10983751] 'applied index is now lower than readState.Index' (duration: 38.093625ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:06:55.550976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.763742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:06:55.551032Z","caller":"traceutil/trace.go:171","msg":"trace[1805497353] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:647; }","duration":"117.869144ms","start":"2026-04-22T06:06:55.433143Z","end":"2026-04-22T06:06:55.551012Z","steps":["trace[1805497353] 'agreement among raft nodes before linearized reading' (duration: 117.742261ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:55.551194Z","caller":"traceutil/trace.go:171","msg":"trace[1677722629] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"203.774035ms","start":"2026-04-22T06:06:55.347399Z","end":"2026-04-22T06:06:55.551173Z","steps":["trace[1677722629] 'process raft request' (duration: 203.310753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:56.009073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.202019ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:06:56.009212Z","caller":"traceutil/trace.go:171","msg":"trace[787128623] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"456.736397ms","start":"2026-04-22T06:06:55.552443Z","end":"2026-04-22T06:06:56.00918Z","steps":["trace[787128623] 'process raft request' (duration: 170.329613ms)","trace[787128623] 'compare' (duration: 286.028365ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:06:56.009304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:55.55242Z","time spent":"456.83547ms","remote":"127.0.0.1:60282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5162,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:06:56.011253Z","caller":"traceutil/trace.go:171","msg":"trace[232758717] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"457.423815ms","start":"2026-04-22T06:06:55.553809Z","end":"2026-04-22T06:06:56.011232Z","steps":["trace[232758717] 'process raft request' (duration: 457.066156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:56.011354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:55.553794Z","time spent":"457.504967ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4387,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:06:56.011955Z","caller":"traceutil/trace.go:171","msg":"trace[116351534] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:670; }","duration":"379.295935ms","start":"2026-04-22T06:06:55.632638Z","end":"2026-04-22T06:06:56.011934Z","steps":["trace[116351534] 'read index received' (duration: 90.029801ms)","trace[116351534] 'applied index is now lower than readState.Index' (duration: 289.264954ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:06:56.011975Z","caller":"traceutil/trace.go:171","msg":"trace[1729580943] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"452.663168ms","start":"2026-04-22T06:06:55.559293Z","end":"2026-04-22T06:06:56.011956Z","steps":["trace[1729580943] 'process raft request' (duration: 452.412771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:56.012275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:55.559271Z","time spent":"452.944495ms","remote":"127.0.0.1:60300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T06:06:56.012112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.468799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:06:56.012554Z","caller":"traceutil/trace.go:171","msg":"trace[1685890256] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:650; }","duration":"379.878279ms","start":"2026-04-22T06:06:55.632587Z","end":"2026-04-22T06:06:56.012465Z","steps":["trace[1685890256] 'agreement among raft nodes before linearized reading' (duration: 379.437458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:56.012696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:55.632565Z","time spent":"380.041413ms","remote":"127.0.0.1:60282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-04-22T06:06:56.059338Z","caller":"traceutil/trace.go:171","msg":"trace[1562976067] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"222.943406ms","start":"2026-04-22T06:06:55.836357Z","end":"2026-04-22T06:06:56.0593Z","steps":["trace[1562976067] 'process raft request' (duration: 222.66958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:56.059426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.396693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-22T06:06:56.05941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.605554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T06:06:56.059613Z","caller":"traceutil/trace.go:171","msg":"trace[238699354] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:651; }","duration":"276.853649ms","start":"2026-04-22T06:06:55.78274Z","end":"2026-04-22T06:06:56.059593Z","steps":["trace[238699354] 'agreement among raft nodes before linearized reading' (duration: 276.47202ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:56.059643Z","caller":"traceutil/trace.go:171","msg":"trace[1167678445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:651; }","duration":"301.475295ms","start":"2026-04-22T06:06:55.758008Z","end":"2026-04-22T06:06:56.059483Z","steps":["trace[1167678445] 'agreement among raft nodes before linearized reading' (duration: 301.256849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:56.059815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:55.757918Z","time spent":"301.817403ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T06:06:56.059961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.326806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-22T06:06:56.060015Z","caller":"traceutil/trace.go:171","msg":"trace[1325865814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:651; }","duration":"379.402217ms","start":"2026-04-22T06:06:55.680598Z","end":"2026-04-22T06:06:56.06Z","steps":["trace[1325865814] 'agreement among raft nodes before linearized reading' (duration: 378.579197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:56.06005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:55.680585Z","time spent":"379.456619ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-22T06:06:56.638694Z","caller":"traceutil/trace.go:171","msg":"trace[1899462706] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"156.892314ms","start":"2026-04-22T06:06:56.481783Z","end":"2026-04-22T06:06:56.638675Z","steps":["trace[1899462706] 'process raft request' (duration: 127.85678ms)","trace[1899462706] 'compare' (duration: 28.958392ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:06:56.678703Z","caller":"traceutil/trace.go:171","msg":"trace[59395841] linearizableReadLoop","detail":"{readStateIndex:696; appliedIndex:694; }","duration":"120.684934ms","start":"2026-04-22T06:06:56.558Z","end":"2026-04-22T06:06:56.678685Z","steps":["trace[59395841] 'read index received' (duration: 51.651058ms)","trace[59395841] 'applied index is now lower than readState.Index' (duration: 69.032726ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:06:56.678864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.809737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:06:56.67889Z","caller":"traceutil/trace.go:171","msg":"trace[1086732793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:672; }","duration":"120.92712ms","start":"2026-04-22T06:06:56.557955Z","end":"2026-04-22T06:06:56.678882Z","steps":["trace[1086732793] 'agreement among raft nodes before linearized reading' (duration: 120.800287ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:56.678827Z","caller":"traceutil/trace.go:171","msg":"trace[1247810073] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"188.817126ms","start":"2026-04-22T06:06:56.489962Z","end":"2026-04-22T06:06:56.678779Z","steps":["trace[1247810073] 'process raft request' (duration: 188.623112ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:56.836585Z","caller":"traceutil/trace.go:171","msg":"trace[114440033] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"156.224136ms","start":"2026-04-22T06:06:56.680335Z","end":"2026-04-22T06:06:56.836559Z","steps":["trace[114440033] 'read index received' (duration: 85.385347ms)","trace[114440033] 'applied index is now lower than readState.Index' (duration: 70.837859ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:06:56.836776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.41778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:06:56.836806Z","caller":"traceutil/trace.go:171","msg":"trace[2064181845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:673; }","duration":"156.503883ms","start":"2026-04-22T06:06:56.680294Z","end":"2026-04-22T06:06:56.836798Z","steps":["trace[2064181845] 'agreement among raft nodes before linearized reading' (duration: 156.364449ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:56.837051Z","caller":"traceutil/trace.go:171","msg":"trace[2030095539] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"201.747845ms","start":"2026-04-22T06:06:56.635274Z","end":"2026-04-22T06:06:56.837022Z","steps":["trace[2030095539] 'process raft request' (duration: 130.451334ms)","trace[2030095539] 'compare' (duration: 70.713746ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:06:57.013193Z","caller":"traceutil/trace.go:171","msg":"trace[1557126915] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"170.011045ms","start":"2026-04-22T06:06:56.842713Z","end":"2026-04-22T06:06:57.012724Z","steps":["trace[1557126915] 'process raft request' (duration: 166.853947ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:57.259413Z","caller":"traceutil/trace.go:171","msg":"trace[2133863410] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"148.415436ms","start":"2026-04-22T06:06:57.110967Z","end":"2026-04-22T06:06:57.259382Z","steps":["trace[2133863410] 'process raft request' (duration: 145.155996ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:57.259644Z","caller":"traceutil/trace.go:171","msg":"trace[597228367] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"149.04515ms","start":"2026-04-22T06:06:57.110575Z","end":"2026-04-22T06:06:57.25962Z","steps":["trace[597228367] 'process raft request' (duration: 148.753113ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:57.609583Z","caller":"traceutil/trace.go:171","msg":"trace[131229664] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"336.788901ms","start":"2026-04-22T06:06:57.272753Z","end":"2026-04-22T06:06:57.609541Z","steps":["trace[131229664] 'process raft request' (duration: 336.34046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:57.609777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:57.272731Z","time spent":"336.933474ms","remote":"127.0.0.1:60282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9296,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:06:57.610382Z","caller":"traceutil/trace.go:171","msg":"trace[767258113] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"332.122517ms","start":"2026-04-22T06:06:57.278215Z","end":"2026-04-22T06:06:57.610338Z","steps":["trace[767258113] 'process raft request' (duration: 331.176513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:57.610638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:57.278197Z","time spent":"332.302521ms","remote":"127.0.0.1:60282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:06:57.734379Z","caller":"traceutil/trace.go:171","msg":"trace[2013367281] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:708; }","duration":"175.87357ms","start":"2026-04-22T06:06:57.558475Z","end":"2026-04-22T06:06:57.734348Z","steps":["trace[2013367281] 'read index received' (duration: 50.713436ms)","trace[2013367281] 'applied index is now lower than readState.Index' (duration: 125.159094ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:06:57.734513Z","caller":"traceutil/trace.go:171","msg":"trace[402850630] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"269.196721ms","start":"2026-04-22T06:06:57.465246Z","end":"2026-04-22T06:06:57.734443Z","steps":["trace[402850630] 'process raft request' (duration: 268.861343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:57.734596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.099565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:06:57.734978Z","caller":"traceutil/trace.go:171","msg":"trace[525040108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:687; }","duration":"176.461874ms","start":"2026-04-22T06:06:57.558465Z","end":"2026-04-22T06:06:57.734927Z","steps":["trace[525040108] 'agreement among raft nodes before linearized reading' (duration: 176.034513ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:57.768306Z","caller":"traceutil/trace.go:171","msg":"trace[287076953] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"146.766104ms","start":"2026-04-22T06:06:57.621449Z","end":"2026-04-22T06:06:57.768215Z","steps":["trace[287076953] 'process raft request' (duration: 146.528398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:57.768393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.467566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-04-22T06:06:57.768472Z","caller":"traceutil/trace.go:171","msg":"trace[723422251] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:688; }","duration":"135.594849ms","start":"2026-04-22T06:06:57.632857Z","end":"2026-04-22T06:06:57.768452Z","steps":["trace[723422251] 'agreement among raft nodes before linearized reading' (duration: 135.355094ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:59.157928Z","caller":"traceutil/trace.go:171","msg":"trace[1811718043] linearizableReadLoop","detail":"{readStateIndex:726; appliedIndex:725; }","duration":"105.523272ms","start":"2026-04-22T06:06:59.052387Z","end":"2026-04-22T06:06:59.15791Z","steps":["trace[1811718043] 'read index received' (duration: 105.312717ms)","trace[1811718043] 'applied index is now lower than readState.Index' (duration: 209.675µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:06:59.157965Z","caller":"traceutil/trace.go:171","msg":"trace[1431450739] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"105.601474ms","start":"2026-04-22T06:06:59.052334Z","end":"2026-04-22T06:06:59.157935Z","steps":["trace[1431450739] 'process raft request' (duration: 105.385798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:59.158042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.638225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:06:59.158077Z","caller":"traceutil/trace.go:171","msg":"trace[1649207666] 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:702; }","duration":"105.704666ms","start":"2026-04-22T06:06:59.052365Z","end":"2026-04-22T06:06:59.158069Z","steps":["trace[1649207666] 'agreement among raft nodes before linearized reading' (duration: 105.635154ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:06.338952Z","caller":"traceutil/trace.go:171","msg":"trace[1457972041] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:785; }","duration":"193.647686ms","start":"2026-04-22T06:07:06.145276Z","end":"2026-04-22T06:07:06.338924Z","steps":["trace[1457972041] 'read index received' (duration: 193.518883ms)","trace[1457972041] 'applied index is now lower than readState.Index' (duration: 127.313µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:07:06.339131Z","caller":"traceutil/trace.go:171","msg":"trace[1045788024] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"194.543708ms","start":"2026-04-22T06:07:06.144546Z","end":"2026-04-22T06:07:06.33909Z","steps":["trace[1045788024] 'process raft request' (duration: 194.19477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:06.339238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.948193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T06:07:06.339316Z","caller":"traceutil/trace.go:171","msg":"trace[2090261952] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:760; }","duration":"194.036566ms","start":"2026-04-22T06:07:06.145262Z","end":"2026-04-22T06:07:06.339299Z","steps":["trace[2090261952] 'agreement among raft nodes before linearized reading' (duration: 193.84917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:06.33931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.104124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-22T06:07:06.339323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.115873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T06:07:06.339387Z","caller":"traceutil/trace.go:171","msg":"trace[223100751] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:760; }","duration":"156.229898ms","start":"2026-04-22T06:07:06.183139Z","end":"2026-04-22T06:07:06.339369Z","steps":["trace[223100751] 'agreement among raft nodes before linearized reading' (duration: 155.988231ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:06.339399Z","caller":"traceutil/trace.go:171","msg":"trace[1651810420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:760; }","duration":"114.237376ms","start":"2026-04-22T06:07:06.225145Z","end":"2026-04-22T06:07:06.339383Z","steps":["trace[1651810420] 'agreement among raft nodes before linearized reading' (duration: 114.03069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:09.872117Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605828148991287154,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T06:07:10.111441Z","caller":"traceutil/trace.go:171","msg":"trace[490542409] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"740.146897ms","start":"2026-04-22T06:07:09.371272Z","end":"2026-04-22T06:07:10.111419Z","steps":["trace[490542409] 'read index received' (duration: 739.947062ms)","trace[490542409] 'applied index is now lower than readState.Index' (duration: 199.005µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:07:10.111618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.327701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T06:07:10.111584Z","caller":"traceutil/trace.go:171","msg":"trace[932781585] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"931.683442ms","start":"2026-04-22T06:07:09.17981Z","end":"2026-04-22T06:07:10.111494Z","steps":["trace[932781585] 'process raft request' (duration: 931.484027ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:10.11165Z","caller":"traceutil/trace.go:171","msg":"trace[1160043171] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:782; }","duration":"740.407383ms","start":"2026-04-22T06:07:09.371233Z","end":"2026-04-22T06:07:10.111641Z","steps":["trace[1160043171] 'agreement among raft nodes before linearized reading' (duration: 740.26954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:10.111683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:09.371217Z","time spent":"740.457355ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-22T06:07:10.111955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:09.179791Z","time spent":"931.883957ms","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:07:14.465834Z","caller":"traceutil/trace.go:171","msg":"trace[2083368331] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"234.53689ms","start":"2026-04-22T06:07:14.231275Z","end":"2026-04-22T06:07:14.465812Z","steps":["trace[2083368331] 'process raft request' (duration: 144.762095ms)","trace[2083368331] 'compare' (duration: 89.694173ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:07:14.46797Z","caller":"traceutil/trace.go:171","msg":"trace[695077398] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"165.70792ms","start":"2026-04-22T06:07:14.302245Z","end":"2026-04-22T06:07:14.467953Z","steps":["trace[695077398] 'process raft request' (duration: 165.595897ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:44.920957Z","caller":"traceutil/trace.go:171","msg":"trace[314860895] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1035; }","duration":"296.232352ms","start":"2026-04-22T06:07:44.624693Z","end":"2026-04-22T06:07:44.920926Z","steps":["trace[314860895] 'read index received' (duration: 296.191811ms)","trace[314860895] 'applied index is now lower than readState.Index' (duration: 39.481µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:07:44.921128Z","caller":"traceutil/trace.go:171","msg":"trace[2053703929] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"559.142994ms","start":"2026-04-22T06:07:44.361909Z","end":"2026-04-22T06:07:44.921052Z","steps":["trace[2053703929] 'process raft request' (duration: 558.863757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:44.921211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.497578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T06:07:44.921251Z","caller":"traceutil/trace.go:171","msg":"trace[1456995207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:999; }","duration":"296.599671ms","start":"2026-04-22T06:07:44.624639Z","end":"2026-04-22T06:07:44.921238Z","steps":["trace[1456995207] 'agreement among raft nodes before linearized reading' (duration: 296.443157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:44.921299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:44.361893Z","time spent":"559.313868ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:07:45.126035Z","caller":"traceutil/trace.go:171","msg":"trace[1855386104] linearizableReadLoop","detail":"{readStateIndex:1037; appliedIndex:1036; }","duration":"204.961733ms","start":"2026-04-22T06:07:44.921051Z","end":"2026-04-22T06:07:45.126013Z","steps":["trace[1855386104] 'read index received' (duration: 204.860941ms)","trace[1855386104] 'applied index is now lower than readState.Index' (duration: 99.492µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:07:45.126274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.715506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-22T06:07:45.1263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.288648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T06:07:45.126369Z","caller":"traceutil/trace.go:171","msg":"trace[1819407330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1000; }","duration":"431.839159ms","start":"2026-04-22T06:07:44.694503Z","end":"2026-04-22T06:07:45.126343Z","steps":["trace[1819407330] 'agreement among raft nodes before linearized reading' (duration: 431.544632ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:45.126073Z","caller":"traceutil/trace.go:171","msg":"trace[1827419156] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"406.444161ms","start":"2026-04-22T06:07:44.719599Z","end":"2026-04-22T06:07:45.126044Z","steps":["trace[1827419156] 'process raft request' (duration: 406.257856ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:45.126381Z","caller":"traceutil/trace.go:171","msg":"trace[408032600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1000; }","duration":"434.38943ms","start":"2026-04-22T06:07:44.69197Z","end":"2026-04-22T06:07:45.12636Z","steps":["trace[408032600] 'agreement among raft nodes before linearized reading' (duration: 434.115694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:45.126396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.507771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-22T06:07:45.12642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:44.694491Z","time spent":"431.918281ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T06:07:45.126434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:44.691965Z","time spent":"434.460293ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-22T06:07:45.12644Z","caller":"traceutil/trace.go:171","msg":"trace[1258319025] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1000; }","duration":"438.589602ms","start":"2026-04-22T06:07:44.687836Z","end":"2026-04-22T06:07:45.126426Z","steps":["trace[1258319025] 'agreement among raft nodes before linearized reading' (duration: 438.283165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:45.126482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:44.687822Z","time spent":"438.645214ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T06:07:45.126496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:07:44.719589Z","time spent":"406.834601ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:07:45.127174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.765182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T06:07:45.12722Z","caller":"traceutil/trace.go:171","msg":"trace[804148255] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1001; }","duration":"156.849173ms","start":"2026-04-22T06:07:44.97036Z","end":"2026-04-22T06:07:45.12721Z","steps":["trace[804148255] 'agreement among raft nodes before linearized reading' (duration: 156.723179ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:45.127575Z","caller":"traceutil/trace.go:171","msg":"trace[2127642261] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"197.915802ms","start":"2026-04-22T06:07:44.929604Z","end":"2026-04-22T06:07:45.12752Z","steps":["trace[2127642261] 'process raft request' (duration: 197.413629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:06.966517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.633352ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-22T06:08:06.966615Z","caller":"traceutil/trace.go:171","msg":"trace[626053027] linearizableReadLoop","detail":"{readStateIndex:1113; appliedIndex:1112; }","duration":"409.112815ms","start":"2026-04-22T06:08:06.557485Z","end":"2026-04-22T06:08:06.966598Z","steps":["trace[626053027] 'read index received' (duration: 144.36993ms)","trace[626053027] 'applied index is now lower than readState.Index' (duration: 264.741275ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:06.96678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.294471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:06.966817Z","caller":"traceutil/trace.go:171","msg":"trace[321464263] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1071; }","duration":"409.373012ms","start":"2026-04-22T06:08:06.557435Z","end":"2026-04-22T06:08:06.966808Z","steps":["trace[321464263] 'agreement among raft nodes before linearized reading' (duration: 409.30214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:06.966818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.615856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-22T06:08:06.966851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:06.557415Z","time spent":"409.428333ms","remote":"127.0.0.1:43126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-22T06:08:06.966865Z","caller":"traceutil/trace.go:171","msg":"trace[261835720] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1071; }","duration":"165.715179ms","start":"2026-04-22T06:08:06.801137Z","end":"2026-04-22T06:08:06.966853Z","steps":["trace[261835720] 'agreement among raft nodes before linearized reading' (duration: 165.602976ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:07.223143Z","caller":"traceutil/trace.go:171","msg":"trace[67564975] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"182.059686ms","start":"2026-04-22T06:08:07.041061Z","end":"2026-04-22T06:08:07.22312Z","steps":["trace[67564975] 'process raft request' (duration: 181.918353ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:07.328714Z","caller":"traceutil/trace.go:171","msg":"trace[1784053710] linearizableReadLoop","detail":"{readStateIndex:1115; appliedIndex:1113; }","duration":"112.927846ms","start":"2026-04-22T06:08:07.21576Z","end":"2026-04-22T06:08:07.328688Z","steps":["trace[1784053710] 'read index received' (duration: 7.232436ms)","trace[1784053710] 'applied index is now lower than readState.Index' (duration: 105.69438ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:07.328813Z","caller":"traceutil/trace.go:171","msg":"trace[1723512625] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"121.787651ms","start":"2026-04-22T06:08:07.206999Z","end":"2026-04-22T06:08:07.328787Z","steps":["trace[1723512625] 'process raft request' (duration: 100.026842ms)","trace[1723512625] 'compare' (duration: 21.535624ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:07.329086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.308315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-22T06:08:07.329156Z","caller":"traceutil/trace.go:171","msg":"trace[172055268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1073; }","duration":"113.424628ms","start":"2026-04-22T06:08:07.215715Z","end":"2026-04-22T06:08:07.32914Z","steps":["trace[172055268] 'agreement among raft nodes before linearized reading' (duration: 113.232093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:07.329343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.706838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-22T06:08:07.329393Z","caller":"traceutil/trace.go:171","msg":"trace[667788616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1073; }","duration":"100.77821ms","start":"2026-04-22T06:08:07.228603Z","end":"2026-04-22T06:08:07.329382Z","steps":["trace[667788616] 'agreement among raft nodes before linearized reading' (duration: 100.659888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:07.329511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.940272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T06:08:07.32957Z","caller":"traceutil/trace.go:171","msg":"trace[1534426294] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1073; }","duration":"110.035254ms","start":"2026-04-22T06:08:07.219521Z","end":"2026-04-22T06:08:07.329556Z","steps":["trace[1534426294] 'agreement among raft nodes before linearized reading' (duration: 109.894361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:07.32985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.339792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T06:08:07.329911Z","caller":"traceutil/trace.go:171","msg":"trace[273235361] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1073; }","duration":"110.414623ms","start":"2026-04-22T06:08:07.219474Z","end":"2026-04-22T06:08:07.329888Z","steps":["trace[273235361] 'agreement among raft nodes before linearized reading' (duration: 109.499662ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:07.498953Z","caller":"traceutil/trace.go:171","msg":"trace[418952295] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"164.831026ms","start":"2026-04-22T06:08:07.33409Z","end":"2026-04-22T06:08:07.498921Z","steps":["trace[418952295] 'process raft request' (duration: 164.517469ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:07.498963Z","caller":"traceutil/trace.go:171","msg":"trace[1860237376] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"164.814465ms","start":"2026-04-22T06:08:07.334123Z","end":"2026-04-22T06:08:07.498937Z","steps":["trace[1860237376] 'process raft request' (duration: 164.711263ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:07.499146Z","caller":"traceutil/trace.go:171","msg":"trace[1271621721] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"164.94438ms","start":"2026-04-22T06:08:07.334191Z","end":"2026-04-22T06:08:07.499136Z","steps":["trace[1271621721] 'process raft request' (duration: 164.685543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:07.764354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.711902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T06:08:07.764446Z","caller":"traceutil/trace.go:171","msg":"trace[1418245097] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1077; }","duration":"124.868626ms","start":"2026-04-22T06:08:07.63956Z","end":"2026-04-22T06:08:07.764429Z","steps":["trace[1418245097] 'count revisions from in-memory index tree' (duration: 124.618939ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:09.613152Z","caller":"traceutil/trace.go:171","msg":"trace[373032332] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"383.839683ms","start":"2026-04-22T06:08:09.229287Z","end":"2026-04-22T06:08:09.613127Z","steps":["trace[373032332] 'process raft request' (duration: 383.686639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:09.613326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:09.229264Z","time spent":"383.973636ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:08:09.626479Z","caller":"traceutil/trace.go:171","msg":"trace[524338578] linearizableReadLoop","detail":"{readStateIndex:1121; appliedIndex:1120; }","duration":"257.490731ms","start":"2026-04-22T06:08:09.368964Z","end":"2026-04-22T06:08:09.626455Z","steps":["trace[524338578] 'read index received' (duration: 244.215698ms)","trace[524338578] 'applied index is now lower than readState.Index' (duration: 13.273733ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:09.62676Z","caller":"traceutil/trace.go:171","msg":"trace[1087977141] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"292.117872ms","start":"2026-04-22T06:08:09.334629Z","end":"2026-04-22T06:08:09.626747Z","steps":["trace[1087977141] 'process raft request' (duration: 291.699602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:09.626845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.85825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-22T06:08:09.62687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.869846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:09.626921Z","caller":"traceutil/trace.go:171","msg":"trace[1921959389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1079; }","duration":"257.982723ms","start":"2026-04-22T06:08:09.368919Z","end":"2026-04-22T06:08:09.626902Z","steps":["trace[1921959389] 'agreement among raft nodes before linearized reading' (duration: 257.744807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:09.626917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.83203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T06:08:09.626952Z","caller":"traceutil/trace.go:171","msg":"trace[1939390500] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1079; }","duration":"166.991319ms","start":"2026-04-22T06:08:09.459942Z","end":"2026-04-22T06:08:09.626933Z","steps":["trace[1939390500] 'agreement among raft nodes before linearized reading' (duration: 166.867156ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:09.626989Z","caller":"traceutil/trace.go:171","msg":"trace[2099614415] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1079; }","duration":"123.950943ms","start":"2026-04-22T06:08:09.503019Z","end":"2026-04-22T06:08:09.62697Z","steps":["trace[2099614415] 'agreement among raft nodes before linearized reading' (duration: 123.762239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:09.627026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.041755ms","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-04-22T06:08:09.627039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.032765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T06:08:09.627079Z","caller":"traceutil/trace.go:171","msg":"trace[318257790] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1079; }","duration":"124.129957ms","start":"2026-04-22T06:08:09.502935Z","end":"2026-04-22T06:08:09.627065Z","steps":["trace[318257790] 'agreement among raft nodes before linearized reading' (duration: 123.962463ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:09.627113Z","caller":"traceutil/trace.go:171","msg":"trace[933697884] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1079; }","duration":"124.119167ms","start":"2026-04-22T06:08:09.502975Z","end":"2026-04-22T06:08:09.627094Z","steps":["trace[933697884] 'agreement among raft nodes before linearized reading' (duration: 123.887372ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:09.73638Z","caller":"traceutil/trace.go:171","msg":"trace[326570049] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"103.516836ms","start":"2026-04-22T06:08:09.632829Z","end":"2026-04-22T06:08:09.736346Z","steps":["trace[326570049] 'process raft request' (duration: 103.365983ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:09.736363Z","caller":"traceutil/trace.go:171","msg":"trace[1505025334] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"104.139382ms","start":"2026-04-22T06:08:09.632183Z","end":"2026-04-22T06:08:09.736323Z","steps":["trace[1505025334] 'process raft request' (duration: 103.972638ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:09.73661Z","caller":"traceutil/trace.go:171","msg":"trace[674565109] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"104.358057ms","start":"2026-04-22T06:08:09.632096Z","end":"2026-04-22T06:08:09.736454Z","steps":["trace[674565109] 'process raft request' (duration: 49.027152ms)","trace[674565109] 'compare' (duration: 54.897405ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:11.674735Z","caller":"traceutil/trace.go:171","msg":"trace[2098503069] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1126; }","duration":"116.42749ms","start":"2026-04-22T06:08:11.558288Z","end":"2026-04-22T06:08:11.674716Z","steps":["trace[2098503069] 'read index received' (duration: 116.370429ms)","trace[2098503069] 'applied index is now lower than readState.Index' (duration: 56.021µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:11.674926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.618025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:11.675028Z","caller":"traceutil/trace.go:171","msg":"trace[393533352] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1084; }","duration":"116.756878ms","start":"2026-04-22T06:08:11.558236Z","end":"2026-04-22T06:08:11.674993Z","steps":["trace[393533352] 'agreement among raft nodes before linearized reading' (duration: 116.567413ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:11.675302Z","caller":"traceutil/trace.go:171","msg":"trace[942047513] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"339.698009ms","start":"2026-04-22T06:08:11.335583Z","end":"2026-04-22T06:08:11.675281Z","steps":["trace[942047513] 'process raft request' (duration: 339.002072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:11.675406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:11.335564Z","time spent":"339.77609ms","remote":"127.0.0.1:60274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:08:11.834877Z","caller":"traceutil/trace.go:171","msg":"trace[721100284] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"102.945052ms","start":"2026-04-22T06:08:11.731911Z","end":"2026-04-22T06:08:11.834856Z","steps":["trace[721100284] 'process raft request' (duration: 102.899081ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:11.834926Z","caller":"traceutil/trace.go:171","msg":"trace[1559729] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"203.220679ms","start":"2026-04-22T06:08:11.63168Z","end":"2026-04-22T06:08:11.834901Z","steps":["trace[1559729] 'process raft request' (duration: 196.184659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:11.835185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.137719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-22T06:08:11.835224Z","caller":"traceutil/trace.go:171","msg":"trace[871418890] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1086; }","duration":"217.232901ms","start":"2026-04-22T06:08:11.617982Z","end":"2026-04-22T06:08:11.835215Z","steps":["trace[871418890] 'agreement among raft nodes before linearized reading' (duration: 216.992555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:11.835352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.371872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T06:08:11.835402Z","caller":"traceutil/trace.go:171","msg":"trace[43338839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1086; }","duration":"184.481504ms","start":"2026-04-22T06:08:11.650904Z","end":"2026-04-22T06:08:11.835386Z","steps":["trace[43338839] 'agreement among raft nodes before linearized reading' (duration: 184.32815ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:11.834926Z","caller":"traceutil/trace.go:171","msg":"trace[896037108] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1127; }","duration":"160.099082ms","start":"2026-04-22T06:08:11.674793Z","end":"2026-04-22T06:08:11.834893Z","steps":["trace[896037108] 'read index received' (duration: 153.115933ms)","trace[896037108] 'applied index is now lower than readState.Index' (duration: 6.981169ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:11.835654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.410975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:11.835689Z","caller":"traceutil/trace.go:171","msg":"trace[825274946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1086; }","duration":"159.476837ms","start":"2026-04-22T06:08:11.676202Z","end":"2026-04-22T06:08:11.835679Z","steps":["trace[825274946] 'agreement among raft nodes before linearized reading' (duration: 159.418296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:11.835729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.534687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:11.835775Z","caller":"traceutil/trace.go:171","msg":"trace[142293715] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1086; }","duration":"133.613328ms","start":"2026-04-22T06:08:11.702149Z","end":"2026-04-22T06:08:11.835762Z","steps":["trace[142293715] 'agreement among raft nodes before linearized reading' (duration: 133.532276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:11.835836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.220617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-04-22T06:08:11.835877Z","caller":"traceutil/trace.go:171","msg":"trace[483266602] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1086; }","duration":"158.31794ms","start":"2026-04-22T06:08:11.677547Z","end":"2026-04-22T06:08:11.835865Z","steps":["trace[483266602] 'agreement among raft nodes before linearized reading' (duration: 158.165376ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:22.132747Z","caller":"traceutil/trace.go:171","msg":"trace[1143993069] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"165.316389ms","start":"2026-04-22T06:08:21.967407Z","end":"2026-04-22T06:08:22.132724Z","steps":["trace[1143993069] 'process raft request' (duration: 159.033186ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:22.222684Z","caller":"traceutil/trace.go:171","msg":"trace[719776165] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"254.963828ms","start":"2026-04-22T06:08:21.967702Z","end":"2026-04-22T06:08:22.222666Z","steps":["trace[719776165] 'process raft request' (duration: 254.845405ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:22.223032Z","caller":"traceutil/trace.go:171","msg":"trace[894969279] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"255.093542ms","start":"2026-04-22T06:08:21.96791Z","end":"2026-04-22T06:08:22.223003Z","steps":["trace[894969279] 'process raft request' (duration: 254.727313ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:22.223133Z","caller":"traceutil/trace.go:171","msg":"trace[1550035909] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"255.03818ms","start":"2026-04-22T06:08:21.968084Z","end":"2026-04-22T06:08:22.223123Z","steps":["trace[1550035909] 'process raft request' (duration: 254.804724ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:22.223294Z","caller":"traceutil/trace.go:171","msg":"trace[1105930110] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"254.737323ms","start":"2026-04-22T06:08:21.968546Z","end":"2026-04-22T06:08:22.223283Z","steps":["trace[1105930110] 'process raft request' (duration: 254.539028ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:22.229879Z","caller":"traceutil/trace.go:171","msg":"trace[1912809190] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"100.701358ms","start":"2026-04-22T06:08:22.129148Z","end":"2026-04-22T06:08:22.229849Z","steps":["trace[1912809190] 'process raft request' (duration: 100.574245ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:24.426782Z","caller":"traceutil/trace.go:171","msg":"trace[1370081133] linearizableReadLoop","detail":"{readStateIndex:1223; appliedIndex:1222; }","duration":"290.402509ms","start":"2026-04-22T06:08:24.136354Z","end":"2026-04-22T06:08:24.426756Z","steps":["trace[1370081133] 'read index received' (duration: 290.164894ms)","trace[1370081133] 'applied index is now lower than readState.Index' (duration: 236.195µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:24.427064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.693626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-22T06:08:24.427104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.419984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-22T06:08:24.427152Z","caller":"traceutil/trace.go:171","msg":"trace[1699180662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1176; }","duration":"290.82287ms","start":"2026-04-22T06:08:24.136304Z","end":"2026-04-22T06:08:24.427127Z","steps":["trace[1699180662] 'agreement among raft nodes before linearized reading' (duration: 290.583805ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:24.42716Z","caller":"traceutil/trace.go:171","msg":"trace[1150228051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1176; }","duration":"198.549367ms","start":"2026-04-22T06:08:24.228598Z","end":"2026-04-22T06:08:24.427148Z","steps":["trace[1150228051] 'agreement among raft nodes before linearized reading' (duration: 198.314951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:24.427179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.820388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-22T06:08:24.427257Z","caller":"traceutil/trace.go:171","msg":"trace[1765686025] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1176; }","duration":"199.9389ms","start":"2026-04-22T06:08:24.227298Z","end":"2026-04-22T06:08:24.427236Z","steps":["trace[1765686025] 'agreement among raft nodes before linearized reading' (duration: 199.721695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:24.427294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.230303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T06:08:24.427401Z","caller":"traceutil/trace.go:171","msg":"trace[221779673] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1176; }","duration":"199.380086ms","start":"2026-04-22T06:08:24.228Z","end":"2026-04-22T06:08:24.42738Z","steps":["trace[221779673] 'agreement among raft nodes before linearized reading' (duration: 199.036028ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:24.426835Z","caller":"traceutil/trace.go:171","msg":"trace[1586028461] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"452.160772ms","start":"2026-04-22T06:08:23.974636Z","end":"2026-04-22T06:08:24.426797Z","steps":["trace[1586028461] 'process raft request' (duration: 451.972468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:24.427819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:23.974615Z","time spent":"453.137866ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:08:24.428519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.022902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T06:08:24.428582Z","caller":"traceutil/trace.go:171","msg":"trace[2074521611] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1176; }","duration":"201.614452ms","start":"2026-04-22T06:08:24.226952Z","end":"2026-04-22T06:08:24.428566Z","steps":["trace[2074521611] 'agreement among raft nodes before linearized reading' (duration: 199.944531ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:24.704887Z","caller":"traceutil/trace.go:171","msg":"trace[714154253] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"273.262393ms","start":"2026-04-22T06:08:24.431577Z","end":"2026-04-22T06:08:24.704839Z","steps":["trace[714154253] 'process raft request' (duration: 248.44037ms)","trace[714154253] 'compare' (duration: 24.523036ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:24.716193Z","caller":"traceutil/trace.go:171","msg":"trace[2048371837] linearizableReadLoop","detail":"{readStateIndex:1228; appliedIndex:1223; }","duration":"153.547782ms","start":"2026-04-22T06:08:24.562615Z","end":"2026-04-22T06:08:24.716163Z","steps":["trace[2048371837] 'read index received' (duration: 117.419845ms)","trace[2048371837] 'applied index is now lower than readState.Index' (duration: 36.126787ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:24.716217Z","caller":"traceutil/trace.go:171","msg":"trace[50789671] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"283.601325ms","start":"2026-04-22T06:08:24.432583Z","end":"2026-04-22T06:08:24.716184Z","steps":["trace[50789671] 'process raft request' (duration: 283.477652ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:24.716308Z","caller":"traceutil/trace.go:171","msg":"trace[1156161620] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"284.560638ms","start":"2026-04-22T06:08:24.431735Z","end":"2026-04-22T06:08:24.716296Z","steps":["trace[1156161620] 'process raft request' (duration: 284.134437ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:24.716371Z","caller":"traceutil/trace.go:171","msg":"trace[976464814] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"284.60088ms","start":"2026-04-22T06:08:24.431759Z","end":"2026-04-22T06:08:24.716359Z","steps":["trace[976464814] 'process raft request' (duration: 284.263681ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:24.716444Z","caller":"traceutil/trace.go:171","msg":"trace[854762325] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"283.060972ms","start":"2026-04-22T06:08:24.433376Z","end":"2026-04-22T06:08:24.716437Z","steps":["trace[854762325] 'process raft request' (duration: 282.744203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:24.716494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.860551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:24.716527Z","caller":"traceutil/trace.go:171","msg":"trace[1099992641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1181; }","duration":"153.941973ms","start":"2026-04-22T06:08:24.562575Z","end":"2026-04-22T06:08:24.716517Z","steps":["trace[1099992641] 'agreement among raft nodes before linearized reading' (duration: 153.868611ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:42.736864Z","caller":"traceutil/trace.go:171","msg":"trace[1990665535] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"102.333418ms","start":"2026-04-22T06:08:42.634496Z","end":"2026-04-22T06:08:42.736829Z","steps":["trace[1990665535] 'process raft request' (duration: 102.131933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:43.386305Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605828148991288208,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T06:08:43.887218Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605828148991288208,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T06:08:44.387843Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605828148991288208,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T06:08:44.660764Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.775690595s","expected-duration":"1s"} {"level":"info","ts":"2026-04-22T06:08:44.661241Z","caller":"traceutil/trace.go:171","msg":"trace[1617421142] linearizableReadLoop","detail":"{readStateIndex:1308; appliedIndex:1307; }","duration":"1.775676185s","start":"2026-04-22T06:08:42.885542Z","end":"2026-04-22T06:08:44.661218Z","steps":["trace[1617421142] 'read index received' (duration: 1.775520341s)","trace[1617421142] 'applied index is now lower than readState.Index' (duration: 155.124µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:44.661376Z","caller":"traceutil/trace.go:171","msg":"trace[970016934] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"1.776404623s","start":"2026-04-22T06:08:42.884961Z","end":"2026-04-22T06:08:44.661366Z","steps":["trace[970016934] 'process raft request' (duration: 1.776020513s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:44.661494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:42.884944Z","time spent":"1.776460744s","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:08:44.661569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.776007963s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-22T06:08:44.661618Z","caller":"traceutil/trace.go:171","msg":"trace[160529751] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1257; }","duration":"1.776095165s","start":"2026-04-22T06:08:42.885507Z","end":"2026-04-22T06:08:44.661602Z","steps":["trace[160529751] 'agreement among raft nodes before linearized reading' (duration: 1.77586708s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:44.661653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:42.885496Z","time spent":"1.776151696s","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T06:08:44.686916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.759937399s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T06:08:44.686988Z","caller":"traceutil/trace.go:171","msg":"trace[967272733] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1258; }","duration":"1.760079272s","start":"2026-04-22T06:08:42.926893Z","end":"2026-04-22T06:08:44.686972Z","steps":["trace[967272733] 'agreement among raft nodes before linearized reading' (duration: 1.759874257s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:44.687024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:42.92688Z","time spent":"1.760135823s","remote":"127.0.0.1:60472","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":"info","ts":"2026-04-22T06:08:44.687323Z","caller":"traceutil/trace.go:171","msg":"trace[2142806983] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"108.396368ms","start":"2026-04-22T06:08:44.578915Z","end":"2026-04-22T06:08:44.687311Z","steps":["trace[2142806983] 'process raft request' (duration: 107.756631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:44.687486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.113167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:44.687526Z","caller":"traceutil/trace.go:171","msg":"trace[884082573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1258; }","duration":"129.184428ms","start":"2026-04-22T06:08:44.55833Z","end":"2026-04-22T06:08:44.687514Z","steps":["trace[884082573] 'agreement among raft nodes before linearized reading' (duration: 129.127877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:44.68782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.128727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T06:08:44.688102Z","caller":"traceutil/trace.go:171","msg":"trace[2017312168] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1258; }","duration":"468.469185ms","start":"2026-04-22T06:08:44.21961Z","end":"2026-04-22T06:08:44.688079Z","steps":["trace[2017312168] 'agreement among raft nodes before linearized reading' (duration: 468.101936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:44.688142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.755098681s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-22T06:08:44.68834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:44.21959Z","time spent":"468.728562ms","remote":"127.0.0.1:50878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"info","ts":"2026-04-22T06:08:44.688431Z","caller":"traceutil/trace.go:171","msg":"trace[1435145833] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1258; }","duration":"1.755432989s","start":"2026-04-22T06:08:42.932945Z","end":"2026-04-22T06:08:44.688378Z","steps":["trace[1435145833] 'agreement among raft nodes before linearized reading' (duration: 1.754897476s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:44.68856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:42.93294Z","time spent":"1.755602033s","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T06:08:44.688013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.75507761s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-22T06:08:44.688779Z","caller":"traceutil/trace.go:171","msg":"trace[2056941144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1258; }","duration":"1.75585979s","start":"2026-04-22T06:08:42.932901Z","end":"2026-04-22T06:08:44.688761Z","steps":["trace[2056941144] 'agreement among raft nodes before linearized reading' (duration: 1.75504042s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:44.688844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:42.932891Z","time spent":"1.755935981s","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T06:08:44.925995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.256127ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:08:44.926405Z","caller":"traceutil/trace.go:171","msg":"trace[981109404] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"233.633218ms","start":"2026-04-22T06:08:44.692749Z","end":"2026-04-22T06:08:44.926382Z","steps":["trace[981109404] 'process raft request' (duration: 86.90273ms)","trace[981109404] 'compare' (duration: 146.124874ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:44.927056Z","caller":"traceutil/trace.go:171","msg":"trace[774162613] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"234.228143ms","start":"2026-04-22T06:08:44.692814Z","end":"2026-04-22T06:08:44.927043Z","steps":["trace[774162613] 'process raft request' (duration: 233.297641ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:44.927253Z","caller":"traceutil/trace.go:171","msg":"trace[1493930255] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"233.637268ms","start":"2026-04-22T06:08:44.693595Z","end":"2026-04-22T06:08:44.927232Z","steps":["trace[1493930255] 'process raft request' (duration: 233.273499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:45.450288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.520645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:45.450406Z","caller":"traceutil/trace.go:171","msg":"trace[1630841516] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1262; }","duration":"213.677148ms","start":"2026-04-22T06:08:45.2367Z","end":"2026-04-22T06:08:45.450377Z","steps":["trace[1630841516] 'count revisions from in-memory index tree' (duration: 213.427503ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:46.885166Z","caller":"traceutil/trace.go:171","msg":"trace[2098266434] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"483.853223ms","start":"2026-04-22T06:08:46.401293Z","end":"2026-04-22T06:08:46.885146Z","steps":["trace[2098266434] 'process raft request' (duration: 483.72947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:46.885283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:46.401269Z","time spent":"483.956086ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:08:47.594057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.7051ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-04-22T06:08:47.594101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.23693ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:47.594295Z","caller":"traceutil/trace.go:171","msg":"trace[1202448255] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1263; }","duration":"293.470036ms","start":"2026-04-22T06:08:47.300797Z","end":"2026-04-22T06:08:47.594267Z","steps":["trace[1202448255] 'range keys from in-memory index tree' (duration: 293.212079ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:47.59474Z","caller":"traceutil/trace.go:171","msg":"trace[1201872886] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1314; }","duration":"1.037206599s","start":"2026-04-22T06:08:46.557511Z","end":"2026-04-22T06:08:47.594718Z","steps":["trace[1201872886] 'read index received' (duration: 327.682744ms)","trace[1201872886] 'applied index is now lower than readState.Index' (duration: 709.522755ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:47.594817Z","caller":"traceutil/trace.go:171","msg":"trace[2009267893] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"715.155014ms","start":"2026-04-22T06:08:46.879634Z","end":"2026-04-22T06:08:47.594789Z","steps":["trace[2009267893] 'process raft request' (duration: 715.026471ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:47.594817Z","caller":"traceutil/trace.go:171","msg":"trace[941465413] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"900.109049ms","start":"2026-04-22T06:08:46.694663Z","end":"2026-04-22T06:08:47.594772Z","steps":["trace[941465413] 'process raft request' (duration: 899.528385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:47.594897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037378653s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:47.594953Z","caller":"traceutil/trace.go:171","msg":"trace[1975014973] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1265; }","duration":"1.037479626s","start":"2026-04-22T06:08:46.557457Z","end":"2026-04-22T06:08:47.594937Z","steps":["trace[1975014973] 'agreement among raft nodes before linearized reading' (duration: 1.037376683s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:47.59497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:46.879609Z","time spent":"715.281727ms","remote":"127.0.0.1:60300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T06:08:47.594984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:46.694638Z","time spent":"900.261662ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:08:47.595004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:46.557436Z","time spent":"1.037555438s","remote":"127.0.0.1:43126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T06:08:47.595565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"930.204626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T06:08:47.595616Z","caller":"traceutil/trace.go:171","msg":"trace[970407066] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1265; }","duration":"930.301219ms","start":"2026-04-22T06:08:46.665302Z","end":"2026-04-22T06:08:47.595603Z","steps":["trace[970407066] 'agreement among raft nodes before linearized reading' (duration: 930.150395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:47.595651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:46.665283Z","time spent":"930.3601ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-22T06:08:47.595895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.156173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-22T06:08:47.595934Z","caller":"traceutil/trace.go:171","msg":"trace[416464293] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1265; }","duration":"852.195593ms","start":"2026-04-22T06:08:46.743728Z","end":"2026-04-22T06:08:47.595924Z","steps":["trace[416464293] 'agreement among raft nodes before linearized reading' (duration: 852.094151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:47.595966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:46.743669Z","time spent":"852.291206ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T06:08:47.59604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.883961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-22T06:08:47.596111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.513697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T06:08:47.596129Z","caller":"traceutil/trace.go:171","msg":"trace[618353357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1265; }","duration":"665.017615ms","start":"2026-04-22T06:08:46.931094Z","end":"2026-04-22T06:08:47.596112Z","steps":["trace[618353357] 'agreement among raft nodes before linearized reading' (duration: 664.718228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:47.596197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:46.931076Z","time spent":"665.104428ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-22T06:08:47.596137Z","caller":"traceutil/trace.go:171","msg":"trace[351203932] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1265; }","duration":"665.539487ms","start":"2026-04-22T06:08:46.930589Z","end":"2026-04-22T06:08:47.596129Z","steps":["trace[351203932] 'agreement among raft nodes before linearized reading' (duration: 665.462486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:47.596356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:46.930539Z","time spent":"665.805545ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-22T06:08:47.596403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.169737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T06:08:47.596462Z","caller":"traceutil/trace.go:171","msg":"trace[516288841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1265; }","duration":"665.28038ms","start":"2026-04-22T06:08:46.931169Z","end":"2026-04-22T06:08:47.596449Z","steps":["trace[516288841] 'agreement among raft nodes before linearized reading' (duration: 665.076755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:47.596496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:46.931147Z","time spent":"665.340702ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T06:08:48.104657Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605828148991288225,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T06:08:48.463889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.746682ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:08:48.464005Z","caller":"traceutil/trace.go:171","msg":"trace[1487474225] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"864.911836ms","start":"2026-04-22T06:08:47.599073Z","end":"2026-04-22T06:08:48.463985Z","steps":["trace[1487474225] 'process raft request' (duration: 672.99381ms)","trace[1487474225] 'compare' (duration: 191.511276ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:48.464063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:47.599057Z","time spent":"864.978417ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:08:48.747711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.742239ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:08:48.747972Z","caller":"traceutil/trace.go:171","msg":"trace[1232089117] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1317; }","duration":"1.143379372s","start":"2026-04-22T06:08:47.604575Z","end":"2026-04-22T06:08:48.747954Z","steps":["trace[1232089117] 'read index received' (duration: 667.500134ms)","trace[1232089117] 'applied index is now lower than readState.Index' (duration: 475.877858ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:48.748059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143482555s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:48.748092Z","caller":"traceutil/trace.go:171","msg":"trace[1405457966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1270; }","duration":"1.143541466s","start":"2026-04-22T06:08:47.604541Z","end":"2026-04-22T06:08:48.748083Z","steps":["trace[1405457966] 'agreement among raft nodes before linearized reading' (duration: 1.143470284s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:48.748122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:47.604525Z","time spent":"1.143590438s","remote":"127.0.0.1:43126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-22T06:08:48.748124Z","caller":"traceutil/trace.go:171","msg":"trace[19445726] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"1.14739929s","start":"2026-04-22T06:08:47.600695Z","end":"2026-04-22T06:08:48.748094Z","steps":["trace[19445726] 'process raft request' (duration: 1.147104223s)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:48.748344Z","caller":"traceutil/trace.go:171","msg":"trace[1078309052] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"1.146806116s","start":"2026-04-22T06:08:47.601484Z","end":"2026-04-22T06:08:48.74829Z","steps":["trace[1078309052] 'process raft request' (duration: 1.146435497s)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:48.748356Z","caller":"traceutil/trace.go:171","msg":"trace[68200176] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"1.147579235s","start":"2026-04-22T06:08:47.600713Z","end":"2026-04-22T06:08:48.748293Z","steps":["trace[68200176] 'process raft request' (duration: 1.147163485s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:48.748527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:47.601469Z","time spent":"1.14696525s","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:08:48.748553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:47.600704Z","time spent":"1.147757099s","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:08:48.748396Z","caller":"traceutil/trace.go:171","msg":"trace[1731594925] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"1.148481198s","start":"2026-04-22T06:08:47.599858Z","end":"2026-04-22T06:08:48.748339Z","steps":["trace[1731594925] 'process raft request' (duration: 1.003035522s)","trace[1731594925] 'compare' (duration: 144.493433ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:48.748726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:47.599849Z","time spent":"1.148824996s","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:08:48.749111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:47.600673Z","time spent":"1.147590425s","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:08:50.218399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.435649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:50.2185Z","caller":"traceutil/trace.go:171","msg":"trace[1406643429] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1271; }","duration":"814.579841ms","start":"2026-04-22T06:08:49.403898Z","end":"2026-04-22T06:08:50.218477Z","steps":["trace[1406643429] 'range keys from in-memory index tree' (duration: 814.325145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:50.218542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:49.403875Z","time spent":"814.656904ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-22T06:08:50.218578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.152971ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:08:50.218692Z","caller":"traceutil/trace.go:171","msg":"trace[1010690731] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1323; }","duration":"202.463463ms","start":"2026-04-22T06:08:50.01621Z","end":"2026-04-22T06:08:50.218674Z","steps":["trace[1010690731] 'read index received' (duration: 64.931µs)","trace[1010690731] 'applied index is now lower than readState.Index' (duration: 202.397292ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:50.218758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.552556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T06:08:50.218792Z","caller":"traceutil/trace.go:171","msg":"trace[744204589] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1272; }","duration":"202.626868ms","start":"2026-04-22T06:08:50.016155Z","end":"2026-04-22T06:08:50.218782Z","steps":["trace[744204589] 'agreement among raft nodes before linearized reading' (duration: 202.570826ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:50.219131Z","caller":"traceutil/trace.go:171","msg":"trace[424168382] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"617.746955ms","start":"2026-04-22T06:08:49.60095Z","end":"2026-04-22T06:08:50.218697Z","steps":["trace[424168382] 'process raft request' (duration: 248.370028ms)","trace[424168382] 'compare' (duration: 368.973537ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:50.219464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:49.600919Z","time spent":"618.441412ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:08:50.452528Z","caller":"traceutil/trace.go:171","msg":"trace[1626148723] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"229.313012ms","start":"2026-04-22T06:08:50.223182Z","end":"2026-04-22T06:08:50.452495Z","steps":["trace[1626148723] 'process raft request' (duration: 229.009284ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:50.46025Z","caller":"traceutil/trace.go:171","msg":"trace[2079506602] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"191.30107ms","start":"2026-04-22T06:08:50.268926Z","end":"2026-04-22T06:08:50.460227Z","steps":["trace[2079506602] 'process raft request' (duration: 191.220498ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:50.636349Z","caller":"traceutil/trace.go:171","msg":"trace[905297443] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"172.704934ms","start":"2026-04-22T06:08:50.46361Z","end":"2026-04-22T06:08:50.636315Z","steps":["trace[905297443] 'process raft request' (duration: 156.882156ms)","trace[905297443] 'compare' (duration: 15.47578ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:50.636422Z","caller":"traceutil/trace.go:171","msg":"trace[1940647090] linearizableReadLoop","detail":"{readStateIndex:1329; appliedIndex:1326; }","duration":"168.281626ms","start":"2026-04-22T06:08:50.4681Z","end":"2026-04-22T06:08:50.636382Z","steps":["trace[1940647090] 'read index received' (duration: 76.141767ms)","trace[1940647090] 'applied index is now lower than readState.Index' (duration: 92.138619ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:50.63682Z","caller":"traceutil/trace.go:171","msg":"trace[1994510432] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"173.122714ms","start":"2026-04-22T06:08:50.463679Z","end":"2026-04-22T06:08:50.636801Z","steps":["trace[1994510432] 'process raft request' (duration: 172.577891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:50.636991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.87652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T06:08:50.637033Z","caller":"traceutil/trace.go:171","msg":"trace[715235937] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1277; }","duration":"168.950131ms","start":"2026-04-22T06:08:50.468069Z","end":"2026-04-22T06:08:50.637019Z","steps":["trace[715235937] 'agreement among raft nodes before linearized reading' (duration: 168.807508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:50.939638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.091642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-22T06:08:50.939733Z","caller":"traceutil/trace.go:171","msg":"trace[2139197247] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1278; }","duration":"186.214635ms","start":"2026-04-22T06:08:50.753494Z","end":"2026-04-22T06:08:50.939709Z","steps":["trace[2139197247] 'range keys from in-memory index tree' (duration: 185.951739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:50.939726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.315287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T06:08:50.939814Z","caller":"traceutil/trace.go:171","msg":"trace[1018451325] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1278; }","duration":"186.437411ms","start":"2026-04-22T06:08:50.753357Z","end":"2026-04-22T06:08:50.939795Z","steps":["trace[1018451325] 'range keys from in-memory index tree' (duration: 186.098132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:50.939843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.343288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T06:08:50.939897Z","caller":"traceutil/trace.go:171","msg":"trace[1867385079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1278; }","duration":"186.4112ms","start":"2026-04-22T06:08:50.753472Z","end":"2026-04-22T06:08:50.939883Z","steps":["trace[1867385079] 'range keys from in-memory index tree' (duration: 186.251076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:50.940155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.070147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-22T06:08:50.940241Z","caller":"traceutil/trace.go:171","msg":"trace[775202076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1278; }","duration":"187.228151ms","start":"2026-04-22T06:08:50.752993Z","end":"2026-04-22T06:08:50.940221Z","steps":["trace[775202076] 'range keys from in-memory index tree' (duration: 186.809041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:55.136902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.094548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-22T06:08:55.136903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.756888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-22T06:08:55.136956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.047537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T06:08:55.136982Z","caller":"traceutil/trace.go:171","msg":"trace[1252140907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1320; }","duration":"154.255161ms","start":"2026-04-22T06:08:54.982713Z","end":"2026-04-22T06:08:55.136968Z","steps":["trace[1252140907] 'range keys from in-memory index tree' (duration: 153.945494ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:55.137008Z","caller":"traceutil/trace.go:171","msg":"trace[1134399611] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1320; }","duration":"154.104558ms","start":"2026-04-22T06:08:54.982883Z","end":"2026-04-22T06:08:55.136988Z","steps":["trace[1134399611] 'range keys from in-memory index tree' (duration: 153.959465ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:55.137016Z","caller":"traceutil/trace.go:171","msg":"trace[632761845] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1320; }","duration":"157.919592ms","start":"2026-04-22T06:08:54.979064Z","end":"2026-04-22T06:08:55.136984Z","steps":["trace[632761845] 'range keys from in-memory index tree' (duration: 157.534503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:55.136928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.026231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T06:08:55.137183Z","caller":"traceutil/trace.go:171","msg":"trace[2061217708] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1320; }","duration":"155.312848ms","start":"2026-04-22T06:08:54.981845Z","end":"2026-04-22T06:08:55.137157Z","steps":["trace[2061217708] 'range keys from in-memory index tree' (duration: 154.856587ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:55.710354Z","caller":"traceutil/trace.go:171","msg":"trace[1840684672] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"568.838296ms","start":"2026-04-22T06:08:55.141488Z","end":"2026-04-22T06:08:55.710327Z","steps":["trace[1840684672] 'process raft request' (duration: 568.614031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:55.710548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:55.14146Z","time spent":"568.96888ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:08:55.73398Z","caller":"traceutil/trace.go:171","msg":"trace[828815906] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"592.448896ms","start":"2026-04-22T06:08:55.141508Z","end":"2026-04-22T06:08:55.733957Z","steps":["trace[828815906] 'process raft request' (duration: 592.22112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:55.734119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:55.141485Z","time spent":"592.560348ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:08:55.734222Z","caller":"traceutil/trace.go:171","msg":"trace[2053416617] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"592.65077ms","start":"2026-04-22T06:08:55.141519Z","end":"2026-04-22T06:08:55.73417Z","steps":["trace[2053416617] 'process raft request' (duration: 592.325442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:55.734331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:55.141503Z","time spent":"592.785524ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:08:55.734798Z","caller":"traceutil/trace.go:171","msg":"trace[1999122895] linearizableReadLoop","detail":"{readStateIndex:1377; appliedIndex:1373; }","duration":"456.593934ms","start":"2026-04-22T06:08:55.278186Z","end":"2026-04-22T06:08:55.73478Z","steps":["trace[1999122895] 'read index received' (duration: 431.97828ms)","trace[1999122895] 'applied index is now lower than readState.Index' (duration: 24.614574ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:55.735044Z","caller":"traceutil/trace.go:171","msg":"trace[1543105162] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"592.164898ms","start":"2026-04-22T06:08:55.142863Z","end":"2026-04-22T06:08:55.735028Z","steps":["trace[1543105162] 'process raft request' (duration: 591.057371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:55.735142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:55.142844Z","time spent":"592.248479ms","remote":"127.0.0.1:60472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:08:55.735407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.411517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-wlx9f\" ","response":"range_response_count:1 size:12642"} {"level":"warn","ts":"2026-04-22T06:08:55.735583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.392444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T06:08:55.735638Z","caller":"traceutil/trace.go:171","msg":"trace[1430786301] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1324; }","duration":"457.454575ms","start":"2026-04-22T06:08:55.278173Z","end":"2026-04-22T06:08:55.735628Z","steps":["trace[1430786301] 'agreement among raft nodes before linearized reading' (duration: 457.320832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:55.735666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:55.278086Z","time spent":"457.571478ms","remote":"127.0.0.1:60540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":70,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-04-22T06:08:55.735836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.198758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:55.735931Z","caller":"traceutil/trace.go:171","msg":"trace[416315324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1324; }","duration":"178.335872ms","start":"2026-04-22T06:08:55.557581Z","end":"2026-04-22T06:08:55.735917Z","steps":["trace[416315324] 'agreement among raft nodes before linearized reading' (duration: 178.217798ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:55.736115Z","caller":"traceutil/trace.go:171","msg":"trace[1158261179] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-wlx9f; range_end:; response_count:1; response_revision:1324; }","duration":"429.50614ms","start":"2026-04-22T06:08:55.305951Z","end":"2026-04-22T06:08:55.735458Z","steps":["trace[1158261179] 'agreement among raft nodes before linearized reading' (duration: 429.293795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:55.736189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:55.30592Z","time spent":"430.233629ms","remote":"127.0.0.1:60406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":12665,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-wlx9f\" "} {"level":"info","ts":"2026-04-22T06:09:27.092019Z","caller":"traceutil/trace.go:171","msg":"trace[834891203] transaction","detail":"{read_only:false; response_revision:1472; number_of_response:1; }","duration":"157.234186ms","start":"2026-04-22T06:09:26.934741Z","end":"2026-04-22T06:09:27.091975Z","steps":["trace[834891203] 'process raft request' (duration: 155.872022ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:09:27.233501Z","caller":"traceutil/trace.go:171","msg":"trace[651939462] linearizableReadLoop","detail":"{readStateIndex:1533; appliedIndex:1532; }","duration":"101.256462ms","start":"2026-04-22T06:09:27.132223Z","end":"2026-04-22T06:09:27.233479Z","steps":["trace[651939462] 'read index received' (duration: 101.097729ms)","trace[651939462] 'applied index is now lower than readState.Index' (duration: 157.563µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:09:27.233676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.424836ms","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:507"} {"level":"info","ts":"2026-04-22T06:09:27.233707Z","caller":"traceutil/trace.go:171","msg":"trace[47428743] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1473; }","duration":"101.506709ms","start":"2026-04-22T06:09:27.132192Z","end":"2026-04-22T06:09:27.233699Z","steps":["trace[47428743] 'agreement among raft nodes before linearized reading' (duration: 101.364855ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:09:27.233892Z","caller":"traceutil/trace.go:171","msg":"trace[2049200066] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"140.818972ms","start":"2026-04-22T06:09:27.093066Z","end":"2026-04-22T06:09:27.233885Z","steps":["trace[2049200066] 'process raft request' (duration: 140.275569ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:10:14.657551Z","caller":"traceutil/trace.go:171","msg":"trace[1051660069] transaction","detail":"{read_only:false; response_revision:1691; number_of_response:1; }","duration":"119.691183ms","start":"2026-04-22T06:10:14.537824Z","end":"2026-04-22T06:10:14.657515Z","steps":["trace[1051660069] 'process raft request' (duration: 119.244053ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:10:14.805303Z","caller":"traceutil/trace.go:171","msg":"trace[199296370] linearizableReadLoop","detail":"{readStateIndex:1761; appliedIndex:1760; }","duration":"146.699776ms","start":"2026-04-22T06:10:14.658578Z","end":"2026-04-22T06:10:14.805278Z","steps":["trace[199296370] 'read index received' (duration: 101.843997ms)","trace[199296370] 'applied index is now lower than readState.Index' (duration: 44.854779ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:10:14.805481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.645628ms","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-04-22T06:10:14.805445Z","caller":"traceutil/trace.go:171","msg":"trace[2094978869] transaction","detail":"{read_only:false; response_revision:1692; number_of_response:1; }","duration":"211.167876ms","start":"2026-04-22T06:10:14.59424Z","end":"2026-04-22T06:10:14.805408Z","steps":["trace[2094978869] 'process raft request' (duration: 166.259916ms)","trace[2094978869] 'compare' (duration: 44.684685ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:10:14.805513Z","caller":"traceutil/trace.go:171","msg":"trace[1965630986] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1692; }","duration":"136.69695ms","start":"2026-04-22T06:10:14.668807Z","end":"2026-04-22T06:10:14.805504Z","steps":["trace[1965630986] 'agreement among raft nodes before linearized reading' (duration: 136.601168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:10:14.805495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.89383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:10:14.805565Z","caller":"traceutil/trace.go:171","msg":"trace[2146088780] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1692; }","duration":"147.004623ms","start":"2026-04-22T06:10:14.658542Z","end":"2026-04-22T06:10:14.805546Z","steps":["trace[2146088780] 'agreement among raft nodes before linearized reading' (duration: 146.87456ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:10:27.49941Z","caller":"traceutil/trace.go:171","msg":"trace[1014569256] transaction","detail":"{read_only:false; response_revision:1749; number_of_response:1; }","duration":"102.645656ms","start":"2026-04-22T06:10:27.396726Z","end":"2026-04-22T06:10:27.499371Z","steps":["trace[1014569256] 'process raft request' (duration: 77.003918ms)","trace[1014569256] 'compare' (duration: 25.476604ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:10:28.624194Z","caller":"traceutil/trace.go:171","msg":"trace[1146825482] transaction","detail":"{read_only:false; response_revision:1752; number_of_response:1; }","duration":"141.805436ms","start":"2026-04-22T06:10:28.482357Z","end":"2026-04-22T06:10:28.624163Z","steps":["trace[1146825482] 'process raft request' (duration: 141.621081ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:10:28.666616Z","caller":"traceutil/trace.go:171","msg":"trace[975029123] transaction","detail":"{read_only:false; response_revision:1753; number_of_response:1; }","duration":"183.397075ms","start":"2026-04-22T06:10:28.483201Z","end":"2026-04-22T06:10:28.666598Z","steps":["trace[975029123] 'process raft request' (duration: 183.247031ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:10:28.666735Z","caller":"traceutil/trace.go:171","msg":"trace[1072079623] linearizableReadLoop","detail":"{readStateIndex:1826; appliedIndex:1823; }","duration":"154.291702ms","start":"2026-04-22T06:10:28.51242Z","end":"2026-04-22T06:10:28.666712Z","steps":["trace[1072079623] 'read index received' (duration: 111.604266ms)","trace[1072079623] 'applied index is now lower than readState.Index' (duration: 42.686416ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:10:28.666766Z","caller":"traceutil/trace.go:171","msg":"trace[2118523601] transaction","detail":"{read_only:false; response_revision:1754; number_of_response:1; }","duration":"183.226011ms","start":"2026-04-22T06:10:28.483518Z","end":"2026-04-22T06:10:28.666744Z","steps":["trace[2118523601] 'process raft request' (duration: 183.041837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:10:28.666934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.505156ms","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:534"} {"level":"info","ts":"2026-04-22T06:10:28.666974Z","caller":"traceutil/trace.go:171","msg":"trace[979294213] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1754; }","duration":"154.585868ms","start":"2026-04-22T06:10:28.512366Z","end":"2026-04-22T06:10:28.666952Z","steps":["trace[979294213] 'agreement among raft nodes before linearized reading' (duration: 154.446915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:10:28.666943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.984721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:10:28.667065Z","caller":"traceutil/trace.go:171","msg":"trace[1590724938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1754; }","duration":"109.142045ms","start":"2026-04-22T06:10:28.557885Z","end":"2026-04-22T06:10:28.667027Z","steps":["trace[1590724938] 'agreement among raft nodes before linearized reading' (duration: 108.961661ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:02.964024Z","caller":"traceutil/trace.go:171","msg":"trace[546988607] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"131.628207ms","start":"2026-04-22T06:11:02.832361Z","end":"2026-04-22T06:11:02.963989Z","steps":["trace[546988607] 'process raft request' (duration: 102.454186ms)","trace[546988607] 'compare' (duration: 28.859493ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:11:02.9706Z","caller":"traceutil/trace.go:171","msg":"trace[1543753777] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"101.050192ms","start":"2026-04-22T06:11:02.869514Z","end":"2026-04-22T06:11:02.970564Z","steps":["trace[1543753777] 'process raft request' (duration: 101.00029ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:02.970949Z","caller":"traceutil/trace.go:171","msg":"trace[413150348] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"136.477284ms","start":"2026-04-22T06:11:02.834441Z","end":"2026-04-22T06:11:02.970919Z","steps":["trace[413150348] 'process raft request' (duration: 135.926041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:11:08.954866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.568386ms","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:534"} {"level":"warn","ts":"2026-04-22T06:11:08.954968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.358592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T06:11:08.954999Z","caller":"traceutil/trace.go:171","msg":"trace[2091219914] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1935; }","duration":"106.738791ms","start":"2026-04-22T06:11:08.848233Z","end":"2026-04-22T06:11:08.954972Z","steps":["trace[2091219914] 'range keys from in-memory index tree' (duration: 106.390983ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:08.955052Z","caller":"traceutil/trace.go:171","msg":"trace[767610905] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1935; }","duration":"127.519386ms","start":"2026-04-22T06:11:08.827513Z","end":"2026-04-22T06:11:08.955032Z","steps":["trace[767610905] 'range keys from in-memory index tree' (duration: 127.185219ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:25.185493Z","caller":"traceutil/trace.go:171","msg":"trace[1938408396] transaction","detail":"{read_only:false; response_revision:2012; number_of_response:1; }","duration":"124.029232ms","start":"2026-04-22T06:11:25.061444Z","end":"2026-04-22T06:11:25.185474Z","steps":["trace[1938408396] 'process raft request' (duration: 79.63965ms)","trace[1938408396] 'compare' (duration: 44.114955ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:11:25.185843Z","caller":"traceutil/trace.go:171","msg":"trace[1327686248] transaction","detail":"{read_only:false; response_revision:2013; number_of_response:1; }","duration":"117.768109ms","start":"2026-04-22T06:11:25.06807Z","end":"2026-04-22T06:11:25.185838Z","steps":["trace[1327686248] 'process raft request' (duration: 117.301248ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:31.425732Z","caller":"traceutil/trace.go:171","msg":"trace[1212273628] linearizableReadLoop","detail":"{readStateIndex:2126; appliedIndex:2125; }","duration":"133.317778ms","start":"2026-04-22T06:11:31.29239Z","end":"2026-04-22T06:11:31.425708Z","steps":["trace[1212273628] 'read index received' (duration: 133.106013ms)","trace[1212273628] 'applied index is now lower than readState.Index' (duration: 210.465µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:11:31.425874Z","caller":"traceutil/trace.go:171","msg":"trace[1266809708] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"163.705459ms","start":"2026-04-22T06:11:31.262102Z","end":"2026-04-22T06:11:31.425807Z","steps":["trace[1266809708] 'process raft request' (duration: 163.452393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:11:31.426094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.673917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T06:11:31.426195Z","caller":"traceutil/trace.go:171","msg":"trace[20663557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2042; }","duration":"133.79186ms","start":"2026-04-22T06:11:31.292385Z","end":"2026-04-22T06:11:31.426177Z","steps":["trace[20663557] 'agreement among raft nodes before linearized reading' (duration: 133.470752ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:31.719861Z","caller":"traceutil/trace.go:171","msg":"trace[926320898] linearizableReadLoop","detail":"{readStateIndex:2128; appliedIndex:2126; }","duration":"161.386992ms","start":"2026-04-22T06:11:31.558451Z","end":"2026-04-22T06:11:31.719838Z","steps":["trace[926320898] 'read index received' (duration: 63.720912ms)","trace[926320898] 'applied index is now lower than readState.Index' (duration: 97.66504ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:11:31.71999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.523876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:11:31.720074Z","caller":"traceutil/trace.go:171","msg":"trace[1485943334] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2043; }","duration":"161.657839ms","start":"2026-04-22T06:11:31.558397Z","end":"2026-04-22T06:11:31.720055Z","steps":["trace[1485943334] 'agreement among raft nodes before linearized reading' (duration: 161.538206ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:31.720129Z","caller":"traceutil/trace.go:171","msg":"trace[2035303579] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"289.073723ms","start":"2026-04-22T06:11:31.431009Z","end":"2026-04-22T06:11:31.720083Z","steps":["trace[2035303579] 'process raft request' (duration: 288.674123ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:39.500106Z","caller":"traceutil/trace.go:171","msg":"trace[786522985] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"145.932685ms","start":"2026-04-22T06:11:39.354124Z","end":"2026-04-22T06:11:39.500057Z","steps":["trace[786522985] 'process raft request' (duration: 123.901079ms)","trace[786522985] 'compare' (duration: 21.825871ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:11:41.510952Z","caller":"traceutil/trace.go:171","msg":"trace[1217958640] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"156.940654ms","start":"2026-04-22T06:11:41.353985Z","end":"2026-04-22T06:11:41.510925Z","steps":["trace[1217958640] 'process raft request' (duration: 123.718824ms)","trace[1217958640] 'compare' (duration: 33.114647ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:11:41.671605Z","caller":"traceutil/trace.go:171","msg":"trace[614645607] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"109.323823ms","start":"2026-04-22T06:11:41.562252Z","end":"2026-04-22T06:11:41.671575Z","steps":["trace[614645607] 'process raft request' (duration: 56.134497ms)","trace[614645607] 'compare' (duration: 53.059853ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:11:41.879048Z","caller":"traceutil/trace.go:171","msg":"trace[642065532] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"115.089904ms","start":"2026-04-22T06:11:41.763938Z","end":"2026-04-22T06:11:41.879028Z","steps":["trace[642065532] 'process raft request' (duration: 46.415252ms)","trace[642065532] 'compare' (duration: 68.5954ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:11:49.666405Z","caller":"traceutil/trace.go:171","msg":"trace[132213867] linearizableReadLoop","detail":"{readStateIndex:2210; appliedIndex:2209; }","duration":"116.763135ms","start":"2026-04-22T06:11:49.549621Z","end":"2026-04-22T06:11:49.666384Z","steps":["trace[132213867] 'read index received' (duration: 116.600921ms)","trace[132213867] 'applied index is now lower than readState.Index' (duration: 161.054µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:11:49.666643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.009711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-22T06:11:49.666699Z","caller":"traceutil/trace.go:171","msg":"trace[392168055] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2122; }","duration":"117.119803ms","start":"2026-04-22T06:11:49.549566Z","end":"2026-04-22T06:11:49.666686Z","steps":["trace[392168055] 'agreement among raft nodes before linearized reading' (duration: 116.927948ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:49.666728Z","caller":"traceutil/trace.go:171","msg":"trace[1985453663] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"131.163036ms","start":"2026-04-22T06:11:49.535545Z","end":"2026-04-22T06:11:49.666708Z","steps":["trace[1985453663] 'process raft request' (duration: 130.705235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:11:51.638405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.829368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-22T06:11:51.638484Z","caller":"traceutil/trace.go:171","msg":"trace[1588202542] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:2131; }","duration":"302.948961ms","start":"2026-04-22T06:11:51.335516Z","end":"2026-04-22T06:11:51.638465Z","steps":["trace[1588202542] 'range keys from in-memory index tree' (duration: 302.387327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:11:51.638522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:11:51.335494Z","time spent":"303.019282ms","remote":"127.0.0.1:60274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.169\" "} {"level":"info","ts":"2026-04-22T06:11:51.835145Z","caller":"traceutil/trace.go:171","msg":"trace[638794265] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2219; }","duration":"157.21397ms","start":"2026-04-22T06:11:51.677902Z","end":"2026-04-22T06:11:51.835116Z","steps":["trace[638794265] 'read index received' (duration: 25.059931ms)","trace[638794265] 'applied index is now lower than readState.Index' (duration: 132.152999ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:11:51.835265Z","caller":"traceutil/trace.go:171","msg":"trace[2119041767] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"163.411891ms","start":"2026-04-22T06:11:51.671813Z","end":"2026-04-22T06:11:51.835225Z","steps":["trace[2119041767] 'process raft request' (duration: 163.086993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:11:51.835427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.508467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-22T06:11:51.835514Z","caller":"traceutil/trace.go:171","msg":"trace[1855246207] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2132; }","duration":"157.63118ms","start":"2026-04-22T06:11:51.677862Z","end":"2026-04-22T06:11:51.835494Z","steps":["trace[1855246207] 'agreement among raft nodes before linearized reading' (duration: 157.386195ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:11:51.841033Z","caller":"traceutil/trace.go:171","msg":"trace[1203665462] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"137.158512ms","start":"2026-04-22T06:11:51.703857Z","end":"2026-04-22T06:11:51.841016Z","steps":["trace[1203665462] 'process raft request' (duration: 136.886936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:11:51.84122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.525272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-22T06:11:51.84132Z","caller":"traceutil/trace.go:171","msg":"trace[1541279525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2133; }","duration":"112.676174ms","start":"2026-04-22T06:11:51.728603Z","end":"2026-04-22T06:11:51.841279Z","steps":["trace[1541279525] 'agreement among raft nodes before linearized reading' (duration: 112.394748ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:12:08.048635Z","caller":"traceutil/trace.go:171","msg":"trace[820784702] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"105.319941ms","start":"2026-04-22T06:12:07.943293Z","end":"2026-04-22T06:12:08.048613Z","steps":["trace[820784702] 'process raft request' (duration: 103.736472ms)"],"step_count":1}