{"level":"warn","ts":"2026-09-07T10:44:03.103702Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T10:44:03.10393Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.214: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://162.253.55.214:2380","--initial-cluster=instance=https://162.253.55.214:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.214:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.214: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-09-07T10:44:03.104197Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T10:44:03.104226Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.214:2380"]} {"level":"info","ts":"2026-09-07T10:44:03.104315Z","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-09-07T10:44:03.105544Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"]} {"level":"info","ts":"2026-09-07T10:44:03.106237Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.214: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-09-07T10:44:03.112265Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.611336ms"} {"level":"info","ts":"2026-09-07T10:44:03.12282Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"86f12f2ae020828","cluster-id":"dfe59afaaa064e4a"} {"level":"info","ts":"2026-09-07T10:44:03.122904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=()"} {"level":"info","ts":"2026-09-07T10:44:03.12293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 0"} {"level":"info","ts":"2026-09-07T10:44:03.122985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 86f12f2ae020828 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-07T10:44:03.12303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became follower at term 1"} {"level":"info","ts":"2026-09-07T10:44:03.123196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"} {"level":"warn","ts":"2026-09-07T10:44:03.130149Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-07T10:44:03.13188Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-07T10:44:03.133216Z","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-09-07T10:44:03.135313Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"86f12f2ae020828","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-07T10:44:03.135994Z","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-09-07T10:44:03.136746Z","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-09-07T10:44:03.136789Z","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-09-07T10:44:03.135533Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"86f12f2ae020828","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-07T10:44:03.140205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 switched to configuration voters=(607725308229060648)"} {"level":"info","ts":"2026-09-07T10:44:03.140407Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","added-peer-id":"86f12f2ae020828","added-peer-peer-urls":["https://162.253.55.214:2380"]} {"level":"info","ts":"2026-09-07T10:44:03.141747Z","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-09-07T10:44:03.141897Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.214:2380"} {"level":"info","ts":"2026-09-07T10:44:03.141961Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.214:2380"} {"level":"info","ts":"2026-09-07T10:44:03.142715Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-07T10:44:03.142663Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"86f12f2ae020828","initial-advertise-peer-urls":["https://162.253.55.214:2380"],"listen-peer-urls":["https://162.253.55.214:2380"],"advertise-client-urls":["https://162.253.55.214:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.214:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-07T10:44:03.324018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 is starting a new election at term 1"} {"level":"info","ts":"2026-09-07T10:44:03.324106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-07T10:44:03.324136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgPreVoteResp from 86f12f2ae020828 at term 1"} {"level":"info","ts":"2026-09-07T10:44:03.324161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became candidate at term 2"} {"level":"info","ts":"2026-09-07T10:44:03.324174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 received MsgVoteResp from 86f12f2ae020828 at term 2"} {"level":"info","ts":"2026-09-07T10:44:03.324193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"86f12f2ae020828 became leader at term 2"} {"level":"info","ts":"2026-09-07T10:44:03.324215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 86f12f2ae020828 elected leader 86f12f2ae020828 at term 2"} {"level":"info","ts":"2026-09-07T10:44:03.328238Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"86f12f2ae020828","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.214:2379]}","request-path":"/0/members/86f12f2ae020828/attributes","cluster-id":"dfe59afaaa064e4a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-07T10:44:03.32829Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T10:44:03.328277Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T10:44:03.328721Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:44:03.329269Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-07T10:44:03.329305Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-07T10:44:03.32988Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfe59afaaa064e4a","local-member-id":"86f12f2ae020828","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:44:03.330083Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:44:03.330163Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:44:03.334419Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.214:2379"} {"level":"info","ts":"2026-09-07T10:44:03.335744Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-07T10:44:07.01513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.438447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-07T10:44:07.015268Z","caller":"traceutil/trace.go:171","msg":"trace[1171042161] transaction","detail":"{read_only:false; response_revision:136; number_of_response:1; }","duration":"379.239821ms","start":"2026-09-07T10:44:06.63601Z","end":"2026-09-07T10:44:07.01525Z","steps":["trace[1171042161] 'process raft request' (duration: 172.091522ms)","trace[1171042161] 'compare' (duration: 206.24288ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:44:07.015376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:44:06.635992Z","time spent":"379.356725ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":664,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T10:44:07.381093Z","caller":"traceutil/trace.go:171","msg":"trace[1861339759] linearizableReadLoop","detail":"{readStateIndex:141; appliedIndex:140; }","duration":"220.469125ms","start":"2026-09-07T10:44:07.160597Z","end":"2026-09-07T10:44:07.381066Z","steps":["trace[1861339759] 'read index received' (duration: 220.239138ms)","trace[1861339759] 'applied index is now lower than readState.Index' (duration: 228.487µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:44:07.381201Z","caller":"traceutil/trace.go:171","msg":"trace[140419814] transaction","detail":"{read_only:false; response_revision:137; number_of_response:1; }","duration":"358.761889ms","start":"2026-09-07T10:44:07.022394Z","end":"2026-09-07T10:44:07.381156Z","steps":["trace[140419814] 'process raft request' (duration: 358.434718ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:07.381483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.784326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-07T10:44:07.381464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.983544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:07.381556Z","caller":"traceutil/trace.go:171","msg":"trace[1825954104] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:137; }","duration":"221.006033ms","start":"2026-09-07T10:44:07.160525Z","end":"2026-09-07T10:44:07.381531Z","steps":["trace[1825954104] 'agreement among raft nodes before linearized reading' (duration: 220.722833ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:44:07.381573Z","caller":"traceutil/trace.go:171","msg":"trace[1889941246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:137; }","duration":"138.126649ms","start":"2026-09-07T10:44:07.243419Z","end":"2026-09-07T10:44:07.381545Z","steps":["trace[1889941246] 'agreement among raft nodes before linearized reading' (duration: 137.891271ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:07.381745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:44:07.022374Z","time spent":"359.115441ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":679,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T10:44:41.223725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.273746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:41.223818Z","caller":"traceutil/trace.go:171","msg":"trace[1712395013] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:484; }","duration":"131.507241ms","start":"2026-09-07T10:44:41.092294Z","end":"2026-09-07T10:44:41.223801Z","steps":["trace[1712395013] 'range keys from in-memory index tree' (duration: 131.187014ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:41.223749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.473223ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:41.223923Z","caller":"traceutil/trace.go:171","msg":"trace[1884625145] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:484; }","duration":"146.683378ms","start":"2026-09-07T10:44:41.077215Z","end":"2026-09-07T10:44:41.223899Z","steps":["trace[1884625145] 'range keys from in-memory index tree' (duration: 146.444302ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.337378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.060255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:45.337443Z","caller":"traceutil/trace.go:171","msg":"trace[771866780] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:571; }","duration":"160.179209ms","start":"2026-09-07T10:44:45.177245Z","end":"2026-09-07T10:44:45.337424Z","steps":["trace[771866780] 'range keys from in-memory index tree' (duration: 160.000004ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.33762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.583506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:45.337661Z","caller":"traceutil/trace.go:171","msg":"trace[1399907748] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:571; }","duration":"185.637036ms","start":"2026-09-07T10:44:45.152002Z","end":"2026-09-07T10:44:45.337639Z","steps":["trace[1399907748] 'range keys from in-memory index tree' (duration: 185.524614ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.337543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.28413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:45.337736Z","caller":"traceutil/trace.go:171","msg":"trace[569385288] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:571; }","duration":"160.537346ms","start":"2026-09-07T10:44:45.17716Z","end":"2026-09-07T10:44:45.337697Z","steps":["trace[569385288] 'count revisions from in-memory index tree' (duration: 160.046065ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.337917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.988975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:45.337948Z","caller":"traceutil/trace.go:171","msg":"trace[1210407244] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:571; }","duration":"160.042206ms","start":"2026-09-07T10:44:45.177898Z","end":"2026-09-07T10:44:45.33794Z","steps":["trace[1210407244] 'range keys from in-memory index tree' (duration: 159.943223ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.337924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.214883ms","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-09-07T10:44:45.338111Z","caller":"traceutil/trace.go:171","msg":"trace[1874377552] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:571; }","duration":"127.420577ms","start":"2026-09-07T10:44:45.210559Z","end":"2026-09-07T10:44:45.33798Z","steps":["trace[1874377552] 'count revisions from in-memory index tree' (duration: 126.745691ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.338216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.449531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:45.338248Z","caller":"traceutil/trace.go:171","msg":"trace[825829311] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:571; }","duration":"105.498433ms","start":"2026-09-07T10:44:45.232741Z","end":"2026-09-07T10:44:45.33824Z","steps":["trace[825829311] 'range keys from in-memory index tree' (duration: 105.409159ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.338377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.473025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:45.3384Z","caller":"traceutil/trace.go:171","msg":"trace[463986382] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:571; }","duration":"106.496826ms","start":"2026-09-07T10:44:45.231895Z","end":"2026-09-07T10:44:45.338392Z","steps":["trace[463986382] 'range keys from in-memory index tree' (duration: 106.354532ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.338614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.45817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:45.338659Z","caller":"traceutil/trace.go:171","msg":"trace[665094513] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:571; }","duration":"187.518652ms","start":"2026-09-07T10:44:45.151118Z","end":"2026-09-07T10:44:45.338637Z","steps":["trace[665094513] 'count revisions from in-memory index tree' (duration: 187.387998ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.338799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.671583ms","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-09-07T10:44:45.338833Z","caller":"traceutil/trace.go:171","msg":"trace[1127656080] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:571; }","duration":"127.718044ms","start":"2026-09-07T10:44:45.211105Z","end":"2026-09-07T10:44:45.338823Z","steps":["trace[1127656080] 'range keys from in-memory index tree' (duration: 127.580981ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.338896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.288067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:45.338917Z","caller":"traceutil/trace.go:171","msg":"trace[1239993326] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:571; }","duration":"106.966366ms","start":"2026-09-07T10:44:45.231946Z","end":"2026-09-07T10:44:45.338912Z","steps":["trace[1239993326] 'count revisions from in-memory index tree' (duration: 105.244986ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.338948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.16628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:45.338999Z","caller":"traceutil/trace.go:171","msg":"trace[1939745455] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:571; }","duration":"187.86684ms","start":"2026-09-07T10:44:45.151118Z","end":"2026-09-07T10:44:45.338984Z","steps":["trace[1939745455] 'range keys from in-memory index tree' (duration: 186.082838ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:45.33724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.513306ms","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-09-07T10:44:45.339636Z","caller":"traceutil/trace.go:171","msg":"trace[1464406551] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:571; }","duration":"128.80608ms","start":"2026-09-07T10:44:45.210677Z","end":"2026-09-07T10:44:45.339483Z","steps":["trace[1464406551] 'range keys from in-memory index tree' (duration: 126.462534ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:44:48.048297Z","caller":"traceutil/trace.go:171","msg":"trace[1090368418] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"189.531422ms","start":"2026-09-07T10:44:47.858662Z","end":"2026-09-07T10:44:48.048194Z","steps":["trace[1090368418] 'process raft request' (duration: 174.107416ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:44:48.04841Z","caller":"traceutil/trace.go:171","msg":"trace[790480382] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:616; }","duration":"117.683515ms","start":"2026-09-07T10:44:47.930625Z","end":"2026-09-07T10:44:48.048309Z","steps":["trace[790480382] 'read index received' (duration: 101.41406ms)","trace[790480382] 'applied index is now lower than readState.Index' (duration: 16.267264ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:44:48.048623Z","caller":"traceutil/trace.go:171","msg":"trace[537583339] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"184.855653ms","start":"2026-09-07T10:44:47.8637Z","end":"2026-09-07T10:44:48.048556Z","steps":["trace[537583339] 'process raft request' (duration: 184.365421ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:48.048872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.218197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qc6tt\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-07T10:44:48.049082Z","caller":"traceutil/trace.go:171","msg":"trace[1127844232] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qc6tt; range_end:; response_count:1; response_revision:592; }","duration":"118.422922ms","start":"2026-09-07T10:44:47.930544Z","end":"2026-09-07T10:44:48.048967Z","steps":["trace[1127844232] 'agreement among raft nodes before linearized reading' (duration: 117.982672ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:48.618786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.25018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T10:44:48.619082Z","caller":"traceutil/trace.go:171","msg":"trace[2086537396] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"544.39607ms","start":"2026-09-07T10:44:48.074663Z","end":"2026-09-07T10:44:48.619059Z","steps":["trace[2086537396] 'process raft request' (duration: 296.617068ms)","trace[2086537396] 'compare' (duration: 246.772409ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:44:48.619134Z","caller":"traceutil/trace.go:171","msg":"trace[725399700] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:618; }","duration":"251.909217ms","start":"2026-09-07T10:44:48.367206Z","end":"2026-09-07T10:44:48.619115Z","steps":["trace[725399700] 'read index received' (duration: 4.086255ms)","trace[725399700] 'applied index is now lower than readState.Index' (duration: 247.821952ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:44:48.619171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:44:48.074629Z","time spent":"544.500852ms","remote":"127.0.0.1:44112","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-09-07T10:44:48.619209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.014979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:44:48.61927Z","caller":"traceutil/trace.go:171","msg":"trace[1553312785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"252.102652ms","start":"2026-09-07T10:44:48.367155Z","end":"2026-09-07T10:44:48.619258Z","steps":["trace[1553312785] 'agreement among raft nodes before linearized reading' (duration: 252.01168ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:44:48.61936Z","caller":"traceutil/trace.go:171","msg":"trace[1286514991] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"473.968886ms","start":"2026-09-07T10:44:48.14535Z","end":"2026-09-07T10:44:48.619319Z","steps":["trace[1286514991] 'process raft request' (duration: 473.554977ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:44:48.621964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:44:48.145324Z","time spent":"474.116819ms","remote":"127.0.0.1:44416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T10:44:50.226969Z","caller":"traceutil/trace.go:171","msg":"trace[366460138] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"114.787041ms","start":"2026-09-07T10:44:50.112154Z","end":"2026-09-07T10:44:50.226941Z","steps":["trace[366460138] 'process raft request' (duration: 114.590617ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:45:03.55688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.618112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:45:03.556975Z","caller":"traceutil/trace.go:171","msg":"trace[314646190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:753; }","duration":"189.729724ms","start":"2026-09-07T10:45:03.367225Z","end":"2026-09-07T10:45:03.556955Z","steps":["trace[314646190] 'range keys from in-memory index tree' (duration: 189.547291ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:46:08.346786Z","caller":"traceutil/trace.go:171","msg":"trace[82061963] transaction","detail":"{read_only:false; response_revision:1583; number_of_response:1; }","duration":"103.717675ms","start":"2026-09-07T10:46:08.243039Z","end":"2026-09-07T10:46:08.346757Z","steps":["trace[82061963] 'process raft request' (duration: 103.639034ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:46:08.346947Z","caller":"traceutil/trace.go:171","msg":"trace[1465991044] transaction","detail":"{read_only:false; response_revision:1582; number_of_response:1; }","duration":"109.070982ms","start":"2026-09-07T10:46:08.237851Z","end":"2026-09-07T10:46:08.346922Z","steps":["trace[1465991044] 'process raft request' (duration: 108.716267ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:46:24.256679Z","caller":"traceutil/trace.go:171","msg":"trace[1206011583] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"120.716314ms","start":"2026-09-07T10:46:24.13593Z","end":"2026-09-07T10:46:24.256647Z","steps":["trace[1206011583] 'process raft request' (duration: 120.568542ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:46:24.844657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.967659ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T10:46:24.84487Z","caller":"traceutil/trace.go:171","msg":"trace[1833180044] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"121.967863ms","start":"2026-09-07T10:46:24.722885Z","end":"2026-09-07T10:46:24.844853Z","steps":["trace[1833180044] 'process raft request' (duration: 121.883672ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:46:24.844964Z","caller":"traceutil/trace.go:171","msg":"trace[635352892] linearizableReadLoop","detail":"{readStateIndex:1920; appliedIndex:1919; }","duration":"318.293235ms","start":"2026-09-07T10:46:24.526647Z","end":"2026-09-07T10:46:24.84494Z","steps":["trace[635352892] 'read index received' (duration: 205.93865ms)","trace[635352892] 'applied index is now lower than readState.Index' (duration: 112.351684ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:46:24.844988Z","caller":"traceutil/trace.go:171","msg":"trace[1154109634] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"335.275956ms","start":"2026-09-07T10:46:24.50966Z","end":"2026-09-07T10:46:24.844936Z","steps":["trace[1154109634] 'process raft request' (duration: 222.950412ms)","trace[1154109634] 'compare' (duration: 111.749476ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:46:24.845172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:46:24.509634Z","time spent":"335.423758ms","remote":"127.0.0.1:44112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3726,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T10:46:24.845374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.714231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-09-07T10:46:24.845371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.193803ms","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-09-07T10:46:24.845428Z","caller":"traceutil/trace.go:171","msg":"trace[383630761] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1849; }","duration":"318.814372ms","start":"2026-09-07T10:46:24.526597Z","end":"2026-09-07T10:46:24.845411Z","steps":["trace[383630761] 'agreement among raft nodes before linearized reading' (duration: 318.464006ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:46:24.845423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.280782ms","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":"warn","ts":"2026-09-07T10:46:24.845495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:46:24.526583Z","time spent":"318.898864ms","remote":"127.0.0.1:44196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-07T10:46:24.845515Z","caller":"traceutil/trace.go:171","msg":"trace[1542235863] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1849; }","duration":"209.413244ms","start":"2026-09-07T10:46:24.636075Z","end":"2026-09-07T10:46:24.845488Z","steps":["trace[1542235863] 'agreement among raft nodes before linearized reading' (duration: 209.085208ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:46:24.84552Z","caller":"traceutil/trace.go:171","msg":"trace[349878878] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1849; }","duration":"114.300416ms","start":"2026-09-07T10:46:24.731119Z","end":"2026-09-07T10:46:24.845419Z","steps":["trace[349878878] 'agreement among raft nodes before linearized reading' (duration: 114.123493ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:46:37.395945Z","caller":"traceutil/trace.go:171","msg":"trace[1412516209] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"111.72382ms","start":"2026-09-07T10:46:37.284188Z","end":"2026-09-07T10:46:37.395912Z","steps":["trace[1412516209] 'process raft request' (duration: 111.451306ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:46:41.115863Z","caller":"traceutil/trace.go:171","msg":"trace[540600823] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"159.878519ms","start":"2026-09-07T10:46:40.955966Z","end":"2026-09-07T10:46:41.115844Z","steps":["trace[540600823] 'process raft request' (duration: 159.583645ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:46:41.130416Z","caller":"traceutil/trace.go:171","msg":"trace[2031891326] linearizableReadLoop","detail":"{readStateIndex:2060; appliedIndex:2058; }","duration":"159.609685ms","start":"2026-09-07T10:46:40.970788Z","end":"2026-09-07T10:46:41.130398Z","steps":["trace[2031891326] 'read index received' (duration: 144.989726ms)","trace[2031891326] 'applied index is now lower than readState.Index' (duration: 14.619159ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:46:41.130504Z","caller":"traceutil/trace.go:171","msg":"trace[1101208019] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"172.750402ms","start":"2026-09-07T10:46:40.957746Z","end":"2026-09-07T10:46:41.130496Z","steps":["trace[1101208019] 'process raft request' (duration: 172.546849ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:46:41.130609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.467523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T10:46:41.130636Z","caller":"traceutil/trace.go:171","msg":"trace[1113625009] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1985; }","duration":"147.534773ms","start":"2026-09-07T10:46:40.983096Z","end":"2026-09-07T10:46:41.130631Z","steps":["trace[1113625009] 'agreement among raft nodes before linearized reading' (duration: 147.444922ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:46:41.130777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.9952ms","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-09-07T10:46:41.130805Z","caller":"traceutil/trace.go:171","msg":"trace[2071249713] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1985; }","duration":"160.066572ms","start":"2026-09-07T10:46:40.970728Z","end":"2026-09-07T10:46:41.130795Z","steps":["trace[2071249713] 'agreement among raft nodes before linearized reading' (duration: 159.98177ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:47:04.947429Z","caller":"traceutil/trace.go:171","msg":"trace[902238663] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"287.101404ms","start":"2026-09-07T10:47:04.660294Z","end":"2026-09-07T10:47:04.947395Z","steps":["trace[902238663] 'process raft request' (duration: 286.872481ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:47:05.24447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.483475ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T10:47:05.24519Z","caller":"traceutil/trace.go:171","msg":"trace[1288177531] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"211.349267ms","start":"2026-09-07T10:47:05.033771Z","end":"2026-09-07T10:47:05.24512Z","steps":["trace[1288177531] 'process raft request' (duration: 52.05401ms)","trace[1288177531] 'compare' (duration: 158.15091ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:48:33.05505Z","caller":"traceutil/trace.go:171","msg":"trace[1082583193] transaction","detail":"{read_only:false; response_revision:2704; number_of_response:1; }","duration":"113.942101ms","start":"2026-09-07T10:48:32.94108Z","end":"2026-09-07T10:48:33.055022Z","steps":["trace[1082583193] 'process raft request' (duration: 113.788845ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:53:02.870962Z","caller":"traceutil/trace.go:171","msg":"trace[1162876385] linearizableReadLoop","detail":"{readStateIndex:5013; appliedIndex:5012; }","duration":"229.099201ms","start":"2026-09-07T10:53:02.641816Z","end":"2026-09-07T10:53:02.870915Z","steps":["trace[1162876385] 'read index received' (duration: 228.988389ms)","trace[1162876385] 'applied index is now lower than readState.Index' (duration: 109.752µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:53:02.871002Z","caller":"traceutil/trace.go:171","msg":"trace[1225315385] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"269.157438ms","start":"2026-09-07T10:53:02.601816Z","end":"2026-09-07T10:53:02.870973Z","steps":["trace[1225315385] 'process raft request' (duration: 268.949734ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:53:02.87126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.378487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:53:02.871454Z","caller":"traceutil/trace.go:171","msg":"trace[1290840707] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4832; }","duration":"229.622691ms","start":"2026-09-07T10:53:02.641755Z","end":"2026-09-07T10:53:02.871378Z","steps":["trace[1290840707] 'agreement among raft nodes before linearized reading' (duration: 229.308646ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:53:02.904019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.62204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-09-07T10:53:02.904121Z","caller":"traceutil/trace.go:171","msg":"trace[219202731] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4833; }","duration":"248.757753ms","start":"2026-09-07T10:53:02.655339Z","end":"2026-09-07T10:53:02.904097Z","steps":["trace[219202731] 'agreement among raft nodes before linearized reading' (duration: 248.407305ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:53:09.665872Z","caller":"traceutil/trace.go:171","msg":"trace[2014815836] linearizableReadLoop","detail":"{readStateIndex:5129; appliedIndex:5128; }","duration":"188.583744ms","start":"2026-09-07T10:53:09.47724Z","end":"2026-09-07T10:53:09.665824Z","steps":["trace[2014815836] 'read index received' (duration: 17.839676ms)","trace[2014815836] 'applied index is now lower than readState.Index' (duration: 170.743138ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:53:09.666332Z","caller":"traceutil/trace.go:171","msg":"trace[1985275019] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"234.229771ms","start":"2026-09-07T10:53:09.432074Z","end":"2026-09-07T10:53:09.666304Z","steps":["trace[1985275019] 'process raft request' (duration: 158.870944ms)","trace[1985275019] 'compare' (duration: 74.787316ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:53:09.666408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.150294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-253666eb-ec8b-40c3-88b6-100374e1d69d\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-09-07T10:53:09.666515Z","caller":"traceutil/trace.go:171","msg":"trace[688071963] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-253666eb-ec8b-40c3-88b6-100374e1d69d; range_end:; response_count:1; response_revision:4945; }","duration":"189.307817ms","start":"2026-09-07T10:53:09.477196Z","end":"2026-09-07T10:53:09.666504Z","steps":["trace[688071963] 'agreement among raft nodes before linearized reading' (duration: 188.9038ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:53:12.79536Z","caller":"traceutil/trace.go:171","msg":"trace[2009587744] transaction","detail":"{read_only:false; response_revision:4991; number_of_response:1; }","duration":"106.939574ms","start":"2026-09-07T10:53:12.688387Z","end":"2026-09-07T10:53:12.795326Z","steps":["trace[2009587744] 'process raft request' (duration: 106.699119ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:53:23.798997Z","caller":"traceutil/trace.go:171","msg":"trace[1957364948] linearizableReadLoop","detail":"{readStateIndex:5320; appliedIndex:5319; }","duration":"189.616893ms","start":"2026-09-07T10:53:23.609334Z","end":"2026-09-07T10:53:23.798951Z","steps":["trace[1957364948] 'read index received' (duration: 189.295487ms)","trace[1957364948] 'applied index is now lower than readState.Index' (duration: 320.476µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:53:23.799051Z","caller":"traceutil/trace.go:171","msg":"trace[1228020174] transaction","detail":"{read_only:false; response_revision:5130; number_of_response:1; }","duration":"191.964036ms","start":"2026-09-07T10:53:23.607062Z","end":"2026-09-07T10:53:23.799026Z","steps":["trace[1228020174] 'process raft request' (duration: 191.705652ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:53:23.799257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.907918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-07T10:53:23.799314Z","caller":"traceutil/trace.go:171","msg":"trace[758846934] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5130; }","duration":"190.02694ms","start":"2026-09-07T10:53:23.60927Z","end":"2026-09-07T10:53:23.799297Z","steps":["trace[758846934] 'agreement among raft nodes before linearized reading' (duration: 189.818496ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:53:24.029542Z","caller":"traceutil/trace.go:171","msg":"trace[1658859636] linearizableReadLoop","detail":"{readStateIndex:5321; appliedIndex:5320; }","duration":"188.248048ms","start":"2026-09-07T10:53:23.841266Z","end":"2026-09-07T10:53:24.029514Z","steps":["trace[1658859636] 'read index received' (duration: 184.921705ms)","trace[1658859636] 'applied index is now lower than readState.Index' (duration: 3.325103ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:53:24.02959Z","caller":"traceutil/trace.go:171","msg":"trace[1520773143] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"205.369565ms","start":"2026-09-07T10:53:23.824191Z","end":"2026-09-07T10:53:24.02956Z","steps":["trace[1520773143] 'process raft request' (duration: 202.013663ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:53:24.030023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.707936ms","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-09-07T10:53:24.030157Z","caller":"traceutil/trace.go:171","msg":"trace[1328604490] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5131; }","duration":"188.891209ms","start":"2026-09-07T10:53:23.841227Z","end":"2026-09-07T10:53:24.030118Z","steps":["trace[1328604490] 'agreement among raft nodes before linearized reading' (duration: 188.405781ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:54:03.606777Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2865} {"level":"info","ts":"2026-09-07T10:54:03.763297Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2865,"took":"155.560704ms","hash":21380952,"current-db-size-bytes":53465088,"current-db-size":"54 MB","current-db-size-in-use-bytes":28413952,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-07T10:54:03.763367Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":21380952,"revision":2865,"compact-revision":-1} {"level":"info","ts":"2026-09-07T10:54:11.925278Z","caller":"traceutil/trace.go:171","msg":"trace[126033486] transaction","detail":"{read_only:false; response_revision:5511; number_of_response:1; }","duration":"131.64993ms","start":"2026-09-07T10:54:11.793608Z","end":"2026-09-07T10:54:11.925258Z","steps":["trace[126033486] 'process raft request' (duration: 131.521898ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:54:11.957523Z","caller":"traceutil/trace.go:171","msg":"trace[1000996550] transaction","detail":"{read_only:false; response_revision:5512; number_of_response:1; }","duration":"161.353455ms","start":"2026-09-07T10:54:11.796146Z","end":"2026-09-07T10:54:11.9575Z","steps":["trace[1000996550] 'process raft request' (duration: 140.410448ms)","trace[1000996550] 'compare' (duration: 20.865726ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:59:03.613374Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5464} {"level":"info","ts":"2026-09-07T10:59:03.735357Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5464,"took":"120.401283ms","hash":3728962794,"current-db-size-bytes":53465088,"current-db-size":"54 MB","current-db-size-in-use-bytes":18681856,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-07T10:59:03.735434Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3728962794,"revision":5464,"compact-revision":2865}