{"level":"warn","ts":"2026-04-06T21:06:13.666092Z","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-06T21:06:13.666207Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89: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.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-06T21:06:13.666287Z","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-06T21:06:13.666305Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-04-06T21:06:13.666352Z","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-06T21:06:13.667006Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-04-06T21:06:13.667107Z","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.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-06T21:06:13.67074Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.402682ms"} {"level":"info","ts":"2026-04-06T21:06:13.680689Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-04-06T21:06:13.680814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-06T21:06:13.680888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-04-06T21:06:13.680912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-06T21:06:13.680957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-04-06T21:06:13.681065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-04-06T21:06:13.693389Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-06T21:06:13.696322Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-06T21:06:13.698328Z","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-06T21:06:13.701343Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-06T21:06:13.701601Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-06T21:06:13.701643Z","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-06T21:06:13.701926Z","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-06T21:06:13.70205Z","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-06T21:06:13.702958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-04-06T21:06:13.703091Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-04-06T21:06:13.705401Z","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-06T21:06:13.705554Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-04-06T21:06:13.705601Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-04-06T21:06:13.70577Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-06T21:06:13.705816Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-06T21:06:14.082082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-06T21:06:14.082167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-06T21:06:14.082229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-04-06T21:06:14.08228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-04-06T21:06:14.082318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-04-06T21:06:14.082345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-04-06T21:06:14.082367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-04-06T21:06:14.084969Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:06:14.085664Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-04-06T21:06:14.085705Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T21:06:14.085821Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T21:06:14.086526Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-06T21:06:14.086657Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-06T21:06:14.08682Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:06:14.086997Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:06:14.087071Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:06:14.090191Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-06T21:06:14.090271Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-04-06T21:06:26.610403Z","caller":"traceutil/trace.go:171","msg":"trace[470610053] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"107.005338ms","start":"2026-04-06T21:06:26.503357Z","end":"2026-04-06T21:06:26.610363Z","steps":["trace[470610053] 'process raft request' (duration: 106.819854ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:27.174328Z","caller":"traceutil/trace.go:171","msg":"trace[1722805961] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"178.667106ms","start":"2026-04-06T21:06:26.995613Z","end":"2026-04-06T21:06:27.17428Z","steps":["trace[1722805961] 'process raft request' (duration: 178.35641ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:47.012835Z","caller":"traceutil/trace.go:171","msg":"trace[599987987] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"105.465743ms","start":"2026-04-06T21:06:46.907338Z","end":"2026-04-06T21:06:47.012804Z","steps":["trace[599987987] 'process raft request' (duration: 100.755012ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:47.013093Z","caller":"traceutil/trace.go:171","msg":"trace[1444067709] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"104.854641ms","start":"2026-04-06T21:06:46.908198Z","end":"2026-04-06T21:06:47.013053Z","steps":["trace[1444067709] 'process raft request' (duration: 104.541805ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:47.246884Z","caller":"traceutil/trace.go:171","msg":"trace[131418989] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"129.622234ms","start":"2026-04-06T21:06:47.11723Z","end":"2026-04-06T21:06:47.246853Z","steps":["trace[131418989] 'process raft request' (duration: 122.323902ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:47.247049Z","caller":"traceutil/trace.go:171","msg":"trace[1949907945] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"124.599197ms","start":"2026-04-06T21:06:47.122401Z","end":"2026-04-06T21:06:47.247Z","steps":["trace[1949907945] 'process raft request' (duration: 124.362101ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:53.564911Z","caller":"traceutil/trace.go:171","msg":"trace[1085538941] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"192.761915ms","start":"2026-04-06T21:06:53.372119Z","end":"2026-04-06T21:06:53.564881Z","steps":["trace[1085538941] 'read index received' (duration: 191.803976ms)","trace[1085538941] 'applied index is now lower than readState.Index' (duration: 956.269µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:06:53.565017Z","caller":"traceutil/trace.go:171","msg":"trace[593050736] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"210.086372ms","start":"2026-04-06T21:06:53.354888Z","end":"2026-04-06T21:06:53.564974Z","steps":["trace[593050736] 'process raft request' (duration: 209.287236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:53.565167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.01446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:06:53.565302Z","caller":"traceutil/trace.go:171","msg":"trace[274493222] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:589; }","duration":"193.196073ms","start":"2026-04-06T21:06:53.372087Z","end":"2026-04-06T21:06:53.565283Z","steps":["trace[274493222] 'agreement among raft nodes before linearized reading' (duration: 192.976509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:53.566077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.986489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:06:53.56613Z","caller":"traceutil/trace.go:171","msg":"trace[2095792607] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:589; }","duration":"193.05711ms","start":"2026-04-06T21:06:53.373061Z","end":"2026-04-06T21:06:53.566118Z","steps":["trace[2095792607] 'agreement among raft nodes before linearized reading' (duration: 192.961689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:53.565523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.331466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:06:53.5664Z","caller":"traceutil/trace.go:171","msg":"trace[13752572] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:589; }","duration":"194.246484ms","start":"2026-04-06T21:06:53.372129Z","end":"2026-04-06T21:06:53.566375Z","steps":["trace[13752572] 'agreement among raft nodes before linearized reading' (duration: 193.285995ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:53.818479Z","caller":"traceutil/trace.go:171","msg":"trace[616215563] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"160.935835ms","start":"2026-04-06T21:06:53.657515Z","end":"2026-04-06T21:06:53.81845Z","steps":["trace[616215563] 'read index received' (duration: 160.707201ms)","trace[616215563] 'applied index is now lower than readState.Index' (duration: 227.724µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:06:53.818537Z","caller":"traceutil/trace.go:171","msg":"trace[418472305] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"163.526205ms","start":"2026-04-06T21:06:53.654972Z","end":"2026-04-06T21:06:53.818498Z","steps":["trace[418472305] 'process raft request' (duration: 163.345932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:53.818812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.19353ms","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":"info","ts":"2026-04-06T21:06:53.818848Z","caller":"traceutil/trace.go:171","msg":"trace[1870750699] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"161.271462ms","start":"2026-04-06T21:06:53.657566Z","end":"2026-04-06T21:06:53.818838Z","steps":["trace[1870750699] 'agreement among raft nodes before linearized reading' (duration: 161.048107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:53.818874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.327393ms","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-06T21:06:53.818983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.842128ms","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":"info","ts":"2026-04-06T21:06:53.818985Z","caller":"traceutil/trace.go:171","msg":"trace[238333217] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"161.491905ms","start":"2026-04-06T21:06:53.657476Z","end":"2026-04-06T21:06:53.818968Z","steps":["trace[238333217] 'agreement among raft nodes before linearized reading' (duration: 161.098538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:53.818908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.380979ms","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":"info","ts":"2026-04-06T21:06:53.819033Z","caller":"traceutil/trace.go:171","msg":"trace[368177837] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"131.895129ms","start":"2026-04-06T21:06:53.68712Z","end":"2026-04-06T21:06:53.819015Z","steps":["trace[368177837] 'agreement among raft nodes before linearized reading' (duration: 131.841938ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:53.819162Z","caller":"traceutil/trace.go:171","msg":"trace[1426274204] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"131.591693ms","start":"2026-04-06T21:06:53.68748Z","end":"2026-04-06T21:06:53.819072Z","steps":["trace[1426274204] 'agreement among raft nodes before linearized reading' (duration: 131.356479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:53.819157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.162964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:06:53.819314Z","caller":"traceutil/trace.go:171","msg":"trace[1508727892] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:590; }","duration":"131.44416ms","start":"2026-04-06T21:06:53.687852Z","end":"2026-04-06T21:06:53.819296Z","steps":["trace[1508727892] 'agreement among raft nodes before linearized reading' (duration: 130.812427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:54.613864Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095028958049819,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-06T21:06:54.640165Z","caller":"traceutil/trace.go:171","msg":"trace[2142880053] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"527.240141ms","start":"2026-04-06T21:06:54.112887Z","end":"2026-04-06T21:06:54.640127Z","steps":["trace[2142880053] 'read index received' (duration: 526.930105ms)","trace[2142880053] 'applied index is now lower than readState.Index' (duration: 308.875µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:06:54.640205Z","caller":"traceutil/trace.go:171","msg":"trace[1879876464] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"532.548223ms","start":"2026-04-06T21:06:54.107634Z","end":"2026-04-06T21:06:54.640182Z","steps":["trace[1879876464] 'process raft request' (duration: 532.293408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:54.640344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.848752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:06:54.640384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.458884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:06:54.640452Z","caller":"traceutil/trace.go:171","msg":"trace[289598725] 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:597; }","duration":"527.603267ms","start":"2026-04-06T21:06:54.112831Z","end":"2026-04-06T21:06:54.640435Z","steps":["trace[289598725] 'agreement among raft nodes before linearized reading' (duration: 527.442924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:54.640514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:06:54.112797Z","time spent":"527.701598ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-04-06T21:06:54.64061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.295316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-06T21:06:54.640401Z","caller":"traceutil/trace.go:171","msg":"trace[1163526989] 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:597; }","duration":"526.950663ms","start":"2026-04-06T21:06:54.113435Z","end":"2026-04-06T21:06:54.640386Z","steps":["trace[1163526989] 'agreement among raft nodes before linearized reading' (duration: 526.834691ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:54.640665Z","caller":"traceutil/trace.go:171","msg":"trace[1221712025] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"382.391338ms","start":"2026-04-06T21:06:54.25826Z","end":"2026-04-06T21:06:54.640651Z","steps":["trace[1221712025] 'agreement among raft nodes before linearized reading' (duration: 382.165834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:54.640712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:06:54.258233Z","time spent":"382.467239ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-06T21:06:54.640701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:06:54.113427Z","time spent":"527.24926ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-06T21:06:54.640693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.972104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:06:54.640904Z","caller":"traceutil/trace.go:171","msg":"trace[1853993361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"143.28412ms","start":"2026-04-06T21:06:54.497589Z","end":"2026-04-06T21:06:54.640873Z","steps":["trace[1853993361] 'agreement among raft nodes before linearized reading' (duration: 142.846542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:54.640908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.202148ms","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-06T21:06:54.640997Z","caller":"traceutil/trace.go:171","msg":"trace[350245290] 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:597; }","duration":"527.395002ms","start":"2026-04-06T21:06:54.113581Z","end":"2026-04-06T21:06:54.640976Z","steps":["trace[350245290] 'agreement among raft nodes before linearized reading' (duration: 526.953704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:54.641047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:06:54.113567Z","time spent":"527.469115ms","remote":"127.0.0.1:46810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-06T21:06:54.641684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:06:54.10761Z","time spent":"532.650865ms","remote":"127.0.0.1:46378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T21:06:54.972295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.528937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-06T21:06:54.972434Z","caller":"traceutil/trace.go:171","msg":"trace[213722658] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:598; }","duration":"178.737451ms","start":"2026-04-06T21:06:54.793661Z","end":"2026-04-06T21:06:54.972398Z","steps":["trace[213722658] 'range keys from in-memory index tree' (duration: 178.247582ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:56.3509Z","caller":"traceutil/trace.go:171","msg":"trace[122857201] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"134.424218ms","start":"2026-04-06T21:06:56.21645Z","end":"2026-04-06T21:06:56.350874Z","steps":["trace[122857201] 'read index received' (duration: 128.261477ms)","trace[122857201] 'applied index is now lower than readState.Index' (duration: 6.161191ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:06:56.351058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.571501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:06:56.351087Z","caller":"traceutil/trace.go:171","msg":"trace[709524450] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:616; }","duration":"134.639212ms","start":"2026-04-06T21:06:56.216436Z","end":"2026-04-06T21:06:56.351075Z","steps":["trace[709524450] 'agreement among raft nodes before linearized reading' (duration: 134.560591ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:56.351069Z","caller":"traceutil/trace.go:171","msg":"trace[654938600] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"135.065431ms","start":"2026-04-06T21:06:56.21596Z","end":"2026-04-06T21:06:56.351026Z","steps":["trace[654938600] 'process raft request' (duration: 128.658226ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:56.356192Z","caller":"traceutil/trace.go:171","msg":"trace[870287815] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"136.532169ms","start":"2026-04-06T21:06:56.219611Z","end":"2026-04-06T21:06:56.356143Z","steps":["trace[870287815] 'process raft request' (duration: 136.256404ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:56.35632Z","caller":"traceutil/trace.go:171","msg":"trace[81950182] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"136.261395ms","start":"2026-04-06T21:06:56.220039Z","end":"2026-04-06T21:06:56.356301Z","steps":["trace[81950182] 'process raft request' (duration: 136.07409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:56.35643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.174371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:06:56.356605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.400136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:06:56.356603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.437427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:06:56.356676Z","caller":"traceutil/trace.go:171","msg":"trace[324195981] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:619; }","duration":"138.512358ms","start":"2026-04-06T21:06:56.218142Z","end":"2026-04-06T21:06:56.356655Z","steps":["trace[324195981] 'agreement among raft nodes before linearized reading' (duration: 138.350105ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:56.35669Z","caller":"traceutil/trace.go:171","msg":"trace[115566697] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:619; }","duration":"138.547879ms","start":"2026-04-06T21:06:56.218126Z","end":"2026-04-06T21:06:56.356674Z","steps":["trace[115566697] 'agreement among raft nodes before linearized reading' (duration: 138.413916ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:56.356618Z","caller":"traceutil/trace.go:171","msg":"trace[26303018] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:619; }","duration":"138.485737ms","start":"2026-04-06T21:06:56.218096Z","end":"2026-04-06T21:06:56.356581Z","steps":["trace[26303018] 'agreement among raft nodes before linearized reading' (duration: 138.11295ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:56.356716Z","caller":"traceutil/trace.go:171","msg":"trace[1643029249] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"136.679353ms","start":"2026-04-06T21:06:56.219984Z","end":"2026-04-06T21:06:56.356664Z","steps":["trace[1643029249] 'process raft request' (duration: 136.05804ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:09.747429Z","caller":"traceutil/trace.go:171","msg":"trace[691036100] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"162.898104ms","start":"2026-04-06T21:07:09.584497Z","end":"2026-04-06T21:07:09.747395Z","steps":["trace[691036100] 'process raft request' (duration: 162.71631ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:49.229348Z","caller":"traceutil/trace.go:171","msg":"trace[1376941536] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"226.315089ms","start":"2026-04-06T21:07:49.002998Z","end":"2026-04-06T21:07:49.229313Z","steps":["trace[1376941536] 'process raft request' (duration: 226.151976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:32.783424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.658706ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-06T21:08:32.783709Z","caller":"traceutil/trace.go:171","msg":"trace[2057379577] linearizableReadLoop","detail":"{readStateIndex:1894; appliedIndex:1893; }","duration":"285.888934ms","start":"2026-04-06T21:08:32.497795Z","end":"2026-04-06T21:08:32.783684Z","steps":["trace[2057379577] 'read index received' (duration: 92.793909ms)","trace[2057379577] 'applied index is now lower than readState.Index' (duration: 193.092875ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:08:32.784004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.035764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:08:32.784027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.200769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:08:32.784103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.414645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7cec382e-1b8a-40b9-8070-05b7c7b558f7\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-06T21:08:32.784144Z","caller":"traceutil/trace.go:171","msg":"trace[78476771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1837; }","duration":"286.385874ms","start":"2026-04-06T21:08:32.497729Z","end":"2026-04-06T21:08:32.784115Z","steps":["trace[78476771] 'agreement among raft nodes before linearized reading' (duration: 286.15534ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:08:32.784159Z","caller":"traceutil/trace.go:171","msg":"trace[1351362650] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1837; }","duration":"126.222078ms","start":"2026-04-06T21:08:32.657875Z","end":"2026-04-06T21:08:32.784097Z","steps":["trace[1351362650] 'agreement among raft nodes before linearized reading' (duration: 126.017634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:32.784077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.129162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-06T21:08:32.78421Z","caller":"traceutil/trace.go:171","msg":"trace[2113591933] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7cec382e-1b8a-40b9-8070-05b7c7b558f7; range_end:; response_count:1; response_revision:1837; }","duration":"178.565678ms","start":"2026-04-06T21:08:32.60562Z","end":"2026-04-06T21:08:32.784186Z","steps":["trace[2113591933] 'agreement among raft nodes before linearized reading' (duration: 178.286253ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:08:32.784285Z","caller":"traceutil/trace.go:171","msg":"trace[43680078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1837; }","duration":"243.342195ms","start":"2026-04-06T21:08:32.5409Z","end":"2026-04-06T21:08:32.784242Z","steps":["trace[43680078] 'agreement among raft nodes before linearized reading' (duration: 242.987619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:32.784311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.673499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"warn","ts":"2026-04-06T21:08:32.784365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.244255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7cec382e-1b8a-40b9-8070-05b7c7b558f7\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-06T21:08:32.784434Z","caller":"traceutil/trace.go:171","msg":"trace[1060917619] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1837; }","duration":"186.863072ms","start":"2026-04-06T21:08:32.597533Z","end":"2026-04-06T21:08:32.784396Z","steps":["trace[1060917619] 'agreement among raft nodes before linearized reading' (duration: 186.509246ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:08:32.784498Z","caller":"traceutil/trace.go:171","msg":"trace[1420147274] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7cec382e-1b8a-40b9-8070-05b7c7b558f7; range_end:; response_count:1; response_revision:1837; }","duration":"170.432819ms","start":"2026-04-06T21:08:32.614033Z","end":"2026-04-06T21:08:32.784466Z","steps":["trace[1420147274] 'agreement among raft nodes before linearized reading' (duration: 170.030011ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:08:32.914142Z","caller":"traceutil/trace.go:171","msg":"trace[1240929311] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"124.517774ms","start":"2026-04-06T21:08:32.789592Z","end":"2026-04-06T21:08:32.91411Z","steps":["trace[1240929311] 'process raft request' (duration: 124.30069ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:08:32.924231Z","caller":"traceutil/trace.go:171","msg":"trace[21184843] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"134.163044ms","start":"2026-04-06T21:08:32.790045Z","end":"2026-04-06T21:08:32.924208Z","steps":["trace[21184843] 'process raft request' (duration: 133.94623ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:08:32.924422Z","caller":"traceutil/trace.go:171","msg":"trace[1090659362] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"132.464639ms","start":"2026-04-06T21:08:32.791942Z","end":"2026-04-06T21:08:32.924407Z","steps":["trace[1090659362] 'process raft request' (duration: 132.194904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:08:41.79527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.307763ms","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-06T21:08:41.79539Z","caller":"traceutil/trace.go:171","msg":"trace[626352385] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1937; }","duration":"188.499457ms","start":"2026-04-06T21:08:41.606862Z","end":"2026-04-06T21:08:41.795362Z","steps":["trace[626352385] 'count revisions from in-memory index tree' (duration: 188.14978ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:09:15.372332Z","caller":"traceutil/trace.go:171","msg":"trace[1558517213] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"237.147631ms","start":"2026-04-06T21:09:15.135138Z","end":"2026-04-06T21:09:15.372286Z","steps":["trace[1558517213] 'process raft request' (duration: 181.906162ms)","trace[1558517213] 'compare' (duration: 55.070916ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:09:52.213656Z","caller":"traceutil/trace.go:171","msg":"trace[8393493] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"290.06099ms","start":"2026-04-06T21:09:51.923569Z","end":"2026-04-06T21:09:52.21363Z","steps":["trace[8393493] 'process raft request' (duration: 270.269363ms)","trace[8393493] 'compare' (duration: 19.312708ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:09:52.214339Z","caller":"traceutil/trace.go:171","msg":"trace[1501880050] transaction","detail":"{read_only:false; response_revision:2481; number_of_response:1; }","duration":"146.604994ms","start":"2026-04-06T21:09:52.067702Z","end":"2026-04-06T21:09:52.214307Z","steps":["trace[1501880050] 'process raft request' (duration: 145.8498ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:10:22.507498Z","caller":"traceutil/trace.go:171","msg":"trace[2081917994] linearizableReadLoop","detail":"{readStateIndex:2791; appliedIndex:2790; }","duration":"138.728738ms","start":"2026-04-06T21:10:22.36874Z","end":"2026-04-06T21:10:22.507469Z","steps":["trace[2081917994] 'read index received' (duration: 138.572166ms)","trace[2081917994] 'applied index is now lower than readState.Index' (duration: 155.672µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:10:22.507614Z","caller":"traceutil/trace.go:171","msg":"trace[897265200] transaction","detail":"{read_only:false; response_revision:2689; number_of_response:1; }","duration":"182.706522ms","start":"2026-04-06T21:10:22.324866Z","end":"2026-04-06T21:10:22.507572Z","steps":["trace[897265200] 'process raft request' (duration: 182.447848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:10:22.50775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.994935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-06T21:10:22.507794Z","caller":"traceutil/trace.go:171","msg":"trace[704895182] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2689; }","duration":"139.104386ms","start":"2026-04-06T21:10:22.368679Z","end":"2026-04-06T21:10:22.507783Z","steps":["trace[704895182] 'agreement among raft nodes before linearized reading' (duration: 138.939653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:10:22.512291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.983039ms","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-06T21:10:22.512389Z","caller":"traceutil/trace.go:171","msg":"trace[2142922925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2689; }","duration":"142.154782ms","start":"2026-04-06T21:10:22.370212Z","end":"2026-04-06T21:10:22.512367Z","steps":["trace[2142922925] 'agreement among raft nodes before linearized reading' (duration: 141.908508ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:10:28.062257Z","caller":"traceutil/trace.go:171","msg":"trace[1734647538] linearizableReadLoop","detail":"{readStateIndex:2831; appliedIndex:2830; }","duration":"292.324772ms","start":"2026-04-06T21:10:27.769903Z","end":"2026-04-06T21:10:28.062228Z","steps":["trace[1734647538] 'read index received' (duration: 292.069888ms)","trace[1734647538] 'applied index is now lower than readState.Index' (duration: 253.484µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:10:28.062402Z","caller":"traceutil/trace.go:171","msg":"trace[762951713] transaction","detail":"{read_only:false; response_revision:2726; number_of_response:1; }","duration":"304.882325ms","start":"2026-04-06T21:10:27.757484Z","end":"2026-04-06T21:10:28.062367Z","steps":["trace[762951713] 'process raft request' (duration: 304.494298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:10:28.062594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.015386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1296"} {"level":"warn","ts":"2026-04-06T21:10:28.062608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:10:27.757462Z","time spent":"305.015967ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:10:28.062695Z","caller":"traceutil/trace.go:171","msg":"trace[1233561309] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2726; }","duration":"205.167489ms","start":"2026-04-06T21:10:27.857509Z","end":"2026-04-06T21:10:28.062677Z","steps":["trace[1233561309] 'agreement among raft nodes before linearized reading' (duration: 204.918555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:10:28.062692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.714559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-06T21:10:28.062903Z","caller":"traceutil/trace.go:171","msg":"trace[1917412569] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2726; }","duration":"293.007455ms","start":"2026-04-06T21:10:27.769866Z","end":"2026-04-06T21:10:28.062874Z","steps":["trace[1917412569] 'agreement among raft nodes before linearized reading' (duration: 292.514836ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:11:00.803951Z","caller":"traceutil/trace.go:171","msg":"trace[895138797] linearizableReadLoop","detail":"{readStateIndex:3163; appliedIndex:3162; }","duration":"103.493868ms","start":"2026-04-06T21:11:00.700408Z","end":"2026-04-06T21:11:00.803901Z","steps":["trace[895138797] 'read index received' (duration: 83.20172ms)","trace[895138797] 'applied index is now lower than readState.Index' (duration: 20.289688ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:11:00.804329Z","caller":"traceutil/trace.go:171","msg":"trace[497312950] transaction","detail":"{read_only:false; response_revision:3041; number_of_response:1; }","duration":"105.161179ms","start":"2026-04-06T21:11:00.699145Z","end":"2026-04-06T21:11:00.804306Z","steps":["trace[497312950] 'process raft request' (duration: 84.497984ms)","trace[497312950] 'compare' (duration: 19.584695ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:11:00.804697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.273634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-06T21:11:00.804801Z","caller":"traceutil/trace.go:171","msg":"trace[162852417] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3041; }","duration":"104.447167ms","start":"2026-04-06T21:11:00.700329Z","end":"2026-04-06T21:11:00.804776Z","steps":["trace[162852417] 'agreement among raft nodes before linearized reading' (duration: 104.06932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:11:35.219804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.939355ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T21:11:35.220115Z","caller":"traceutil/trace.go:171","msg":"trace[3385308] transaction","detail":"{read_only:false; response_revision:3353; number_of_response:1; }","duration":"208.092757ms","start":"2026-04-06T21:11:35.011999Z","end":"2026-04-06T21:11:35.220092Z","steps":["trace[3385308] 'process raft request' (duration: 207.968315ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:11:35.220088Z","caller":"traceutil/trace.go:171","msg":"trace[1909404011] transaction","detail":"{read_only:false; response_revision:3352; number_of_response:1; }","duration":"208.518245ms","start":"2026-04-06T21:11:35.011533Z","end":"2026-04-06T21:11:35.220052Z","steps":["trace[1909404011] 'process raft request' (duration: 15.187743ms)","trace[1909404011] 'compare' (duration: 192.593749ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:11:35.220316Z","caller":"traceutil/trace.go:171","msg":"trace[1423569376] transaction","detail":"{read_only:false; number_of_response:0; response_revision:3353; }","duration":"207.227241ms","start":"2026-04-06T21:11:35.013026Z","end":"2026-04-06T21:11:35.220254Z","steps":["trace[1423569376] 'process raft request' (duration: 207.019308ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:11:35.346465Z","caller":"traceutil/trace.go:171","msg":"trace[323415152] transaction","detail":"{read_only:false; response_revision:3354; number_of_response:1; }","duration":"111.344594ms","start":"2026-04-06T21:11:35.23509Z","end":"2026-04-06T21:11:35.346435Z","steps":["trace[323415152] 'process raft request' (duration: 99.102187ms)","trace[323415152] 'compare' (duration: 12.068924ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:12:38.929556Z","caller":"traceutil/trace.go:171","msg":"trace[740623362] transaction","detail":"{read_only:false; response_revision:3875; number_of_response:1; }","duration":"106.846103ms","start":"2026-04-06T21:12:38.822666Z","end":"2026-04-06T21:12:38.929512Z","steps":["trace[740623362] 'process raft request' (duration: 106.519027ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:45.655564Z","caller":"traceutil/trace.go:171","msg":"trace[1445973170] transaction","detail":"{read_only:false; response_revision:4279; number_of_response:1; }","duration":"144.390549ms","start":"2026-04-06T21:12:45.51114Z","end":"2026-04-06T21:12:45.65553Z","steps":["trace[1445973170] 'process raft request' (duration: 138.839606ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:45.664794Z","caller":"traceutil/trace.go:171","msg":"trace[750949994] transaction","detail":"{read_only:false; response_revision:4280; number_of_response:1; }","duration":"149.895931ms","start":"2026-04-06T21:12:45.514876Z","end":"2026-04-06T21:12:45.664772Z","steps":["trace[750949994] 'process raft request' (duration: 149.701348ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:56.608959Z","caller":"traceutil/trace.go:171","msg":"trace[329682540] transaction","detail":"{read_only:false; response_revision:4552; number_of_response:1; }","duration":"165.081742ms","start":"2026-04-06T21:12:56.443854Z","end":"2026-04-06T21:12:56.608935Z","steps":["trace[329682540] 'process raft request' (duration: 164.886228ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:56.611311Z","caller":"traceutil/trace.go:171","msg":"trace[869597268] transaction","detail":"{read_only:false; response_revision:4553; number_of_response:1; }","duration":"131.033731ms","start":"2026-04-06T21:12:56.480245Z","end":"2026-04-06T21:12:56.611278Z","steps":["trace[869597268] 'process raft request' (duration: 130.851757ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:56.915147Z","caller":"traceutil/trace.go:171","msg":"trace[1888020889] transaction","detail":"{read_only:false; response_revision:4558; number_of_response:1; }","duration":"133.738001ms","start":"2026-04-06T21:12:56.781379Z","end":"2026-04-06T21:12:56.915117Z","steps":["trace[1888020889] 'process raft request' (duration: 133.485687ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:57.219991Z","caller":"traceutil/trace.go:171","msg":"trace[936902027] transaction","detail":"{read_only:false; response_revision:4560; number_of_response:1; }","duration":"161.967625ms","start":"2026-04-06T21:12:57.057991Z","end":"2026-04-06T21:12:57.219959Z","steps":["trace[936902027] 'process raft request' (duration: 101.916081ms)","trace[936902027] 'compare' (duration: 59.81874ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:12:57.220223Z","caller":"traceutil/trace.go:171","msg":"trace[402522641] linearizableReadLoop","detail":"{readStateIndex:4753; appliedIndex:4751; }","duration":"158.798806ms","start":"2026-04-06T21:12:57.061356Z","end":"2026-04-06T21:12:57.220155Z","steps":["trace[402522641] 'read index received' (duration: 7.300365ms)","trace[402522641] 'applied index is now lower than readState.Index' (duration: 151.491491ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:12:57.220326Z","caller":"traceutil/trace.go:171","msg":"trace[1966913200] transaction","detail":"{read_only:false; response_revision:4561; number_of_response:1; }","duration":"154.269322ms","start":"2026-04-06T21:12:57.066022Z","end":"2026-04-06T21:12:57.220292Z","steps":["trace[1966913200] 'process raft request' (duration: 153.862685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:12:57.220559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.701744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-06T21:12:57.220625Z","caller":"traceutil/trace.go:171","msg":"trace[1833697253] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4561; }","duration":"158.805876ms","start":"2026-04-06T21:12:57.061805Z","end":"2026-04-06T21:12:57.220611Z","steps":["trace[1833697253] 'agreement among raft nodes before linearized reading' (duration: 158.583572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:12:57.220622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.216373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-06T21:12:57.220718Z","caller":"traceutil/trace.go:171","msg":"trace[1399699855] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4561; }","duration":"159.363936ms","start":"2026-04-06T21:12:57.061326Z","end":"2026-04-06T21:12:57.22069Z","steps":["trace[1399699855] 'agreement among raft nodes before linearized reading' (duration: 159.03209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:12:58.361999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.158599ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-06T21:12:58.362506Z","caller":"traceutil/trace.go:171","msg":"trace[1912222496] transaction","detail":"{read_only:false; response_revision:4609; number_of_response:1; }","duration":"182.744561ms","start":"2026-04-06T21:12:58.179727Z","end":"2026-04-06T21:12:58.362472Z","steps":["trace[1912222496] 'process raft request' (duration: 26.808077ms)","trace[1912222496] 'compare' (duration: 154.484057ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:12:58.363442Z","caller":"traceutil/trace.go:171","msg":"trace[1990791283] linearizableReadLoop","detail":"{readStateIndex:4806; appliedIndex:4805; }","duration":"179.757894ms","start":"2026-04-06T21:12:58.183497Z","end":"2026-04-06T21:12:58.363255Z","steps":["trace[1990791283] 'read index received' (duration: 23.021076ms)","trace[1990791283] 'applied index is now lower than readState.Index' (duration: 156.733778ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:12:58.364068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.55825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-06T21:12:58.364142Z","caller":"traceutil/trace.go:171","msg":"trace[1075282497] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4610; }","duration":"180.690953ms","start":"2026-04-06T21:12:58.183433Z","end":"2026-04-06T21:12:58.364124Z","steps":["trace[1075282497] 'agreement among raft nodes before linearized reading' (duration: 180.389197ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:58.364172Z","caller":"traceutil/trace.go:171","msg":"trace[717673847] transaction","detail":"{read_only:false; response_revision:4610; number_of_response:1; }","duration":"142.435503ms","start":"2026-04-06T21:12:58.220568Z","end":"2026-04-06T21:12:58.363003Z","steps":["trace[717673847] 'process raft request' (duration: 142.305331ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:08.769859Z","caller":"traceutil/trace.go:171","msg":"trace[2120040813] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"106.824833ms","start":"2026-04-06T21:13:08.663004Z","end":"2026-04-06T21:13:08.769829Z","steps":["trace[2120040813] 'process raft request' (duration: 106.568798ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:08.819798Z","caller":"traceutil/trace.go:171","msg":"trace[483186337] transaction","detail":"{read_only:false; response_revision:4815; number_of_response:1; }","duration":"152.906743ms","start":"2026-04-06T21:13:08.666846Z","end":"2026-04-06T21:13:08.819753Z","steps":["trace[483186337] 'process raft request' (duration: 115.338922ms)","trace[483186337] 'compare' (duration: 37.262445ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:13:09.50204Z","caller":"traceutil/trace.go:171","msg":"trace[1819541209] linearizableReadLoop","detail":"{readStateIndex:5028; appliedIndex:5027; }","duration":"284.07901ms","start":"2026-04-06T21:13:09.217931Z","end":"2026-04-06T21:13:09.50201Z","steps":["trace[1819541209] 'read index received' (duration: 283.785795ms)","trace[1819541209] 'applied index is now lower than readState.Index' (duration: 291.545µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:13:09.502113Z","caller":"traceutil/trace.go:171","msg":"trace[779449389] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"342.646562ms","start":"2026-04-06T21:13:09.159425Z","end":"2026-04-06T21:13:09.502072Z","steps":["trace[779449389] 'process raft request' (duration: 342.365517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:13:09.502267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.308764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-06T21:13:09.502359Z","caller":"traceutil/trace.go:171","msg":"trace[621876837] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:4823; }","duration":"284.471517ms","start":"2026-04-06T21:13:09.21787Z","end":"2026-04-06T21:13:09.502341Z","steps":["trace[621876837] 'agreement among raft nodes before linearized reading' (duration: 284.262813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:13:09.502358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:13:09.159404Z","time spent":"342.834435ms","remote":"127.0.0.1:46378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5180,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T21:13:09.524504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.985787ms","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-06T21:13:09.524483Z","caller":"traceutil/trace.go:171","msg":"trace[764109294] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"256.746689ms","start":"2026-04-06T21:13:09.267686Z","end":"2026-04-06T21:13:09.524433Z","steps":["trace[764109294] 'process raft request' (duration: 256.441834ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:09.52458Z","caller":"traceutil/trace.go:171","msg":"trace[667212311] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4824; }","duration":"210.1221ms","start":"2026-04-06T21:13:09.314439Z","end":"2026-04-06T21:13:09.524562Z","steps":["trace[667212311] 'agreement among raft nodes before linearized reading' (duration: 209.937226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:13:09.52461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.176501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wv9fq\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-06T21:13:09.524767Z","caller":"traceutil/trace.go:171","msg":"trace[2009499461] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wv9fq; range_end:; response_count:1; response_revision:4824; }","duration":"210.395305ms","start":"2026-04-06T21:13:09.314348Z","end":"2026-04-06T21:13:09.524743Z","steps":["trace[2009499461] 'agreement among raft nodes before linearized reading' (duration: 209.975567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:13:09.524628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.16053ms","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-06T21:13:09.524895Z","caller":"traceutil/trace.go:171","msg":"trace[974794402] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4824; }","duration":"210.443716ms","start":"2026-04-06T21:13:09.314395Z","end":"2026-04-06T21:13:09.524839Z","steps":["trace[974794402] 'agreement among raft nodes before linearized reading' (duration: 209.923546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:13:16.101548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.289457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-s2mgv.18a3e0eaffe4774f\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-04-06T21:13:16.101744Z","caller":"traceutil/trace.go:171","msg":"trace[1801908685] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-s2mgv.18a3e0eaffe4774f; range_end:; response_count:1; response_revision:4984; }","duration":"147.547683ms","start":"2026-04-06T21:13:15.954167Z","end":"2026-04-06T21:13:16.101715Z","steps":["trace[1801908685] 'range keys from in-memory index tree' (duration: 146.986333ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:16.452109Z","caller":"traceutil/trace.go:171","msg":"trace[143355904] transaction","detail":"{read_only:false; response_revision:4986; number_of_response:1; }","duration":"142.649701ms","start":"2026-04-06T21:13:16.309423Z","end":"2026-04-06T21:13:16.452073Z","steps":["trace[143355904] 'process raft request' (duration: 142.468198ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:16.6987Z","caller":"traceutil/trace.go:171","msg":"trace[1894795281] linearizableReadLoop","detail":"{readStateIndex:5197; appliedIndex:5196; }","duration":"200.668403ms","start":"2026-04-06T21:13:16.497996Z","end":"2026-04-06T21:13:16.698664Z","steps":["trace[1894795281] 'read index received' (duration: 196.410254ms)","trace[1894795281] 'applied index is now lower than readState.Index' (duration: 4.254709ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:13:16.699023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.668385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-06T21:13:16.699079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.03961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:13:16.699095Z","caller":"traceutil/trace.go:171","msg":"trace[1570550018] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:4987; }","duration":"176.801447ms","start":"2026-04-06T21:13:16.522274Z","end":"2026-04-06T21:13:16.699075Z","steps":["trace[1570550018] 'agreement among raft nodes before linearized reading' (duration: 176.649325ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:16.699133Z","caller":"traceutil/trace.go:171","msg":"trace[407418666] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4987; }","duration":"201.155171ms","start":"2026-04-06T21:13:16.497963Z","end":"2026-04-06T21:13:16.699118Z","steps":["trace[407418666] 'agreement among raft nodes before linearized reading' (duration: 200.874606ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:16.698784Z","caller":"traceutil/trace.go:171","msg":"trace[997980338] transaction","detail":"{read_only:false; response_revision:4987; number_of_response:1; }","duration":"232.239692ms","start":"2026-04-06T21:13:16.466506Z","end":"2026-04-06T21:13:16.698746Z","steps":["trace[997980338] 'process raft request' (duration: 227.981293ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:27.528709Z","caller":"traceutil/trace.go:171","msg":"trace[533662607] transaction","detail":"{read_only:false; response_revision:5139; number_of_response:1; }","duration":"129.039297ms","start":"2026-04-06T21:13:27.399641Z","end":"2026-04-06T21:13:27.52868Z","steps":["trace[533662607] 'process raft request' (duration: 128.786273ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:27.528897Z","caller":"traceutil/trace.go:171","msg":"trace[1037643201] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"128.735072ms","start":"2026-04-06T21:13:27.400101Z","end":"2026-04-06T21:13:27.528836Z","steps":["trace[1037643201] 'process raft request' (duration: 128.499318ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:13:27.528961Z","caller":"traceutil/trace.go:171","msg":"trace[473644255] transaction","detail":"{read_only:false; response_revision:5141; number_of_response:1; }","duration":"128.6335ms","start":"2026-04-06T21:13:27.400302Z","end":"2026-04-06T21:13:27.528935Z","steps":["trace[473644255] 'process raft request' (duration: 128.355725ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:16:14.116646Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3206} {"level":"info","ts":"2026-04-06T21:16:14.210882Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3206,"took":"91.806641ms","hash":4008165332,"current-db-size-bytes":61046784,"current-db-size":"61 MB","current-db-size-in-use-bytes":33538048,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-06T21:16:14.210977Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4008165332,"revision":3206,"compact-revision":-1} {"level":"info","ts":"2026-04-06T21:19:06.660438Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002161.wal"} {"level":"info","ts":"2026-04-06T21:19:11.170619Z","caller":"traceutil/trace.go:171","msg":"trace[2141448630] transaction","detail":"{read_only:false; response_revision:8214; number_of_response:1; }","duration":"244.64456ms","start":"2026-04-06T21:19:10.925937Z","end":"2026-04-06T21:19:11.170581Z","steps":["trace[2141448630] 'process raft request' (duration: 244.434916ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:22.925714Z","caller":"traceutil/trace.go:171","msg":"trace[1105360205] transaction","detail":"{read_only:false; response_revision:8294; number_of_response:1; }","duration":"324.885396ms","start":"2026-04-06T21:19:22.600793Z","end":"2026-04-06T21:19:22.925678Z","steps":["trace[1105360205] 'process raft request' (duration: 324.63152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:19:22.92594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:19:22.600762Z","time spent":"325.069898ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T21:19:22.956395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.063539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11495"} {"level":"info","ts":"2026-04-06T21:19:22.956499Z","caller":"traceutil/trace.go:171","msg":"trace[804396573] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8294; }","duration":"100.252274ms","start":"2026-04-06T21:19:22.856224Z","end":"2026-04-06T21:19:22.956477Z","steps":["trace[804396573] 'agreement among raft nodes before linearized reading' (duration: 99.976688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:19:23.793719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.642694ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T21:19:23.793998Z","caller":"traceutil/trace.go:171","msg":"trace[1856405802] transaction","detail":"{read_only:false; response_revision:8298; number_of_response:1; }","duration":"368.852755ms","start":"2026-04-06T21:19:23.425128Z","end":"2026-04-06T21:19:23.793981Z","steps":["trace[1856405802] 'process raft request' (duration: 190.849014ms)","trace[1856405802] 'compare' (duration: 177.157605ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:19:23.794043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:19:23.425099Z","time spent":"368.923256ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:19:23.976191Z","caller":"traceutil/trace.go:171","msg":"trace[1534627383] linearizableReadLoop","detail":"{readStateIndex:8671; appliedIndex:8669; }","duration":"155.548217ms","start":"2026-04-06T21:19:23.820612Z","end":"2026-04-06T21:19:23.97616Z","steps":["trace[1534627383] 'read index received' (duration: 155.334603ms)","trace[1534627383] 'applied index is now lower than readState.Index' (duration: 212.644µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:19:23.976213Z","caller":"traceutil/trace.go:171","msg":"trace[220965695] transaction","detail":"{read_only:false; response_revision:8300; number_of_response:1; }","duration":"176.122095ms","start":"2026-04-06T21:19:23.800048Z","end":"2026-04-06T21:19:23.97617Z","steps":["trace[220965695] 'process raft request' (duration: 175.86859ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:23.976256Z","caller":"traceutil/trace.go:171","msg":"trace[735552771] transaction","detail":"{read_only:false; response_revision:8301; number_of_response:1; }","duration":"176.117565ms","start":"2026-04-06T21:19:23.800096Z","end":"2026-04-06T21:19:23.976213Z","steps":["trace[735552771] 'process raft request' (duration: 176.021013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:19:23.976573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.842951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-04-06T21:19:23.976647Z","caller":"traceutil/trace.go:171","msg":"trace[2041785279] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8301; }","duration":"175.971032ms","start":"2026-04-06T21:19:23.800653Z","end":"2026-04-06T21:19:23.976624Z","steps":["trace[2041785279] 'agreement among raft nodes before linearized reading' (duration: 175.687237ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:23.986116Z","caller":"traceutil/trace.go:171","msg":"trace[1967792709] transaction","detail":"{read_only:false; response_revision:8302; number_of_response:1; }","duration":"160.881217ms","start":"2026-04-06T21:19:23.825222Z","end":"2026-04-06T21:19:23.986103Z","steps":["trace[1967792709] 'process raft request' (duration: 160.716974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:19:23.986251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.697116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wv9fq\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-06T21:19:23.986349Z","caller":"traceutil/trace.go:171","msg":"trace[2129798707] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wv9fq; range_end:; response_count:1; response_revision:8302; }","duration":"158.826388ms","start":"2026-04-06T21:19:23.8275Z","end":"2026-04-06T21:19:23.986326Z","steps":["trace[2129798707] 'agreement among raft nodes before linearized reading' (duration: 158.570334ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:51.515598Z","caller":"traceutil/trace.go:171","msg":"trace[1234346817] transaction","detail":"{read_only:false; response_revision:8536; number_of_response:1; }","duration":"200.481982ms","start":"2026-04-06T21:19:51.315088Z","end":"2026-04-06T21:19:51.51557Z","steps":["trace[1234346817] 'process raft request' (duration: 200.255518ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:04.045593Z","caller":"traceutil/trace.go:171","msg":"trace[395098369] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"100.339438ms","start":"2026-04-06T21:20:03.945221Z","end":"2026-04-06T21:20:04.045561Z","steps":["trace[395098369] 'process raft request' (duration: 85.58707ms)","trace[395098369] 'compare' (duration: 14.576725ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:20:04.710856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.331517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-04-06T21:20:04.710975Z","caller":"traceutil/trace.go:171","msg":"trace[1657849211] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8668; }","duration":"267.50758ms","start":"2026-04-06T21:20:04.443442Z","end":"2026-04-06T21:20:04.71095Z","steps":["trace[1657849211] 'range keys from in-memory index tree' (duration: 267.098232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:04.711024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.312875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:04.711171Z","caller":"traceutil/trace.go:171","msg":"trace[831186995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8668; }","duration":"213.503858ms","start":"2026-04-06T21:20:04.497644Z","end":"2026-04-06T21:20:04.711148Z","steps":["trace[831186995] 'range keys from in-memory index tree' (duration: 213.238503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:04.71118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.03168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4830"} {"level":"info","ts":"2026-04-06T21:20:04.711251Z","caller":"traceutil/trace.go:171","msg":"trace[1464399496] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8668; }","duration":"314.150953ms","start":"2026-04-06T21:20:04.397081Z","end":"2026-04-06T21:20:04.711232Z","steps":["trace[1464399496] 'range keys from in-memory index tree' (duration: 313.857066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:04.711297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:20:04.397062Z","time spent":"314.226014ms","remote":"127.0.0.1:47936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4854,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-06T21:20:04.71167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.593279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-04-06T21:20:04.711717Z","caller":"traceutil/trace.go:171","msg":"trace[1452420205] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8668; }","duration":"251.664071ms","start":"2026-04-06T21:20:04.460038Z","end":"2026-04-06T21:20:04.711702Z","steps":["trace[1452420205] 'range keys from in-memory index tree' (duration: 250.752092ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:04.895424Z","caller":"traceutil/trace.go:171","msg":"trace[595696358] transaction","detail":"{read_only:false; response_revision:8669; number_of_response:1; }","duration":"203.392587ms","start":"2026-04-06T21:20:04.692009Z","end":"2026-04-06T21:20:04.895401Z","steps":["trace[595696358] 'process raft request' (duration: 203.090351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:04.895617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.049782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:20:04.895329Z","caller":"traceutil/trace.go:171","msg":"trace[962553966] linearizableReadLoop","detail":"{readStateIndex:9058; appliedIndex:9057; }","duration":"182.739917ms","start":"2026-04-06T21:20:04.712554Z","end":"2026-04-06T21:20:04.895293Z","steps":["trace[962553966] 'read index received' (duration: 182.432541ms)","trace[962553966] 'applied index is now lower than readState.Index' (duration: 306.376µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:04.895737Z","caller":"traceutil/trace.go:171","msg":"trace[2054052059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8669; }","duration":"183.231646ms","start":"2026-04-06T21:20:04.712475Z","end":"2026-04-06T21:20:04.895707Z","steps":["trace[2054052059] 'agreement among raft nodes before linearized reading' (duration: 183.037652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:04.896159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.375962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:568"} {"level":"info","ts":"2026-04-06T21:20:04.896209Z","caller":"traceutil/trace.go:171","msg":"trace[497937089] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8669; }","duration":"180.443293ms","start":"2026-04-06T21:20:04.71575Z","end":"2026-04-06T21:20:04.896194Z","steps":["trace[497937089] 'agreement among raft nodes before linearized reading' (duration: 180.274789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:04.896463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.905282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-04-06T21:20:04.896523Z","caller":"traceutil/trace.go:171","msg":"trace[338175398] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8669; }","duration":"181.034584ms","start":"2026-04-06T21:20:04.715471Z","end":"2026-04-06T21:20:04.896505Z","steps":["trace[338175398] 'agreement among raft nodes before linearized reading' (duration: 180.447402ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:05.030727Z","caller":"traceutil/trace.go:171","msg":"trace[603343721] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"128.091934ms","start":"2026-04-06T21:20:04.90259Z","end":"2026-04-06T21:20:05.030682Z","steps":["trace[603343721] 'process raft request' (duration: 127.790337ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:05.711732Z","caller":"traceutil/trace.go:171","msg":"trace[70758197] transaction","detail":"{read_only:false; response_revision:8674; number_of_response:1; }","duration":"106.298231ms","start":"2026-04-06T21:20:05.605399Z","end":"2026-04-06T21:20:05.711697Z","steps":["trace[70758197] 'process raft request' (duration: 106.092257ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:06.477837Z","caller":"traceutil/trace.go:171","msg":"trace[581264907] linearizableReadLoop","detail":"{readStateIndex:9070; appliedIndex:9069; }","duration":"149.263602ms","start":"2026-04-06T21:20:06.328541Z","end":"2026-04-06T21:20:06.477804Z","steps":["trace[581264907] 'read index received' (duration: 142.930823ms)","trace[581264907] 'applied index is now lower than readState.Index' (duration: 6.331239ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:20:06.477921Z","caller":"traceutil/trace.go:171","msg":"trace[1637160720] transaction","detail":"{read_only:false; response_revision:8681; number_of_response:1; }","duration":"150.017548ms","start":"2026-04-06T21:20:06.327857Z","end":"2026-04-06T21:20:06.477875Z","steps":["trace[1637160720] 'process raft request' (duration: 143.560256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:20:06.478482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.869605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:208065"} {"level":"info","ts":"2026-04-06T21:20:06.478572Z","caller":"traceutil/trace.go:171","msg":"trace[1819675032] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8681; }","duration":"150.073678ms","start":"2026-04-06T21:20:06.328486Z","end":"2026-04-06T21:20:06.478559Z","steps":["trace[1819675032] 'agreement among raft nodes before linearized reading' (duration: 149.441376ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:06.666593Z","caller":"traceutil/trace.go:171","msg":"trace[1313709762] transaction","detail":"{read_only:false; response_revision:8682; number_of_response:1; }","duration":"135.395941ms","start":"2026-04-06T21:20:06.531143Z","end":"2026-04-06T21:20:06.666539Z","steps":["trace[1313709762] 'process raft request' (duration: 62.457912ms)","trace[1313709762] 'compare' (duration: 72.570233ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:21:14.123177Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6513} {"level":"info","ts":"2026-04-06T21:21:14.243645Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6513,"took":"117.966651ms","hash":1929940673,"current-db-size-bytes":61046784,"current-db-size":"61 MB","current-db-size-in-use-bytes":26537984,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-06T21:21:14.24373Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1929940673,"revision":6513,"compact-revision":3206} {"level":"info","ts":"2026-04-06T21:21:14.845333Z","caller":"traceutil/trace.go:171","msg":"trace[1722392618] transaction","detail":"{read_only:false; response_revision:9410; number_of_response:1; }","duration":"138.867427ms","start":"2026-04-06T21:21:14.706441Z","end":"2026-04-06T21:21:14.845309Z","steps":["trace[1722392618] 'process raft request' (duration: 138.724074ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:21:14.859321Z","caller":"traceutil/trace.go:171","msg":"trace[1514265506] transaction","detail":"{read_only:false; response_revision:9411; number_of_response:1; }","duration":"152.573066ms","start":"2026-04-06T21:21:14.706731Z","end":"2026-04-06T21:21:14.859304Z","steps":["trace[1514265506] 'process raft request' (duration: 152.407712ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:21:14.859556Z","caller":"traceutil/trace.go:171","msg":"trace[2032648002] transaction","detail":"{read_only:false; response_revision:9412; number_of_response:1; }","duration":"152.052996ms","start":"2026-04-06T21:21:14.70749Z","end":"2026-04-06T21:21:14.859543Z","steps":["trace[2032648002] 'process raft request' (duration: 151.76065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:21:15.048042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.564767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wv9fq\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-06T21:21:15.04814Z","caller":"traceutil/trace.go:171","msg":"trace[1140344990] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wv9fq; range_end:; response_count:1; response_revision:9413; }","duration":"122.728341ms","start":"2026-04-06T21:21:14.92539Z","end":"2026-04-06T21:21:15.048118Z","steps":["trace[1140344990] 'range keys from in-memory index tree' (duration: 122.331954ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:21:15.093257Z","caller":"traceutil/trace.go:171","msg":"trace[1502142543] transaction","detail":"{read_only:false; response_revision:9414; number_of_response:1; }","duration":"118.949619ms","start":"2026-04-06T21:21:14.97427Z","end":"2026-04-06T21:21:15.093219Z","steps":["trace[1502142543] 'process raft request' (duration: 118.595992ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:21:30.941321Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-06T21:21:30.946891Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-06T21:21:30.946999Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-06T21:26:14.132071Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9406} {"level":"info","ts":"2026-04-06T21:26:14.227069Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9406,"took":"92.164744ms","hash":2663732053,"current-db-size-bytes":61046784,"current-db-size":"61 MB","current-db-size-in-use-bytes":25489408,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-06T21:26:14.227186Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2663732053,"revision":9406,"compact-revision":6513}