{"level":"warn","ts":"2026-04-07T01:26:03.200164Z","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-07T01:26:03.200268Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141: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.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141: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-07T01:26:03.200341Z","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-07T01:26:03.200354Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-07T01:26:03.200373Z","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-07T01:26:03.201252Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]} {"level":"info","ts":"2026-04-07T01:26:03.201337Z","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.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141: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-07T01:26:03.205557Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.961403ms"} {"level":"info","ts":"2026-04-07T01:26:03.212105Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"} {"level":"info","ts":"2026-04-07T01:26:03.212217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T01:26:03.212245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"} {"level":"info","ts":"2026-04-07T01:26:03.212258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T01:26:03.212277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"} {"level":"info","ts":"2026-04-07T01:26:03.212324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"warn","ts":"2026-04-07T01:26:03.220626Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T01:26:03.223065Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T01:26:03.224333Z","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-07T01:26:03.226675Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T01:26:03.226864Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T01:26:03.229681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"info","ts":"2026-04-07T01:26:03.229938Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-07T01:26:03.230168Z","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-07T01:26:03.230598Z","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-07T01:26:03.230612Z","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-07T01:26:03.2329Z","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-07T01:26:03.232967Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-07T01:26:03.233032Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-07T01:26:03.233265Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T01:26:03.233374Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T01:26:04.113511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T01:26:04.113582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T01:26:04.113656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"} {"level":"info","ts":"2026-04-07T01:26:04.113683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"} {"level":"info","ts":"2026-04-07T01:26:04.113699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-07T01:26:04.113721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"} {"level":"info","ts":"2026-04-07T01:26:04.113742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-07T01:26:04.115199Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:04.115215Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:26:04.115248Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T01:26:04.11536Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:26:04.11577Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T01:26:04.115937Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T01:26:04.116429Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:04.116617Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:04.116669Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:04.118405Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T01:26:04.118781Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"} {"level":"info","ts":"2026-04-07T01:26:41.84184Z","caller":"traceutil/trace.go:171","msg":"trace[2044568285] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"151.351221ms","start":"2026-04-07T01:26:41.690456Z","end":"2026-04-07T01:26:41.841807Z","steps":["trace[2044568285] 'process raft request' (duration: 150.746824ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:42.019328Z","caller":"traceutil/trace.go:171","msg":"trace[1643340207] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"109.706777ms","start":"2026-04-07T01:26:41.909595Z","end":"2026-04-07T01:26:42.019301Z","steps":["trace[1643340207] 'read index received' (duration: 109.558533ms)","trace[1643340207] 'applied index is now lower than readState.Index' (duration: 147.124µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:42.019423Z","caller":"traceutil/trace.go:171","msg":"trace[1072801471] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"122.846661ms","start":"2026-04-07T01:26:41.896522Z","end":"2026-04-07T01:26:42.019369Z","steps":["trace[1072801471] 'process raft request' (duration: 122.640156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.019795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.135749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5cxqw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-07T01:26:42.020116Z","caller":"traceutil/trace.go:171","msg":"trace[738007838] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5cxqw; range_end:; response_count:1; response_revision:600; }","duration":"110.474691ms","start":"2026-04-07T01:26:41.909543Z","end":"2026-04-07T01:26:42.020017Z","steps":["trace[738007838] 'agreement among raft nodes before linearized reading' (duration: 109.945205ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:42.374278Z","caller":"traceutil/trace.go:171","msg":"trace[2116072081] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"194.94699ms","start":"2026-04-07T01:26:42.179267Z","end":"2026-04-07T01:26:42.374214Z","steps":["trace[2116072081] 'read index received' (duration: 158.433953ms)","trace[2116072081] 'applied index is now lower than readState.Index' (duration: 36.508997ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:42.374221Z","caller":"traceutil/trace.go:171","msg":"trace[135861319] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"337.510232ms","start":"2026-04-07T01:26:42.036686Z","end":"2026-04-07T01:26:42.374196Z","steps":["trace[135861319] 'process raft request' (duration: 301.110627ms)","trace[135861319] 'compare' (duration: 36.114717ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:42.374775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:42.036677Z","time spent":"337.719777ms","remote":"127.0.0.1:34880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:26:42.487212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.91168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.487298Z","caller":"traceutil/trace.go:171","msg":"trace[759673530] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:603; }","duration":"308.052254ms","start":"2026-04-07T01:26:42.179223Z","end":"2026-04-07T01:26:42.487275Z","steps":["trace[759673530] 'agreement among raft nodes before linearized reading' (duration: 195.205257ms)","trace[759673530] 'count revisions from in-memory index tree' (duration: 112.703733ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:42.487346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:42.179201Z","time spent":"308.134337ms","remote":"127.0.0.1:39742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:26:42.487326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.035372ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-04-07T01:26:42.487553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.446071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.487649Z","caller":"traceutil/trace.go:171","msg":"trace[1233032207] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:603; }","duration":"222.566605ms","start":"2026-04-07T01:26:42.265061Z","end":"2026-04-07T01:26:42.487627Z","steps":["trace[1233032207] 'agreement among raft nodes before linearized reading' (duration: 222.3941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.487759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.211222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.487833Z","caller":"traceutil/trace.go:171","msg":"trace[341946351] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:603; }","duration":"236.290895ms","start":"2026-04-07T01:26:42.251514Z","end":"2026-04-07T01:26:42.487805Z","steps":["trace[341946351] 'agreement among raft nodes before linearized reading' (duration: 236.105339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.488619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.214612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.488683Z","caller":"traceutil/trace.go:171","msg":"trace[2095383091] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:603; }","duration":"288.054976ms","start":"2026-04-07T01:26:42.200605Z","end":"2026-04-07T01:26:42.48866Z","steps":["trace[2095383091] 'agreement among raft nodes before linearized reading' (duration: 287.209092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.488758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.861409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.48885Z","caller":"traceutil/trace.go:171","msg":"trace[706494866] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:603; }","duration":"117.982193ms","start":"2026-04-07T01:26:42.370824Z","end":"2026-04-07T01:26:42.488806Z","steps":["trace[706494866] 'agreement among raft nodes before linearized reading' (duration: 117.060437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.489007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.404676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.489275Z","caller":"traceutil/trace.go:171","msg":"trace[1635323080] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:603; }","duration":"237.650094ms","start":"2026-04-07T01:26:42.251468Z","end":"2026-04-07T01:26:42.489118Z","steps":["trace[1635323080] 'agreement among raft nodes before linearized reading' (duration: 237.327065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.489295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.901927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.489389Z","caller":"traceutil/trace.go:171","msg":"trace[1410282565] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:603; }","duration":"310.01898ms","start":"2026-04-07T01:26:42.17933Z","end":"2026-04-07T01:26:42.489349Z","steps":["trace[1410282565] 'agreement among raft nodes before linearized reading' (duration: 309.908227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.489443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:42.179304Z","time spent":"310.125133ms","remote":"127.0.0.1:39742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-07T01:26:42.487883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.573269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.48956Z","caller":"traceutil/trace.go:171","msg":"trace[1584074015] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:603; }","duration":"310.267397ms","start":"2026-04-07T01:26:42.179246Z","end":"2026-04-07T01:26:42.489514Z","steps":["trace[1584074015] 'agreement among raft nodes before linearized reading' (duration: 308.376403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.489294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.538629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.489638Z","caller":"traceutil/trace.go:171","msg":"trace[1204793707] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:603; }","duration":"288.91604ms","start":"2026-04-07T01:26:42.200706Z","end":"2026-04-07T01:26:42.489622Z","steps":["trace[1204793707] 'agreement among raft nodes before linearized reading' (duration: 288.546639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.489651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:26:42.179225Z","time spent":"310.38525ms","remote":"127.0.0.1:39742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T01:26:42.489723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.139378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.487455Z","caller":"traceutil/trace.go:171","msg":"trace[916490623] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"113.058472ms","start":"2026-04-07T01:26:42.374374Z","end":"2026-04-07T01:26:42.487432Z","steps":["trace[916490623] 'read index received' (duration: 49.051µs)","trace[916490623] 'applied index is now lower than readState.Index' (duration: 113.007741ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:42.489783Z","caller":"traceutil/trace.go:171","msg":"trace[1845165590] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:603; }","duration":"161.20852ms","start":"2026-04-07T01:26:42.328543Z","end":"2026-04-07T01:26:42.489751Z","steps":["trace[1845165590] 'agreement among raft nodes before linearized reading' (duration: 161.152279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.49023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.434203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:26:42.490224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.701753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.490276Z","caller":"traceutil/trace.go:171","msg":"trace[1769352405] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:603; }","duration":"119.483115ms","start":"2026-04-07T01:26:42.370777Z","end":"2026-04-07T01:26:42.49026Z","steps":["trace[1769352405] 'agreement among raft nodes before linearized reading' (duration: 119.406492ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:42.490305Z","caller":"traceutil/trace.go:171","msg":"trace[1164002903] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:603; }","duration":"238.829917ms","start":"2026-04-07T01:26:42.251442Z","end":"2026-04-07T01:26:42.490272Z","steps":["trace[1164002903] 'agreement among raft nodes before linearized reading' (duration: 238.699993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.490347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.109086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.490425Z","caller":"traceutil/trace.go:171","msg":"trace[823420087] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:603; }","duration":"225.247481ms","start":"2026-04-07T01:26:42.265159Z","end":"2026-04-07T01:26:42.490406Z","steps":["trace[823420087] 'agreement among raft nodes before linearized reading' (duration: 225.128837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.487563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.576934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:26:42.490628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.001374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.490652Z","caller":"traceutil/trace.go:171","msg":"trace[76199999] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:603; }","duration":"282.701104ms","start":"2026-04-07T01:26:42.207926Z","end":"2026-04-07T01:26:42.490627Z","steps":["trace[76199999] 'agreement among raft nodes before linearized reading' (duration: 279.545193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.490667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.227333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.490736Z","caller":"traceutil/trace.go:171","msg":"trace[1851463753] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:603; }","duration":"224.301715ms","start":"2026-04-07T01:26:42.266402Z","end":"2026-04-07T01:26:42.490703Z","steps":["trace[1851463753] 'agreement among raft nodes before linearized reading' (duration: 224.224433ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:42.490859Z","caller":"traceutil/trace.go:171","msg":"trace[1337671781] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:603; }","duration":"162.076626ms","start":"2026-04-07T01:26:42.32859Z","end":"2026-04-07T01:26:42.490666Z","steps":["trace[1337671781] 'agreement among raft nodes before linearized reading' (duration: 161.717035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.49094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.153225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.491021Z","caller":"traceutil/trace.go:171","msg":"trace[118619175] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:603; }","duration":"120.243087ms","start":"2026-04-07T01:26:42.370744Z","end":"2026-04-07T01:26:42.490987Z","steps":["trace[118619175] 'agreement among raft nodes before linearized reading' (duration: 119.965129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.52479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.330976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:26:42.524836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.160429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.524854Z","caller":"traceutil/trace.go:171","msg":"trace[206860567] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"110.414588ms","start":"2026-04-07T01:26:42.414421Z","end":"2026-04-07T01:26:42.524836Z","steps":["trace[206860567] 'agreement among raft nodes before linearized reading' (duration: 110.323295ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:42.52487Z","caller":"traceutil/trace.go:171","msg":"trace[1308707583] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"111.20909ms","start":"2026-04-07T01:26:42.413649Z","end":"2026-04-07T01:26:42.524859Z","steps":["trace[1308707583] 'agreement among raft nodes before linearized reading' (duration: 111.160399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.524758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.681835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.52512Z","caller":"traceutil/trace.go:171","msg":"trace[2085960580] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"137.089375ms","start":"2026-04-07T01:26:42.388022Z","end":"2026-04-07T01:26:42.525111Z","steps":["trace[2085960580] 'agreement among raft nodes before linearized reading' (duration: 136.664294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.525086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.973582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.525437Z","caller":"traceutil/trace.go:171","msg":"trace[1620041433] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"137.098836ms","start":"2026-04-07T01:26:42.388056Z","end":"2026-04-07T01:26:42.525155Z","steps":["trace[1620041433] 'agreement among raft nodes before linearized reading' (duration: 136.90641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:42.52543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.643143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:42.52568Z","caller":"traceutil/trace.go:171","msg":"trace[78549831] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:604; }","duration":"111.835628ms","start":"2026-04-07T01:26:42.413687Z","end":"2026-04-07T01:26:42.525523Z","steps":["trace[78549831] 'agreement among raft nodes before linearized reading' (duration: 111.503539ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:10.746208Z","caller":"traceutil/trace.go:171","msg":"trace[574534536] linearizableReadLoop","detail":"{readStateIndex:1879; appliedIndex:1878; }","duration":"213.399989ms","start":"2026-04-07T01:28:10.532783Z","end":"2026-04-07T01:28:10.746183Z","steps":["trace[574534536] 'read index received' (duration: 213.201624ms)","trace[574534536] 'applied index is now lower than readState.Index' (duration: 197.155µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:10.746324Z","caller":"traceutil/trace.go:171","msg":"trace[1555472069] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"329.613407ms","start":"2026-04-07T01:28:10.416668Z","end":"2026-04-07T01:28:10.746282Z","steps":["trace[1555472069] 'process raft request' (duration: 329.363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:10.746467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.653441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-07T01:28:10.746468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.676718ms","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-07T01:28:10.746512Z","caller":"traceutil/trace.go:171","msg":"trace[1163406215] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1810; }","duration":"211.736343ms","start":"2026-04-07T01:28:10.534763Z","end":"2026-04-07T01:28:10.7465Z","steps":["trace[1163406215] 'agreement among raft nodes before linearized reading' (duration: 211.584339ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:10.746525Z","caller":"traceutil/trace.go:171","msg":"trace[635211807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1810; }","duration":"213.773721ms","start":"2026-04-07T01:28:10.532737Z","end":"2026-04-07T01:28:10.746511Z","steps":["trace[635211807] 'agreement among raft nodes before linearized reading' (duration: 213.587485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:10.74651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:28:10.41664Z","time spent":"329.771681ms","remote":"127.0.0.1:34880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:28:10.746555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.908868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:28:10.746605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.627978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0f6e8149-8a6d-4f9b-bef1-022eb637a308\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T01:28:10.746667Z","caller":"traceutil/trace.go:171","msg":"trace[1600805327] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1810; }","duration":"198.041802ms","start":"2026-04-07T01:28:10.548592Z","end":"2026-04-07T01:28:10.746634Z","steps":["trace[1600805327] 'agreement among raft nodes before linearized reading' (duration: 197.823556ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:10.746673Z","caller":"traceutil/trace.go:171","msg":"trace[1759858686] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0f6e8149-8a6d-4f9b-bef1-022eb637a308; range_end:; response_count:1; response_revision:1810; }","duration":"171.70146ms","start":"2026-04-07T01:28:10.574952Z","end":"2026-04-07T01:28:10.746653Z","steps":["trace[1759858686] 'agreement among raft nodes before linearized reading' (duration: 171.465423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:11.151465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.356811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-07T01:28:11.151555Z","caller":"traceutil/trace.go:171","msg":"trace[1738548662] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1818; }","duration":"122.493725ms","start":"2026-04-07T01:28:11.029043Z","end":"2026-04-07T01:28:11.151537Z","steps":["trace[1738548662] 'range keys from in-memory index tree' (duration: 121.869517ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:18.948787Z","caller":"traceutil/trace.go:171","msg":"trace[973572144] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"101.034523ms","start":"2026-04-07T01:28:18.847711Z","end":"2026-04-07T01:28:18.948746Z","steps":["trace[973572144] 'process raft request' (duration: 100.827007ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:01.591156Z","caller":"traceutil/trace.go:171","msg":"trace[608316460] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"117.750562ms","start":"2026-04-07T01:29:01.473382Z","end":"2026-04-07T01:29:01.591133Z","steps":["trace[608316460] 'process raft request' (duration: 117.570657ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:01.758624Z","caller":"traceutil/trace.go:171","msg":"trace[1489294371] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"163.556295ms","start":"2026-04-07T01:29:01.595016Z","end":"2026-04-07T01:29:01.758572Z","steps":["trace[1489294371] 'process raft request' (duration: 110.498455ms)","trace[1489294371] 'compare' (duration: 52.900045ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:02.034415Z","caller":"traceutil/trace.go:171","msg":"trace[1330995400] linearizableReadLoop","detail":"{readStateIndex:2220; appliedIndex:2219; }","duration":"229.170043ms","start":"2026-04-07T01:29:01.805225Z","end":"2026-04-07T01:29:02.034395Z","steps":["trace[1330995400] 'read index received' (duration: 228.990738ms)","trace[1330995400] 'applied index is now lower than readState.Index' (duration: 178.415µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:02.034494Z","caller":"traceutil/trace.go:171","msg":"trace[2135327545] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"270.186661ms","start":"2026-04-07T01:29:01.764274Z","end":"2026-04-07T01:29:02.034461Z","steps":["trace[2135327545] 'process raft request' (duration: 269.992415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:02.034561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.325627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:29:02.034602Z","caller":"traceutil/trace.go:171","msg":"trace[2053208684] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:2141; }","duration":"229.38328ms","start":"2026-04-07T01:29:01.805208Z","end":"2026-04-07T01:29:02.034591Z","steps":["trace[2053208684] 'agreement among raft nodes before linearized reading' (duration: 229.304587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:53.696975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.981503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-07T01:29:53.697078Z","caller":"traceutil/trace.go:171","msg":"trace[685013092] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2593; }","duration":"109.136027ms","start":"2026-04-07T01:29:53.587923Z","end":"2026-04-07T01:29:53.697059Z","steps":["trace[685013092] 'range keys from in-memory index tree' (duration: 108.799597ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:30:27.605567Z","caller":"traceutil/trace.go:171","msg":"trace[1525888178] transaction","detail":"{read_only:false; response_revision:2797; number_of_response:1; }","duration":"112.832472ms","start":"2026-04-07T01:30:27.492697Z","end":"2026-04-07T01:30:27.60553Z","steps":["trace[1525888178] 'process raft request' (duration: 112.617676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:30:27.798544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.264338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1447"} {"level":"info","ts":"2026-04-07T01:30:27.798646Z","caller":"traceutil/trace.go:171","msg":"trace[238599393] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2797; }","duration":"189.412943ms","start":"2026-04-07T01:30:27.609212Z","end":"2026-04-07T01:30:27.798625Z","steps":["trace[238599393] 'range keys from in-memory index tree' (duration: 189.095813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:30:27.798872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.253987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:30:27.799145Z","caller":"traceutil/trace.go:171","msg":"trace[1876939713] transaction","detail":"{read_only:false; response_revision:2799; number_of_response:1; }","duration":"186.810439ms","start":"2026-04-07T01:30:27.612313Z","end":"2026-04-07T01:30:27.799123Z","steps":["trace[1876939713] 'process raft request' (duration: 186.696665ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:30:27.799545Z","caller":"traceutil/trace.go:171","msg":"trace[758042608] transaction","detail":"{read_only:false; response_revision:2798; number_of_response:1; }","duration":"188.101335ms","start":"2026-04-07T01:30:27.611425Z","end":"2026-04-07T01:30:27.799527Z","steps":["trace[758042608] 'process raft request' (duration: 44.055365ms)","trace[758042608] 'compare' (duration: 142.787985ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:32:58.290335Z","caller":"traceutil/trace.go:171","msg":"trace[1258124536] transaction","detail":"{read_only:false; response_revision:3792; number_of_response:1; }","duration":"100.26134ms","start":"2026-04-07T01:32:58.190046Z","end":"2026-04-07T01:32:58.290307Z","steps":["trace[1258124536] 'process raft request' (duration: 100.084345ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:34.520339Z","caller":"traceutil/trace.go:171","msg":"trace[397765247] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"100.958387ms","start":"2026-04-07T01:34:34.419354Z","end":"2026-04-07T01:34:34.520313Z","steps":["trace[397765247] 'process raft request' (duration: 100.744031ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:34.558642Z","caller":"traceutil/trace.go:171","msg":"trace[1768225058] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"131.42906ms","start":"2026-04-07T01:34:34.427194Z","end":"2026-04-07T01:34:34.558623Z","steps":["trace[1768225058] 'process raft request' (duration: 131.307447ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:34.7255Z","caller":"traceutil/trace.go:171","msg":"trace[801883293] transaction","detail":"{read_only:false; response_revision:5207; number_of_response:1; }","duration":"155.172592ms","start":"2026-04-07T01:34:34.570297Z","end":"2026-04-07T01:34:34.725469Z","steps":["trace[801883293] 'process raft request' (duration: 74.273772ms)","trace[801883293] 'compare' (duration: 80.443007ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:34:34.725609Z","caller":"traceutil/trace.go:171","msg":"trace[158543132] linearizableReadLoop","detail":"{readStateIndex:5403; appliedIndex:5400; }","duration":"154.510494ms","start":"2026-04-07T01:34:34.571074Z","end":"2026-04-07T01:34:34.725585Z","steps":["trace[158543132] 'read index received' (duration: 36.04166ms)","trace[158543132] 'applied index is now lower than readState.Index' (duration: 118.466784ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:34:34.725829Z","caller":"traceutil/trace.go:171","msg":"trace[1244141999] transaction","detail":"{read_only:false; response_revision:5208; number_of_response:1; }","duration":"154.658048ms","start":"2026-04-07T01:34:34.571163Z","end":"2026-04-07T01:34:34.725821Z","steps":["trace[1244141999] 'process raft request' (duration: 154.138203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:34:34.725884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.797932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:8 size:70960"} {"level":"info","ts":"2026-04-07T01:34:34.725911Z","caller":"traceutil/trace.go:171","msg":"trace[1334256405] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:8; response_revision:5209; }","duration":"154.862934ms","start":"2026-04-07T01:34:34.57104Z","end":"2026-04-07T01:34:34.725903Z","steps":["trace[1334256405] 'agreement among raft nodes before linearized reading' (duration: 154.617567ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:43.400759Z","caller":"traceutil/trace.go:171","msg":"trace[943555694] linearizableReadLoop","detail":"{readStateIndex:5588; appliedIndex:5587; }","duration":"106.951597ms","start":"2026-04-07T01:34:43.293785Z","end":"2026-04-07T01:34:43.400736Z","steps":["trace[943555694] 'read index received' (duration: 41.161145ms)","trace[943555694] 'applied index is now lower than readState.Index' (duration: 65.789262ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:34:43.400877Z","caller":"traceutil/trace.go:171","msg":"trace[1606070712] transaction","detail":"{read_only:false; response_revision:5387; number_of_response:1; }","duration":"146.665121ms","start":"2026-04-07T01:34:43.254168Z","end":"2026-04-07T01:34:43.400833Z","steps":["trace[1606070712] 'process raft request' (duration: 80.787206ms)","trace[1606070712] 'compare' (duration: 65.667229ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:34:43.400944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.144512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:34:43.400984Z","caller":"traceutil/trace.go:171","msg":"trace[445282966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5387; }","duration":"107.241856ms","start":"2026-04-07T01:34:43.29373Z","end":"2026-04-07T01:34:43.400972Z","steps":["trace[445282966] 'agreement among raft nodes before linearized reading' (duration: 107.160384ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:36:04.143743Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2999} {"level":"info","ts":"2026-04-07T01:36:04.239175Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2999,"took":"93.129178ms","hash":1881742753,"current-db-size-bytes":58781696,"current-db-size":"59 MB","current-db-size-in-use-bytes":33976320,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-07T01:36:04.239284Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1881742753,"revision":2999,"compact-revision":-1} {"level":"info","ts":"2026-04-07T01:41:02.483975Z","caller":"traceutil/trace.go:171","msg":"trace[926320808] linearizableReadLoop","detail":"{readStateIndex:8575; appliedIndex:8574; }","duration":"189.608093ms","start":"2026-04-07T01:41:02.294337Z","end":"2026-04-07T01:41:02.483945Z","steps":["trace[926320808] 'read index received' (duration: 189.452928ms)","trace[926320808] 'applied index is now lower than readState.Index' (duration: 152.974µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:02.484139Z","caller":"traceutil/trace.go:171","msg":"trace[1945405466] transaction","detail":"{read_only:false; response_revision:8283; number_of_response:1; }","duration":"244.966558ms","start":"2026-04-07T01:41:02.239152Z","end":"2026-04-07T01:41:02.484118Z","steps":["trace[1945405466] 'process raft request' (duration: 244.589018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:02.484322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.955302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:41:02.484436Z","caller":"traceutil/trace.go:171","msg":"trace[991513179] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8283; }","duration":"190.131627ms","start":"2026-04-07T01:41:02.29428Z","end":"2026-04-07T01:41:02.484411Z","steps":["trace[991513179] 'agreement among raft nodes before linearized reading' (duration: 189.957933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:02.545683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.639973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:41:02.545741Z","caller":"traceutil/trace.go:171","msg":"trace[335317134] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:8284; }","duration":"127.747256ms","start":"2026-04-07T01:41:02.417977Z","end":"2026-04-07T01:41:02.545724Z","steps":["trace[335317134] 'agreement among raft nodes before linearized reading' (duration: 127.643163ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:03.288273Z","caller":"traceutil/trace.go:171","msg":"trace[1572406187] transaction","detail":"{read_only:false; response_revision:8289; number_of_response:1; }","duration":"106.928055ms","start":"2026-04-07T01:41:03.181255Z","end":"2026-04-07T01:41:03.288183Z","steps":["trace[1572406187] 'process raft request' (duration: 74.199841ms)","trace[1572406187] 'compare' (duration: 32.562419ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:04.150067Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6125} {"level":"info","ts":"2026-04-07T01:41:04.279738Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6125,"took":"127.18233ms","hash":3023401065,"current-db-size-bytes":58781696,"current-db-size":"59 MB","current-db-size-in-use-bytes":23179264,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-07T01:41:04.279824Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3023401065,"revision":6125,"compact-revision":2999} {"level":"info","ts":"2026-04-07T01:41:30.849391Z","caller":"traceutil/trace.go:171","msg":"trace[973198800] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"251.443658ms","start":"2026-04-07T01:41:30.597921Z","end":"2026-04-07T01:41:30.849365Z","steps":["trace[973198800] 'process raft request' (duration: 251.282483ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:30.889127Z","caller":"traceutil/trace.go:171","msg":"trace[1372282032] linearizableReadLoop","detail":"{readStateIndex:8792; appliedIndex:8790; }","duration":"180.708843ms","start":"2026-04-07T01:41:30.708392Z","end":"2026-04-07T01:41:30.889101Z","steps":["trace[1372282032] 'read index received' (duration: 140.911202ms)","trace[1372282032] 'applied index is now lower than readState.Index' (duration: 39.796721ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:30.889194Z","caller":"traceutil/trace.go:171","msg":"trace[342646404] transaction","detail":"{read_only:false; response_revision:8491; number_of_response:1; }","duration":"240.059459ms","start":"2026-04-07T01:41:30.649103Z","end":"2026-04-07T01:41:30.889163Z","steps":["trace[342646404] 'process raft request' (duration: 239.856184ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:30.889375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.966911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T01:41:30.889422Z","caller":"traceutil/trace.go:171","msg":"trace[1865009690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8491; }","duration":"181.072334ms","start":"2026-04-07T01:41:30.708339Z","end":"2026-04-07T01:41:30.889411Z","steps":["trace[1865009690] 'agreement among raft nodes before linearized reading' (duration: 180.892958ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:31.067864Z","caller":"traceutil/trace.go:171","msg":"trace[181638887] transaction","detail":"{read_only:false; response_revision:8493; number_of_response:1; }","duration":"119.437733ms","start":"2026-04-07T01:41:30.948397Z","end":"2026-04-07T01:41:31.067835Z","steps":["trace[181638887] 'process raft request' (duration: 118.859937ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:34.16478Z","caller":"traceutil/trace.go:171","msg":"trace[838671026] linearizableReadLoop","detail":"{readStateIndex:8810; appliedIndex:8809; }","duration":"138.180807ms","start":"2026-04-07T01:41:34.026561Z","end":"2026-04-07T01:41:34.164741Z","steps":["trace[838671026] 'read index received' (duration: 112.361467ms)","trace[838671026] 'applied index is now lower than readState.Index' (duration: 25.81816ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:34.164818Z","caller":"traceutil/trace.go:171","msg":"trace[880229972] transaction","detail":"{read_only:false; response_revision:8508; number_of_response:1; }","duration":"170.721315ms","start":"2026-04-07T01:41:33.994057Z","end":"2026-04-07T01:41:34.164778Z","steps":["trace[880229972] 'process raft request' (duration: 144.974207ms)","trace[880229972] 'compare' (duration: 25.543253ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:41:34.165095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.511727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-07T01:41:34.165221Z","caller":"traceutil/trace.go:171","msg":"trace[596753292] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8508; }","duration":"138.685101ms","start":"2026-04-07T01:41:34.026506Z","end":"2026-04-07T01:41:34.165191Z","steps":["trace[596753292] 'agreement among raft nodes before linearized reading' (duration: 138.334822ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:42:29.320346Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002472.wal"} {"level":"info","ts":"2026-04-07T01:43:42.486694Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9ef3b4f68930dc2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T01:43:42.493918Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T01:43:42.494013Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T01:46:04.157268Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8298} {"level":"info","ts":"2026-04-07T01:46:04.240641Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8298,"took":"79.706483ms","hash":2846651635,"current-db-size-bytes":58781696,"current-db-size":"59 MB","current-db-size-in-use-bytes":24875008,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-07T01:46:04.241072Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2846651635,"revision":8298,"compact-revision":6125} {"level":"info","ts":"2026-04-07T01:51:04.165877Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10697} {"level":"info","ts":"2026-04-07T01:51:04.254813Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10697,"took":"86.47287ms","hash":1479755093,"current-db-size-bytes":58781696,"current-db-size":"59 MB","current-db-size-in-use-bytes":20471808,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-07T01:51:04.254897Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1479755093,"revision":10697,"compact-revision":8298}