{"level":"warn","ts":"2026-04-13T21:07:07.240021Z","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-13T21:07:07.240132Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-13T21:07:07.240212Z","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-13T21:07:07.240228Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-13T21:07:07.240254Z","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-13T21:07:07.240953Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-04-13T21:07:07.241044Z","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":16,"max-cpu-available":16,"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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-13T21:07:07.24535Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.073918ms"} {"level":"info","ts":"2026-04-13T21:07:07.250811Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-04-13T21:07:07.250912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T21:07:07.25094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-04-13T21:07:07.250949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T21:07:07.250962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-04-13T21:07:07.251002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-04-13T21:07:07.259609Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T21:07:07.263707Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T21:07:07.266168Z","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-13T21:07:07.269313Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T21:07:07.270596Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T21:07:07.270928Z","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-13T21:07:07.272224Z","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-13T21:07:07.272244Z","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-13T21:07:07.272742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-04-13T21:07:07.272899Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-04-13T21:07:07.274967Z","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-13T21:07:07.275071Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-13T21:07:07.275124Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-04-13T21:07:07.275486Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T21:07:07.27554Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T21:07:07.851979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T21:07:07.852054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T21:07:07.852093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-04-13T21:07:07.852115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-04-13T21:07:07.852127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-13T21:07:07.852144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-04-13T21:07:07.852172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-04-13T21:07:07.853301Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T21:07:07.853495Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:07:07.853599Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:07:07.853653Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T21:07:07.853635Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:07:07.853719Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T21:07:07.854688Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:07:07.854805Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:07:07.854841Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:07:07.856949Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T21:07:07.857076Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-04-13T21:07:20.857991Z","caller":"traceutil/trace.go:171","msg":"trace[869354526] linearizableReadLoop","detail":"{readStateIndex:407; appliedIndex:406; }","duration":"220.913807ms","start":"2026-04-13T21:07:20.637041Z","end":"2026-04-13T21:07:20.857955Z","steps":["trace[869354526] 'read index received' (duration: 220.708671ms)","trace[869354526] 'applied index is now lower than readState.Index' (duration: 203.676µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:20.858044Z","caller":"traceutil/trace.go:171","msg":"trace[438775312] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"221.115904ms","start":"2026-04-13T21:07:20.636889Z","end":"2026-04-13T21:07:20.858005Z","steps":["trace[438775312] 'process raft request' (duration: 220.869326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:20.858195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.121004ms","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-13T21:07:20.858323Z","caller":"traceutil/trace.go:171","msg":"trace[920086876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:398; }","duration":"221.313029ms","start":"2026-04-13T21:07:20.636987Z","end":"2026-04-13T21:07:20.8583Z","steps":["trace[920086876] 'agreement among raft nodes before linearized reading' (duration: 221.076632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:21.257865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.348165ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:07:21.258183Z","caller":"traceutil/trace.go:171","msg":"trace[422103112] linearizableReadLoop","detail":"{readStateIndex:408; appliedIndex:407; }","duration":"346.096124ms","start":"2026-04-13T21:07:20.91206Z","end":"2026-04-13T21:07:21.258157Z","steps":["trace[422103112] 'read index received' (duration: 98.545134ms)","trace[422103112] 'applied index is now lower than readState.Index' (duration: 247.54866ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:21.258352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.29004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-04-13T21:07:21.258355Z","caller":"traceutil/trace.go:171","msg":"trace[1980861458] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"396.113113ms","start":"2026-04-13T21:07:20.862166Z","end":"2026-04-13T21:07:21.258279Z","steps":["trace[1980861458] 'process raft request' (duration: 148.534132ms)","trace[1980861458] 'compare' (duration: 246.094988ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:21.258397Z","caller":"traceutil/trace.go:171","msg":"trace[2020450574] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:399; }","duration":"346.340892ms","start":"2026-04-13T21:07:20.912043Z","end":"2026-04-13T21:07:21.258384Z","steps":["trace[2020450574] 'agreement among raft nodes before linearized reading' (duration: 346.240219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:21.258516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.76651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-13T21:07:21.258622Z","caller":"traceutil/trace.go:171","msg":"trace[1287789379] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:1; response_revision:399; }","duration":"253.940135ms","start":"2026-04-13T21:07:21.004659Z","end":"2026-04-13T21:07:21.258599Z","steps":["trace[1287789379] 'agreement among raft nodes before linearized reading' (duration: 253.745569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:21.258621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:20.911962Z","time spent":"346.63461ms","remote":"127.0.0.1:54156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4349,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-04-13T21:07:21.258685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:20.862135Z","time spent":"396.346249ms","remote":"127.0.0.1:54248","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-13T21:07:46.533389Z","caller":"traceutil/trace.go:171","msg":"trace[1878308555] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"283.875851ms","start":"2026-04-13T21:07:46.249473Z","end":"2026-04-13T21:07:46.533348Z","steps":["trace[1878308555] 'read index received' (duration: 282.985156ms)","trace[1878308555] 'applied index is now lower than readState.Index' (duration: 889.005µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:46.533467Z","caller":"traceutil/trace.go:171","msg":"trace[925648308] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"354.155278ms","start":"2026-04-13T21:07:46.179264Z","end":"2026-04-13T21:07:46.533419Z","steps":["trace[925648308] 'process raft request' (duration: 353.49024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:46.533622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.110937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:46.533737Z","caller":"traceutil/trace.go:171","msg":"trace[2101724095] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"284.285833ms","start":"2026-04-13T21:07:46.249427Z","end":"2026-04-13T21:07:46.533713Z","steps":["trace[2101724095] 'agreement among raft nodes before linearized reading' (duration: 284.077767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:46.533905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:46.179224Z","time spent":"354.515698ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:07:46.591722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.505992ms","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-13T21:07:46.59182Z","caller":"traceutil/trace.go:171","msg":"trace[519448077] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"201.663966ms","start":"2026-04-13T21:07:46.390136Z","end":"2026-04-13T21:07:46.5918Z","steps":["trace[519448077] 'agreement among raft nodes before linearized reading' (duration: 201.354507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:46.848705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.060185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:46.848826Z","caller":"traceutil/trace.go:171","msg":"trace[947123986] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"117.23584ms","start":"2026-04-13T21:07:46.731567Z","end":"2026-04-13T21:07:46.848802Z","steps":["trace[947123986] 'count revisions from in-memory index tree' (duration: 116.982973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:46.849244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.980331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:46.849291Z","caller":"traceutil/trace.go:171","msg":"trace[297416917] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"150.072805ms","start":"2026-04-13T21:07:46.699205Z","end":"2026-04-13T21:07:46.849278Z","steps":["trace[297416917] 'count revisions from in-memory index tree' (duration: 149.887219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:46.849414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.350284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:46.849522Z","caller":"traceutil/trace.go:171","msg":"trace[1558382994] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"149.490449ms","start":"2026-04-13T21:07:46.700006Z","end":"2026-04-13T21:07:46.849496Z","steps":["trace[1558382994] 'range keys from in-memory index tree' (duration: 149.298323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:46.849565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.234197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:46.849659Z","caller":"traceutil/trace.go:171","msg":"trace[826502072] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"118.353081ms","start":"2026-04-13T21:07:46.731289Z","end":"2026-04-13T21:07:46.849642Z","steps":["trace[826502072] 'range keys from in-memory index tree' (duration: 118.142875ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:46.849714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.27234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:46.850468Z","caller":"traceutil/trace.go:171","msg":"trace[588302202] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"151.013821ms","start":"2026-04-13T21:07:46.699423Z","end":"2026-04-13T21:07:46.850437Z","steps":["trace[588302202] 'range keys from in-memory index tree' (duration: 150.146826ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:47.310007Z","caller":"traceutil/trace.go:171","msg":"trace[490884530] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"227.889199ms","start":"2026-04-13T21:07:47.082093Z","end":"2026-04-13T21:07:47.309982Z","steps":["trace[490884530] 'read index received' (duration: 227.003964ms)","trace[490884530] 'applied index is now lower than readState.Index' (duration: 884.525µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:47.310109Z","caller":"traceutil/trace.go:171","msg":"trace[41891190] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"238.765198ms","start":"2026-04-13T21:07:47.07132Z","end":"2026-04-13T21:07:47.310085Z","steps":["trace[41891190] 'process raft request' (duration: 238.08504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:47.310178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.059463ms","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-13T21:07:47.31048Z","caller":"traceutil/trace.go:171","msg":"trace[151622570] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:623; }","duration":"228.146336ms","start":"2026-04-13T21:07:47.082053Z","end":"2026-04-13T21:07:47.310199Z","steps":["trace[151622570] 'agreement among raft nodes before linearized reading' (duration: 228.054083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:47.31052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.301424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:47.310727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.788847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:47.310722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.491445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:47.310793Z","caller":"traceutil/trace.go:171","msg":"trace[1895568858] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:623; }","duration":"157.866709ms","start":"2026-04-13T21:07:47.152899Z","end":"2026-04-13T21:07:47.310766Z","steps":["trace[1895568858] 'agreement among raft nodes before linearized reading' (duration: 157.798207ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:47.310772Z","caller":"traceutil/trace.go:171","msg":"trace[1031386980] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:623; }","duration":"157.576382ms","start":"2026-04-13T21:07:47.153132Z","end":"2026-04-13T21:07:47.310708Z","steps":["trace[1031386980] 'agreement among raft nodes before linearized reading' (duration: 157.278703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:47.310887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.956594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:47.310914Z","caller":"traceutil/trace.go:171","msg":"trace[1835929833] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:623; }","duration":"202.009145ms","start":"2026-04-13T21:07:47.108899Z","end":"2026-04-13T21:07:47.310908Z","steps":["trace[1835929833] 'agreement among raft nodes before linearized reading' (duration: 201.966404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:47.310943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.395622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:47.311022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.215378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:47.310617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.324235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:47.311064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.136526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:47.311067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.460537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:47.311155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.796537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:47.311163Z","caller":"traceutil/trace.go:171","msg":"trace[79357437] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:623; }","duration":"183.258619ms","start":"2026-04-13T21:07:47.127784Z","end":"2026-04-13T21:07:47.311042Z","steps":["trace[79357437] 'agreement among raft nodes before linearized reading' (duration: 183.215178ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:47.311163Z","caller":"traceutil/trace.go:171","msg":"trace[1714793978] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:623; }","duration":"183.269109ms","start":"2026-04-13T21:07:47.127864Z","end":"2026-04-13T21:07:47.311133Z","steps":["trace[1714793978] 'agreement among raft nodes before linearized reading' (duration: 183.115645ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:47.311189Z","caller":"traceutil/trace.go:171","msg":"trace[1109211705] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:623; }","duration":"182.842178ms","start":"2026-04-13T21:07:47.128339Z","end":"2026-04-13T21:07:47.311181Z","steps":["trace[1109211705] 'agreement among raft nodes before linearized reading' (duration: 182.800797ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:47.310839Z","caller":"traceutil/trace.go:171","msg":"trace[325291178] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:623; }","duration":"228.645529ms","start":"2026-04-13T21:07:47.082164Z","end":"2026-04-13T21:07:47.310809Z","steps":["trace[325291178] 'agreement among raft nodes before linearized reading' (duration: 228.384792ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:47.31122Z","caller":"traceutil/trace.go:171","msg":"trace[1849136194] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:623; }","duration":"227.616001ms","start":"2026-04-13T21:07:47.083541Z","end":"2026-04-13T21:07:47.311157Z","steps":["trace[1849136194] 'agreement among raft nodes before linearized reading' (duration: 227.360304ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:47.311209Z","caller":"traceutil/trace.go:171","msg":"trace[1334803445] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:623; }","duration":"158.025254ms","start":"2026-04-13T21:07:47.153114Z","end":"2026-04-13T21:07:47.311139Z","steps":["trace[1334803445] 'agreement among raft nodes before linearized reading' (duration: 157.310944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:47.311063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.528392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:47.311299Z","caller":"traceutil/trace.go:171","msg":"trace[494079765] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:623; }","duration":"201.775019ms","start":"2026-04-13T21:07:47.109515Z","end":"2026-04-13T21:07:47.31129Z","steps":["trace[494079765] 'agreement among raft nodes before linearized reading' (duration: 201.530832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:47.311323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.973408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:47.310628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.549833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:47.311432Z","caller":"traceutil/trace.go:171","msg":"trace[1096226064] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:623; }","duration":"123.109002ms","start":"2026-04-13T21:07:47.188298Z","end":"2026-04-13T21:07:47.311407Z","steps":["trace[1096226064] 'agreement among raft nodes before linearized reading' (duration: 122.974188ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:47.311097Z","caller":"traceutil/trace.go:171","msg":"trace[1127451007] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:623; }","duration":"122.614708ms","start":"2026-04-13T21:07:47.188426Z","end":"2026-04-13T21:07:47.311041Z","steps":["trace[1127451007] 'agreement among raft nodes before linearized reading' (duration: 122.285739ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:47.311435Z","caller":"traceutil/trace.go:171","msg":"trace[1508008266] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:623; }","duration":"202.387646ms","start":"2026-04-13T21:07:47.109033Z","end":"2026-04-13T21:07:47.31142Z","steps":["trace[1508008266] 'agreement among raft nodes before linearized reading' (duration: 201.472461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.022853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.918943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:07:48.022975Z","caller":"traceutil/trace.go:171","msg":"trace[1207305581] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"467.468909ms","start":"2026-04-13T21:07:47.555488Z","end":"2026-04-13T21:07:48.022957Z","steps":["trace[1207305581] 'read index received' (duration: 57.271918ms)","trace[1207305581] 'applied index is now lower than readState.Index' (duration: 410.195801ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:48.023115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.623763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:48.023086Z","caller":"traceutil/trace.go:171","msg":"trace[439858845] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"541.120848ms","start":"2026-04-13T21:07:47.481919Z","end":"2026-04-13T21:07:48.02304Z","steps":["trace[439858845] 'process raft request' (duration: 130.943257ms)","trace[439858845] 'compare' (duration: 409.764649ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:48.023152Z","caller":"traceutil/trace.go:171","msg":"trace[1136182257] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"467.708246ms","start":"2026-04-13T21:07:47.555433Z","end":"2026-04-13T21:07:48.023142Z","steps":["trace[1136182257] 'agreement among raft nodes before linearized reading' (duration: 467.614943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.023266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:47.481891Z","time spent":"541.282372ms","remote":"127.0.0.1:54156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:07:48.023335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.926115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:48.023328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.562282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:48.023436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.906008ms","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-13T21:07:48.023475Z","caller":"traceutil/trace.go:171","msg":"trace[798990180] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:626; }","duration":"320.830599ms","start":"2026-04-13T21:07:47.702616Z","end":"2026-04-13T21:07:48.023446Z","steps":["trace[798990180] 'agreement among raft nodes before linearized reading' (duration: 320.583172ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.023498Z","caller":"traceutil/trace.go:171","msg":"trace[557746612] 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:626; }","duration":"113.95797ms","start":"2026-04-13T21:07:47.90952Z","end":"2026-04-13T21:07:48.023478Z","steps":["trace[557746612] 'agreement among raft nodes before linearized reading' (duration: 113.890488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.023513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.608587ms","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-13T21:07:48.023471Z","caller":"traceutil/trace.go:171","msg":"trace[1988079519] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"287.067779ms","start":"2026-04-13T21:07:47.736354Z","end":"2026-04-13T21:07:48.023421Z","steps":["trace[1988079519] 'agreement among raft nodes before linearized reading' (duration: 286.931526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.023534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.441653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:48.023548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:47.70258Z","time spent":"320.953482ms","remote":"127.0.0.1:56698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-04-13T21:07:48.023573Z","caller":"traceutil/trace.go:171","msg":"trace[291289348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"143.71666ms","start":"2026-04-13T21:07:47.879835Z","end":"2026-04-13T21:07:48.023552Z","steps":["trace[291289348] 'agreement among raft nodes before linearized reading' (duration: 143.602107ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.023586Z","caller":"traceutil/trace.go:171","msg":"trace[58433165] 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:626; }","duration":"114.549216ms","start":"2026-04-13T21:07:47.909022Z","end":"2026-04-13T21:07:48.023572Z","steps":["trace[58433165] 'agreement among raft nodes before linearized reading' (duration: 114.442674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.023698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.45162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:48.023656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.299838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:48.023703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.371915ms","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-13T21:07:48.023735Z","caller":"traceutil/trace.go:171","msg":"trace[936654378] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"287.503161ms","start":"2026-04-13T21:07:47.736221Z","end":"2026-04-13T21:07:48.023724Z","steps":["trace[936654378] 'agreement among raft nodes before linearized reading' (duration: 287.449229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.023738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.788385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:48.023781Z","caller":"traceutil/trace.go:171","msg":"trace[1298553352] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"292.473508ms","start":"2026-04-13T21:07:47.731283Z","end":"2026-04-13T21:07:48.023757Z","steps":["trace[1298553352] 'agreement among raft nodes before linearized reading' (duration: 292.336824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.023335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.277689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:48.023791Z","caller":"traceutil/trace.go:171","msg":"trace[2130321114] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:626; }","duration":"151.480323ms","start":"2026-04-13T21:07:47.872273Z","end":"2026-04-13T21:07:48.023753Z","steps":["trace[2130321114] 'agreement among raft nodes before linearized reading' (duration: 151.278078ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.02381Z","caller":"traceutil/trace.go:171","msg":"trace[1076612047] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:626; }","duration":"150.942769ms","start":"2026-04-13T21:07:47.87285Z","end":"2026-04-13T21:07:48.023793Z","steps":["trace[1076612047] 'agreement among raft nodes before linearized reading' (duration: 150.717272ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.023837Z","caller":"traceutil/trace.go:171","msg":"trace[860211021] 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:626; }","duration":"114.825843ms","start":"2026-04-13T21:07:47.908994Z","end":"2026-04-13T21:07:48.02382Z","steps":["trace[860211021] 'agreement among raft nodes before linearized reading' (duration: 114.268048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.023338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.857516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:48.023874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.872594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:48.023899Z","caller":"traceutil/trace.go:171","msg":"trace[649134547] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:626; }","duration":"151.497364ms","start":"2026-04-13T21:07:47.872383Z","end":"2026-04-13T21:07:48.02388Z","steps":["trace[649134547] 'agreement among raft nodes before linearized reading' (duration: 150.804655ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.023932Z","caller":"traceutil/trace.go:171","msg":"trace[10878682] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"286.972857ms","start":"2026-04-13T21:07:47.736941Z","end":"2026-04-13T21:07:48.023914Z","steps":["trace[10878682] 'agreement among raft nodes before linearized reading' (duration: 286.879274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.024025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.87309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:48.024076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.960102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:48.024109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.542769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:48.024137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.671084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:48.024143Z","caller":"traceutil/trace.go:171","msg":"trace[1672736862] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"346.066605ms","start":"2026-04-13T21:07:47.67806Z","end":"2026-04-13T21:07:48.024126Z","steps":["trace[1672736862] 'agreement among raft nodes before linearized reading' (duration: 345.965122ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.024161Z","caller":"traceutil/trace.go:171","msg":"trace[1780623561] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"345.965572ms","start":"2026-04-13T21:07:47.678096Z","end":"2026-04-13T21:07:48.024062Z","steps":["trace[1780623561] 'agreement among raft nodes before linearized reading' (duration: 345.89772ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.024156Z","caller":"traceutil/trace.go:171","msg":"trace[1120447663] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:626; }","duration":"321.641721ms","start":"2026-04-13T21:07:47.702499Z","end":"2026-04-13T21:07:48.024141Z","steps":["trace[1120447663] 'agreement among raft nodes before linearized reading' (duration: 321.553249ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.024179Z","caller":"traceutil/trace.go:171","msg":"trace[643515704] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"345.734886ms","start":"2026-04-13T21:07:47.678433Z","end":"2026-04-13T21:07:48.024167Z","steps":["trace[643515704] 'agreement among raft nodes before linearized reading' (duration: 345.555701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.024203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:47.678033Z","time spent":"346.147047ms","remote":"127.0.0.1:56686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:07:48.024199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:47.67807Z","time spent":"346.119996ms","remote":"127.0.0.1:56686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T21:07:48.024178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.58787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:48.024217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:47.702464Z","time spent":"321.737464ms","remote":"127.0.0.1:56698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:07:48.024216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:47.678418Z","time spent":"345.787757ms","remote":"127.0.0.1:56678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"info","ts":"2026-04-13T21:07:48.024269Z","caller":"traceutil/trace.go:171","msg":"trace[558180556] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:626; }","duration":"321.713894ms","start":"2026-04-13T21:07:47.702533Z","end":"2026-04-13T21:07:48.024246Z","steps":["trace[558180556] 'agreement among raft nodes before linearized reading' (duration: 321.55514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.024313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:47.702473Z","time spent":"321.829137ms","remote":"127.0.0.1:56698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-13T21:07:48.024338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:47.555405Z","time spent":"467.783898ms","remote":"127.0.0.1:56678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:07:48.024517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.609063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:48.024573Z","caller":"traceutil/trace.go:171","msg":"trace[872754828] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"469.030972ms","start":"2026-04-13T21:07:47.555528Z","end":"2026-04-13T21:07:48.024559Z","steps":["trace[872754828] 'agreement among raft nodes before linearized reading' (duration: 467.603332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.024608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:47.555484Z","time spent":"469.114205ms","remote":"127.0.0.1:56678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T21:07:48.506764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.130151ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:07:48.506902Z","caller":"traceutil/trace.go:171","msg":"trace[188258605] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"477.761353ms","start":"2026-04-13T21:07:48.029117Z","end":"2026-04-13T21:07:48.506879Z","steps":["trace[188258605] 'process raft request' (duration: 296.419757ms)","trace[188258605] 'compare' (duration: 180.990916ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:48.506972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:48.029099Z","time spent":"477.843895ms","remote":"127.0.0.1:54248","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-13T21:07:48.519133Z","caller":"traceutil/trace.go:171","msg":"trace[1108173735] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"489.811044ms","start":"2026-04-13T21:07:48.029288Z","end":"2026-04-13T21:07:48.519099Z","steps":["trace[1108173735] 'process raft request' (duration: 489.615059ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.519205Z","caller":"traceutil/trace.go:171","msg":"trace[1399276798] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"489.842086ms","start":"2026-04-13T21:07:48.029343Z","end":"2026-04-13T21:07:48.519185Z","steps":["trace[1399276798] 'process raft request' (duration: 489.64618ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.519183Z","caller":"traceutil/trace.go:171","msg":"trace[1577026163] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"489.463045ms","start":"2026-04-13T21:07:48.029705Z","end":"2026-04-13T21:07:48.519168Z","steps":["trace[1577026163] 'process raft request' (duration: 489.330862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.519304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:48.029266Z","time spent":"489.956239ms","remote":"127.0.0.1:54068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:07:48.519307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:48.029314Z","time spent":"489.935527ms","remote":"127.0.0.1:54068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:07:48.519437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:48.029683Z","time spent":"489.633119ms","remote":"127.0.0.1:54218","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-13T21:07:48.519513Z","caller":"traceutil/trace.go:171","msg":"trace[167570351] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"488.668433ms","start":"2026-04-13T21:07:48.030832Z","end":"2026-04-13T21:07:48.5195Z","steps":["trace[167570351] 'process raft request' (duration: 488.289193ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.519466Z","caller":"traceutil/trace.go:171","msg":"trace[401155978] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"489.409683ms","start":"2026-04-13T21:07:48.029861Z","end":"2026-04-13T21:07:48.519271Z","steps":["trace[401155978] 'process raft request' (duration: 489.220978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:48.519583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.562522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:07:48.5196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:48.030816Z","time spent":"488.734145ms","remote":"127.0.0.1:54156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:07:48.519635Z","caller":"traceutil/trace.go:171","msg":"trace[1731706962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"271.684595ms","start":"2026-04-13T21:07:48.247942Z","end":"2026-04-13T21:07:48.519626Z","steps":["trace[1731706962] 'agreement among raft nodes before linearized reading' (duration: 271.562811ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:48.519445Z","caller":"traceutil/trace.go:171","msg":"trace[243776689] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:644; }","duration":"271.406298ms","start":"2026-04-13T21:07:48.248002Z","end":"2026-04-13T21:07:48.519408Z","steps":["trace[243776689] 'read index received' (duration: 77.589148ms)","trace[243776689] 'applied index is now lower than readState.Index' (duration: 193.8152ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:48.519816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:48.029835Z","time spent":"489.796504ms","remote":"127.0.0.1:54248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:08:04.790395Z","caller":"traceutil/trace.go:171","msg":"trace[345290228] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:812; }","duration":"135.00916ms","start":"2026-04-13T21:08:04.655352Z","end":"2026-04-13T21:08:04.790361Z","steps":["trace[345290228] 'read index received' (duration: 134.837565ms)","trace[345290228] 'applied index is now lower than readState.Index' (duration: 170.185µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:08:04.790568Z","caller":"traceutil/trace.go:171","msg":"trace[2109046060] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"164.830181ms","start":"2026-04-13T21:08:04.625724Z","end":"2026-04-13T21:08:04.790555Z","steps":["trace[2109046060] 'process raft request' (duration: 164.452831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:08:04.790947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.575985ms","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-13T21:08:04.791004Z","caller":"traceutil/trace.go:171","msg":"trace[1246406379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:790; }","duration":"135.718349ms","start":"2026-04-13T21:08:04.655273Z","end":"2026-04-13T21:08:04.790991Z","steps":["trace[1246406379] 'agreement among raft nodes before linearized reading' (duration: 135.439162ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:09:18.135944Z","caller":"traceutil/trace.go:171","msg":"trace[374660854] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"111.553154ms","start":"2026-04-13T21:09:18.024319Z","end":"2026-04-13T21:09:18.135872Z","steps":["trace[374660854] 'process raft request' (duration: 20.642213ms)","trace[374660854] 'compare' (duration: 90.618612ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:09:18.732132Z","caller":"traceutil/trace.go:171","msg":"trace[1144031938] linearizableReadLoop","detail":"{readStateIndex:1917; appliedIndex:1916; }","duration":"171.983559ms","start":"2026-04-13T21:09:18.56011Z","end":"2026-04-13T21:09:18.732094Z","steps":["trace[1144031938] 'read index received' (duration: 171.626058ms)","trace[1144031938] 'applied index is now lower than readState.Index' (duration: 355.001µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:09:18.732227Z","caller":"traceutil/trace.go:171","msg":"trace[815380974] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"177.616516ms","start":"2026-04-13T21:09:18.554561Z","end":"2026-04-13T21:09:18.732177Z","steps":["trace[815380974] 'process raft request' (duration: 177.286997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:09:18.732612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.476214ms","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-13T21:09:18.73268Z","caller":"traceutil/trace.go:171","msg":"trace[1354361227] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1849; }","duration":"172.619498ms","start":"2026-04-13T21:09:18.560046Z","end":"2026-04-13T21:09:18.732665Z","steps":["trace[1354361227] 'agreement among raft nodes before linearized reading' (duration: 172.270438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:09:18.73265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.32569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c4622fd6-1c67-455c-8723-8586eb6533ec\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-04-13T21:09:18.732845Z","caller":"traceutil/trace.go:171","msg":"trace[359613038] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c4622fd6-1c67-455c-8723-8586eb6533ec; range_end:; response_count:1; response_revision:1849; }","duration":"103.596607ms","start":"2026-04-13T21:09:18.62922Z","end":"2026-04-13T21:09:18.732817Z","steps":["trace[359613038] 'agreement among raft nodes before linearized reading' (duration: 103.310709ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:09:57.575079Z","caller":"traceutil/trace.go:171","msg":"trace[2016932652] linearizableReadLoop","detail":"{readStateIndex:2190; appliedIndex:2188; }","duration":"104.961063ms","start":"2026-04-13T21:09:57.470078Z","end":"2026-04-13T21:09:57.575039Z","steps":["trace[2016932652] 'read index received' (duration: 82.430079ms)","trace[2016932652] 'applied index is now lower than readState.Index' (duration: 22.528904ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:09:57.575311Z","caller":"traceutil/trace.go:171","msg":"trace[226898219] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"105.438546ms","start":"2026-04-13T21:09:57.469811Z","end":"2026-04-13T21:09:57.57525Z","steps":["trace[226898219] 'process raft request' (duration: 105.004764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:09:57.575486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.378794ms","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-13T21:09:57.575551Z","caller":"traceutil/trace.go:171","msg":"trace[1300992800] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2113; }","duration":"105.520189ms","start":"2026-04-13T21:09:57.470014Z","end":"2026-04-13T21:09:57.575534Z","steps":["trace[1300992800] 'agreement among raft nodes before linearized reading' (duration: 105.179129ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:10:03.537861Z","caller":"traceutil/trace.go:171","msg":"trace[1348602204] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2218; }","duration":"287.176689ms","start":"2026-04-13T21:10:03.250656Z","end":"2026-04-13T21:10:03.537833Z","steps":["trace[1348602204] 'read index received' (duration: 286.938722ms)","trace[1348602204] 'applied index is now lower than readState.Index' (duration: 237.147µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:10:03.537911Z","caller":"traceutil/trace.go:171","msg":"trace[222432773] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"371.985425ms","start":"2026-04-13T21:10:03.165898Z","end":"2026-04-13T21:10:03.537883Z","steps":["trace[222432773] 'process raft request' (duration: 371.756099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:10:03.538058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:10:03.165866Z","time spent":"372.105549ms","remote":"127.0.0.1:54248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:10:03.538052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.374095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:10:03.538149Z","caller":"traceutil/trace.go:171","msg":"trace[579116778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2141; }","duration":"287.527989ms","start":"2026-04-13T21:10:03.250595Z","end":"2026-04-13T21:10:03.538123Z","steps":["trace[579116778] 'agreement among raft nodes before linearized reading' (duration: 287.348904ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:10:58.180446Z","caller":"traceutil/trace.go:171","msg":"trace[386423628] transaction","detail":"{read_only:false; response_revision:2611; number_of_response:1; }","duration":"138.107406ms","start":"2026-04-13T21:10:58.042311Z","end":"2026-04-13T21:10:58.180418Z","steps":["trace[386423628] 'process raft request' (duration: 137.955471ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:31.983462Z","caller":"traceutil/trace.go:171","msg":"trace[1024282124] transaction","detail":"{read_only:false; response_revision:2812; number_of_response:1; }","duration":"111.57797ms","start":"2026-04-13T21:11:31.871853Z","end":"2026-04-13T21:11:31.983431Z","steps":["trace[1024282124] 'process raft request' (duration: 111.374534ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:14:19.338538Z","caller":"traceutil/trace.go:171","msg":"trace[134026187] transaction","detail":"{read_only:false; response_revision:3893; number_of_response:1; }","duration":"268.939984ms","start":"2026-04-13T21:14:19.069564Z","end":"2026-04-13T21:14:19.338504Z","steps":["trace[134026187] 'process raft request' (duration: 237.923177ms)","trace[134026187] 'compare' (duration: 30.843012ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:14:19.338922Z","caller":"traceutil/trace.go:171","msg":"trace[889541310] transaction","detail":"{read_only:false; response_revision:3894; number_of_response:1; }","duration":"268.604915ms","start":"2026-04-13T21:14:19.070257Z","end":"2026-04-13T21:14:19.338862Z","steps":["trace[889541310] 'process raft request' (duration: 268.336238ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:14:19.339018Z","caller":"traceutil/trace.go:171","msg":"trace[1181637128] transaction","detail":"{read_only:false; response_revision:3895; number_of_response:1; }","duration":"268.528143ms","start":"2026-04-13T21:14:19.070477Z","end":"2026-04-13T21:14:19.339005Z","steps":["trace[1181637128] 'process raft request' (duration: 268.310657ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:15:50.557121Z","caller":"traceutil/trace.go:171","msg":"trace[1109506204] transaction","detail":"{read_only:false; response_revision:5092; number_of_response:1; }","duration":"131.278218ms","start":"2026-04-13T21:15:50.425813Z","end":"2026-04-13T21:15:50.557091Z","steps":["trace[1109506204] 'process raft request' (duration: 130.549928ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:15:54.459384Z","caller":"traceutil/trace.go:171","msg":"trace[1821291352] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"103.747319ms","start":"2026-04-13T21:15:54.355567Z","end":"2026-04-13T21:15:54.459314Z","steps":["trace[1821291352] 'process raft request' (duration: 13.917498ms)","trace[1821291352] 'compare' (duration: 89.639026ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:16:02.613953Z","caller":"traceutil/trace.go:171","msg":"trace[869990030] transaction","detail":"{read_only:false; response_revision:5323; number_of_response:1; }","duration":"111.194342ms","start":"2026-04-13T21:16:02.502726Z","end":"2026-04-13T21:16:02.61392Z","steps":["trace[869990030] 'process raft request' (duration: 106.912545ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:16:11.5407Z","caller":"traceutil/trace.go:171","msg":"trace[1529621225] transaction","detail":"{read_only:false; response_revision:5483; number_of_response:1; }","duration":"110.36962ms","start":"2026-04-13T21:16:11.430293Z","end":"2026-04-13T21:16:11.540663Z","steps":["trace[1529621225] 'process raft request' (duration: 110.147364ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:16:12.027974Z","caller":"traceutil/trace.go:171","msg":"trace[1187853339] transaction","detail":"{read_only:false; response_revision:5484; number_of_response:1; }","duration":"123.66436ms","start":"2026-04-13T21:16:11.904275Z","end":"2026-04-13T21:16:12.027939Z","steps":["trace[1187853339] 'process raft request' (duration: 123.374643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:16:14.197711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.511071ms","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-13T21:16:14.197905Z","caller":"traceutil/trace.go:171","msg":"trace[1269320470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5533; }","duration":"140.742197ms","start":"2026-04-13T21:16:14.057103Z","end":"2026-04-13T21:16:14.197845Z","steps":["trace[1269320470] 'range keys from in-memory index tree' (duration: 140.252383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:16:14.198522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.118674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-04-13T21:16:14.199331Z","caller":"traceutil/trace.go:171","msg":"trace[1978135503] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5533; }","duration":"167.788813ms","start":"2026-04-13T21:16:14.031267Z","end":"2026-04-13T21:16:14.199056Z","steps":["trace[1978135503] 'range keys from in-memory index tree' (duration: 166.24865ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:17:07.904582Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3007} {"level":"info","ts":"2026-04-13T21:17:08.015693Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3007,"took":"108.972153ms","hash":3092427188,"current-db-size-bytes":56762368,"current-db-size":"57 MB","current-db-size-in-use-bytes":31338496,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-13T21:17:08.015801Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3092427188,"revision":3007,"compact-revision":-1} {"level":"warn","ts":"2026-04-13T21:22:06.857942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.601796ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-13T21:22:06.858265Z","caller":"traceutil/trace.go:171","msg":"trace[289168297] linearizableReadLoop","detail":"{readStateIndex:8569; appliedIndex:8567; }","duration":"184.548585ms","start":"2026-04-13T21:22:06.673696Z","end":"2026-04-13T21:22:06.858245Z","steps":["trace[289168297] 'read index received' (duration: 162.835782ms)","trace[289168297] 'applied index is now lower than readState.Index' (duration: 21.711493ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:22:06.858363Z","caller":"traceutil/trace.go:171","msg":"trace[1120900583] transaction","detail":"{read_only:false; response_revision:8280; number_of_response:1; }","duration":"342.801982ms","start":"2026-04-13T21:22:06.515508Z","end":"2026-04-13T21:22:06.85831Z","steps":["trace[1120900583] 'process raft request' (duration: 342.584476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:06.858462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.734131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:22:06.858551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:22:06.515484Z","time spent":"342.973537ms","remote":"127.0.0.1:54248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:22:06.858569Z","caller":"traceutil/trace.go:171","msg":"trace[862162965] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:8280; }","duration":"184.888885ms","start":"2026-04-13T21:22:06.673659Z","end":"2026-04-13T21:22:06.858548Z","steps":["trace[862162965] 'agreement among raft nodes before linearized reading' (duration: 184.694369ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:22:07.918283Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6061} {"level":"info","ts":"2026-04-13T21:22:08.049455Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6061,"took":"127.28521ms","hash":2600492389,"current-db-size-bytes":56762368,"current-db-size":"57 MB","current-db-size-in-use-bytes":23797760,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-13T21:22:08.049561Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2600492389,"revision":6061,"compact-revision":3007} {"level":"info","ts":"2026-04-13T21:22:18.587178Z","caller":"traceutil/trace.go:171","msg":"trace[1202718370] transaction","detail":"{read_only:false; response_revision:8340; number_of_response:1; }","duration":"191.636899ms","start":"2026-04-13T21:22:18.395505Z","end":"2026-04-13T21:22:18.587142Z","steps":["trace[1202718370] 'process raft request' (duration: 110.540142ms)","trace[1202718370] 'compare' (duration: 80.903142ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:22:18.642773Z","caller":"traceutil/trace.go:171","msg":"trace[706550363] linearizableReadLoop","detail":"{readStateIndex:8634; appliedIndex:8631; }","duration":"183.772195ms","start":"2026-04-13T21:22:18.458971Z","end":"2026-04-13T21:22:18.642743Z","steps":["trace[706550363] 'read index received' (duration: 47.204421ms)","trace[706550363] 'applied index is now lower than readState.Index' (duration: 136.566593ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:22:18.642904Z","caller":"traceutil/trace.go:171","msg":"trace[1942084431] transaction","detail":"{read_only:false; response_revision:8341; number_of_response:1; }","duration":"246.970612ms","start":"2026-04-13T21:22:18.39584Z","end":"2026-04-13T21:22:18.642811Z","steps":["trace[1942084431] 'process raft request' (duration: 246.661784ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:22:18.642969Z","caller":"traceutil/trace.go:171","msg":"trace[1752352550] transaction","detail":"{read_only:false; response_revision:8342; number_of_response:1; }","duration":"247.054305ms","start":"2026-04-13T21:22:18.395873Z","end":"2026-04-13T21:22:18.642928Z","steps":["trace[1752352550] 'process raft request' (duration: 246.777857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:18.642977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.983531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:18.643174Z","caller":"traceutil/trace.go:171","msg":"trace[1599344294] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:8342; }","duration":"184.250478ms","start":"2026-04-13T21:22:18.458913Z","end":"2026-04-13T21:22:18.643163Z","steps":["trace[1599344294] 'agreement among raft nodes before linearized reading' (duration: 183.934619ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:22:19.320246Z","caller":"traceutil/trace.go:171","msg":"trace[1775469848] linearizableReadLoop","detail":"{readStateIndex:8638; appliedIndex:8637; }","duration":"139.480583ms","start":"2026-04-13T21:22:19.180726Z","end":"2026-04-13T21:22:19.320206Z","steps":["trace[1775469848] 'read index received' (duration: 96.20612ms)","trace[1775469848] 'applied index is now lower than readState.Index' (duration: 43.272933ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:22:19.320534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.711509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.320626Z","caller":"traceutil/trace.go:171","msg":"trace[665387895] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8345; }","duration":"139.895114ms","start":"2026-04-13T21:22:19.180712Z","end":"2026-04-13T21:22:19.320607Z","steps":["trace[665387895] 'agreement among raft nodes before linearized reading' (duration: 139.646797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.320632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.074891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.320684Z","caller":"traceutil/trace.go:171","msg":"trace[435636956] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8345; }","duration":"139.158983ms","start":"2026-04-13T21:22:19.181507Z","end":"2026-04-13T21:22:19.320666Z","steps":["trace[435636956] 'agreement among raft nodes before linearized reading' (duration: 139.04171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.320806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.523976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:22:19.320824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.833907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.320843Z","caller":"traceutil/trace.go:171","msg":"trace[679379459] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8345; }","duration":"101.570037ms","start":"2026-04-13T21:22:19.219263Z","end":"2026-04-13T21:22:19.320833Z","steps":["trace[679379459] 'agreement among raft nodes before linearized reading' (duration: 101.515005ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:22:19.320873Z","caller":"traceutil/trace.go:171","msg":"trace[67960481] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8345; }","duration":"100.892759ms","start":"2026-04-13T21:22:19.219966Z","end":"2026-04-13T21:22:19.320859Z","steps":["trace[67960481] 'agreement among raft nodes before linearized reading' (duration: 100.808736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.320869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.11123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.320955Z","caller":"traceutil/trace.go:171","msg":"trace[2103271125] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8345; }","duration":"140.251734ms","start":"2026-04-13T21:22:19.180683Z","end":"2026-04-13T21:22:19.320935Z","steps":["trace[2103271125] 'agreement among raft nodes before linearized reading' (duration: 140.069669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.321061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.671584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.321107Z","caller":"traceutil/trace.go:171","msg":"trace[432427683] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8345; }","duration":"118.751326ms","start":"2026-04-13T21:22:19.202342Z","end":"2026-04-13T21:22:19.321093Z","steps":["trace[432427683] 'agreement among raft nodes before linearized reading' (duration: 118.688354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.321078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.907223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.321198Z","caller":"traceutil/trace.go:171","msg":"trace[802424676] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8345; }","duration":"118.059507ms","start":"2026-04-13T21:22:19.203107Z","end":"2026-04-13T21:22:19.321166Z","steps":["trace[802424676] 'agreement among raft nodes before linearized reading' (duration: 117.78482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.321208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.238116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:22:19.321293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.985522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.321331Z","caller":"traceutil/trace.go:171","msg":"trace[852870654] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8345; }","duration":"119.050444ms","start":"2026-04-13T21:22:19.20227Z","end":"2026-04-13T21:22:19.32132Z","steps":["trace[852870654] 'agreement among raft nodes before linearized reading' (duration: 118.989523ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:22:19.321427Z","caller":"traceutil/trace.go:171","msg":"trace[208648006] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8345; }","duration":"102.474472ms","start":"2026-04-13T21:22:19.218835Z","end":"2026-04-13T21:22:19.32131Z","steps":["trace[208648006] 'agreement among raft nodes before linearized reading' (duration: 102.159053ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:22:19.463715Z","caller":"traceutil/trace.go:171","msg":"trace[1440782573] transaction","detail":"{read_only:false; response_revision:8346; number_of_response:1; }","duration":"141.024666ms","start":"2026-04-13T21:22:19.322659Z","end":"2026-04-13T21:22:19.463683Z","steps":["trace[1440782573] 'process raft request' (duration: 132.861613ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:22:19.482957Z","caller":"traceutil/trace.go:171","msg":"trace[1254376910] linearizableReadLoop","detail":"{readStateIndex:8640; appliedIndex:8638; }","duration":"147.531914ms","start":"2026-04-13T21:22:19.335405Z","end":"2026-04-13T21:22:19.482937Z","steps":["trace[1254376910] 'read index received' (duration: 120.121215ms)","trace[1254376910] 'applied index is now lower than readState.Index' (duration: 27.409539ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:22:19.483102Z","caller":"traceutil/trace.go:171","msg":"trace[1740200588] transaction","detail":"{read_only:false; response_revision:8347; number_of_response:1; }","duration":"156.768306ms","start":"2026-04-13T21:22:19.326286Z","end":"2026-04-13T21:22:19.483055Z","steps":["trace[1740200588] 'process raft request' (duration: 156.503619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.48322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.503633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.483272Z","caller":"traceutil/trace.go:171","msg":"trace[1610590287] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8347; }","duration":"147.612496ms","start":"2026-04-13T21:22:19.335647Z","end":"2026-04-13T21:22:19.48326Z","steps":["trace[1610590287] 'agreement among raft nodes before linearized reading' (duration: 147.500693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.483521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.503693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.483563Z","caller":"traceutil/trace.go:171","msg":"trace[302755089] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8347; }","duration":"117.563404ms","start":"2026-04-13T21:22:19.365989Z","end":"2026-04-13T21:22:19.483553Z","steps":["trace[302755089] 'agreement among raft nodes before linearized reading' (duration: 117.501442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.483743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.76432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.483783Z","caller":"traceutil/trace.go:171","msg":"trace[1112734616] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8347; }","duration":"117.828612ms","start":"2026-04-13T21:22:19.365944Z","end":"2026-04-13T21:22:19.483773Z","steps":["trace[1112734616] 'agreement among raft nodes before linearized reading' (duration: 117.76889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.483939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.689088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:22:19.483959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.970636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.484028Z","caller":"traceutil/trace.go:171","msg":"trace[1434488581] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8347; }","duration":"133.082328ms","start":"2026-04-13T21:22:19.350929Z","end":"2026-04-13T21:22:19.484011Z","steps":["trace[1434488581] 'agreement among raft nodes before linearized reading' (duration: 132.964995ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:22:19.483977Z","caller":"traceutil/trace.go:171","msg":"trace[279488274] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8347; }","duration":"147.749769ms","start":"2026-04-13T21:22:19.336217Z","end":"2026-04-13T21:22:19.483967Z","steps":["trace[279488274] 'agreement among raft nodes before linearized reading' (duration: 147.691228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.484248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.515073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:22:19.484265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.791138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.484286Z","caller":"traceutil/trace.go:171","msg":"trace[2006376074] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8347; }","duration":"132.560655ms","start":"2026-04-13T21:22:19.351713Z","end":"2026-04-13T21:22:19.484273Z","steps":["trace[2006376074] 'agreement among raft nodes before linearized reading' (duration: 132.520003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.484206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.162911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.484322Z","caller":"traceutil/trace.go:171","msg":"trace[951672117] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8347; }","duration":"118.8853ms","start":"2026-04-13T21:22:19.365424Z","end":"2026-04-13T21:22:19.484309Z","steps":["trace[951672117] 'agreement among raft nodes before linearized reading' (duration: 118.806798ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:22:19.484361Z","caller":"traceutil/trace.go:171","msg":"trace[1071671614] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8347; }","duration":"133.355036ms","start":"2026-04-13T21:22:19.350985Z","end":"2026-04-13T21:22:19.48434Z","steps":["trace[1071671614] 'agreement among raft nodes before linearized reading' (duration: 133.191232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:22:19.485484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.850853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:22:19.485647Z","caller":"traceutil/trace.go:171","msg":"trace[754173634] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8347; }","duration":"150.176146ms","start":"2026-04-13T21:22:19.335401Z","end":"2026-04-13T21:22:19.485577Z","steps":["trace[754173634] 'agreement among raft nodes before linearized reading' (duration: 147.717829ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:22:47.749022Z","caller":"traceutil/trace.go:171","msg":"trace[985661216] transaction","detail":"{read_only:false; response_revision:8553; number_of_response:1; }","duration":"114.801919ms","start":"2026-04-13T21:22:47.634159Z","end":"2026-04-13T21:22:47.748961Z","steps":["trace[985661216] 'process raft request' (duration: 114.544182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:23:00.488021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.082154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:23:00.48837Z","caller":"traceutil/trace.go:171","msg":"trace[1286882836] transaction","detail":"{read_only:false; response_revision:8660; number_of_response:1; }","duration":"219.943213ms","start":"2026-04-13T21:23:00.268375Z","end":"2026-04-13T21:23:00.488318Z","steps":["trace[1286882836] 'process raft request' (duration: 107.402676ms)","trace[1286882836] 'compare' (duration: 111.445797ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:23:00.488664Z","caller":"traceutil/trace.go:171","msg":"trace[440952346] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"145.843817ms","start":"2026-04-13T21:23:00.342779Z","end":"2026-04-13T21:23:00.488623Z","steps":["trace[440952346] 'process raft request' (duration: 145.424325ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:23:00.620393Z","caller":"traceutil/trace.go:171","msg":"trace[828217695] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8663; }","duration":"121.594787ms","start":"2026-04-13T21:23:00.498757Z","end":"2026-04-13T21:23:00.620352Z","steps":["trace[828217695] 'process raft request' (duration: 121.297709ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:23:00.620479Z","caller":"traceutil/trace.go:171","msg":"trace[1708290242] transaction","detail":"{read_only:false; response_revision:8664; number_of_response:1; }","duration":"117.150204ms","start":"2026-04-13T21:23:00.503304Z","end":"2026-04-13T21:23:00.620454Z","steps":["trace[1708290242] 'process raft request' (duration: 116.962119ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:23:01.457578Z","caller":"traceutil/trace.go:171","msg":"trace[1708206552] transaction","detail":"{read_only:false; response_revision:8672; number_of_response:1; }","duration":"197.116272ms","start":"2026-04-13T21:23:01.260433Z","end":"2026-04-13T21:23:01.457549Z","steps":["trace[1708206552] 'process raft request' (duration: 196.892316ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:23:01.470073Z","caller":"traceutil/trace.go:171","msg":"trace[204379003] transaction","detail":"{read_only:false; response_revision:8673; number_of_response:1; }","duration":"206.615364ms","start":"2026-04-13T21:23:01.263433Z","end":"2026-04-13T21:23:01.470049Z","steps":["trace[204379003] 'process raft request' (duration: 206.417509ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:23:01.47027Z","caller":"traceutil/trace.go:171","msg":"trace[1320213187] linearizableReadLoop","detail":"{readStateIndex:8981; appliedIndex:8978; }","duration":"172.064681ms","start":"2026-04-13T21:23:01.298178Z","end":"2026-04-13T21:23:01.470242Z","steps":["trace[1320213187] 'read index received' (duration: 159.172175ms)","trace[1320213187] 'applied index is now lower than readState.Index' (duration: 12.889066ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:23:01.470336Z","caller":"traceutil/trace.go:171","msg":"trace[273030138] transaction","detail":"{read_only:false; response_revision:8674; number_of_response:1; }","duration":"184.3452ms","start":"2026-04-13T21:23:01.28598Z","end":"2026-04-13T21:23:01.470325Z","steps":["trace[273030138] 'process raft request' (duration: 184.021091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:23:01.470551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.368539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-04-13T21:23:01.470579Z","caller":"traceutil/trace.go:171","msg":"trace[476629509] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8674; }","duration":"172.468342ms","start":"2026-04-13T21:23:01.298102Z","end":"2026-04-13T21:23:01.470571Z","steps":["trace[476629509] 'agreement among raft nodes before linearized reading' (duration: 172.330658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:23:02.065512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.406057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210989"} {"level":"info","ts":"2026-04-13T21:23:02.065603Z","caller":"traceutil/trace.go:171","msg":"trace[1893430163] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8677; }","duration":"152.569113ms","start":"2026-04-13T21:23:01.913012Z","end":"2026-04-13T21:23:02.065582Z","steps":["trace[1893430163] 'range keys from in-memory index tree' (duration: 151.457072ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:23:17.593563Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023d9.wal"} {"level":"info","ts":"2026-04-13T21:24:16.099699Z","caller":"traceutil/trace.go:171","msg":"trace[465757527] linearizableReadLoop","detail":"{readStateIndex:9734; appliedIndex:9733; }","duration":"125.145715ms","start":"2026-04-13T21:24:15.974525Z","end":"2026-04-13T21:24:16.099671Z","steps":["trace[465757527] 'read index received' (duration: 124.94394ms)","trace[465757527] 'applied index is now lower than readState.Index' (duration: 200.375µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:24:16.099731Z","caller":"traceutil/trace.go:171","msg":"trace[22902994] transaction","detail":"{read_only:false; response_revision:9409; number_of_response:1; }","duration":"126.671577ms","start":"2026-04-13T21:24:15.973033Z","end":"2026-04-13T21:24:16.099705Z","steps":["trace[22902994] 'process raft request' (duration: 126.441371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:24:16.100451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.898636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:31 size:291245"} {"level":"info","ts":"2026-04-13T21:24:16.100562Z","caller":"traceutil/trace.go:171","msg":"trace[1091623510] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:31; response_revision:9409; }","duration":"126.085141ms","start":"2026-04-13T21:24:15.974446Z","end":"2026-04-13T21:24:16.100531Z","steps":["trace[1091623510] 'agreement among raft nodes before linearized reading' (duration: 125.34599ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:24:50.671023Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3aaa5c123e150e0","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-13T21:24:50.677114Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-13T21:24:50.677255Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-13T21:27:07.924966Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8284} {"level":"info","ts":"2026-04-13T21:27:08.005366Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8284,"took":"78.128312ms","hash":1516307231,"current-db-size-bytes":56762368,"current-db-size":"57 MB","current-db-size-in-use-bytes":25997312,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-13T21:27:08.005437Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1516307231,"revision":8284,"compact-revision":6061} {"level":"info","ts":"2026-04-13T21:29:01.214884Z","caller":"traceutil/trace.go:171","msg":"trace[1528080060] transaction","detail":"{read_only:false; response_revision:11284; number_of_response:1; }","duration":"254.678642ms","start":"2026-04-13T21:29:00.960142Z","end":"2026-04-13T21:29:01.214821Z","steps":["trace[1528080060] 'process raft request' (duration: 254.410825ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:29:01.939471Z","caller":"traceutil/trace.go:171","msg":"trace[719675652] transaction","detail":"{read_only:false; response_revision:11286; number_of_response:1; }","duration":"132.12724ms","start":"2026-04-13T21:29:01.807275Z","end":"2026-04-13T21:29:01.939403Z","steps":["trace[719675652] 'process raft request' (duration: 131.77359ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:29:40.773956Z","caller":"traceutil/trace.go:171","msg":"trace[927845794] transaction","detail":"{read_only:false; response_revision:11481; number_of_response:1; }","duration":"121.967783ms","start":"2026-04-13T21:29:40.651912Z","end":"2026-04-13T21:29:40.77388Z","steps":["trace[927845794] 'process raft request' (duration: 121.665615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:30:40.780887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.32067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-13T21:30:40.781054Z","caller":"traceutil/trace.go:171","msg":"trace[627533844] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11789; }","duration":"312.549966ms","start":"2026-04-13T21:30:40.46848Z","end":"2026-04-13T21:30:40.78103Z","steps":["trace[627533844] 'range keys from in-memory index tree' (duration: 312.081803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:30:40.781063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.913973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-04-13T21:30:40.781104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:30:40.468452Z","time spent":"312.638498ms","remote":"127.0.0.1:54248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-13T21:30:40.781136Z","caller":"traceutil/trace.go:171","msg":"trace[1972793141] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11789; }","duration":"310.060857ms","start":"2026-04-13T21:30:40.471057Z","end":"2026-04-13T21:30:40.781118Z","steps":["trace[1972793141] 'range keys from in-memory index tree' (duration: 309.639435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:30:40.781169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:30:40.471029Z","time spent":"310.134429ms","remote":"127.0.0.1:54248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-04-13T21:32:07.93296Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10683} {"level":"info","ts":"2026-04-13T21:32:08.009838Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10683,"took":"74.89698ms","hash":366155324,"current-db-size-bytes":56762368,"current-db-size":"57 MB","current-db-size-in-use-bytes":21118976,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-13T21:32:08.009912Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":366155324,"revision":10683,"compact-revision":8284}