{"level":"warn","ts":"2026-04-22T16:22:31.26844Z","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-22T16:22:31.268567Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.138: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.19.213.138:2380","--initial-cluster=instance=https://199.19.213.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.138: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-22T16:22:31.268647Z","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-22T16:22:31.268661Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.138:2380"]} {"level":"info","ts":"2026-04-22T16:22:31.268684Z","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-22T16:22:31.269397Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"]} {"level":"info","ts":"2026-04-22T16:22:31.269495Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.138:2380"],"listen-peer-urls":["https://199.19.213.138:2380"],"advertise-client-urls":["https://199.19.213.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.138: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-22T16:22:31.274027Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.307091ms"} {"level":"info","ts":"2026-04-22T16:22:31.282062Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2062be27cfb43adb","cluster-id":"f353072e75ed4d57"} {"level":"info","ts":"2026-04-22T16:22:31.28217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T16:22:31.282204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became follower at term 0"} {"level":"info","ts":"2026-04-22T16:22:31.282224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2062be27cfb43adb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T16:22:31.282234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became follower at term 1"} {"level":"info","ts":"2026-04-22T16:22:31.282286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=(2333636635129035483)"} {"level":"warn","ts":"2026-04-22T16:22:31.287521Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T16:22:31.289407Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T16:22:31.290362Z","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-22T16:22:31.29226Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2062be27cfb43adb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T16:22:31.292626Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2062be27cfb43adb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T16:22:31.292744Z","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-22T16:22:31.292874Z","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-22T16:22:31.292899Z","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-22T16:22:31.294763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=(2333636635129035483)"} {"level":"info","ts":"2026-04-22T16:22:31.294915Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f353072e75ed4d57","local-member-id":"2062be27cfb43adb","added-peer-id":"2062be27cfb43adb","added-peer-peer-urls":["https://199.19.213.138:2380"]} {"level":"info","ts":"2026-04-22T16:22:31.298618Z","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-22T16:22:31.298803Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.138:2380"} {"level":"info","ts":"2026-04-22T16:22:31.298949Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.138:2380"} {"level":"info","ts":"2026-04-22T16:22:31.2993Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2062be27cfb43adb","initial-advertise-peer-urls":["https://199.19.213.138:2380"],"listen-peer-urls":["https://199.19.213.138:2380"],"advertise-client-urls":["https://199.19.213.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T16:22:31.299359Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T16:22:31.682989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T16:22:31.683096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T16:22:31.683171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb received MsgPreVoteResp from 2062be27cfb43adb at term 1"} {"level":"info","ts":"2026-04-22T16:22:31.683218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became candidate at term 2"} {"level":"info","ts":"2026-04-22T16:22:31.683241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb received MsgVoteResp from 2062be27cfb43adb at term 2"} {"level":"info","ts":"2026-04-22T16:22:31.683264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became leader at term 2"} {"level":"info","ts":"2026-04-22T16:22:31.683288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2062be27cfb43adb elected leader 2062be27cfb43adb at term 2"} {"level":"info","ts":"2026-04-22T16:22:31.684632Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T16:22:31.685016Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2062be27cfb43adb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.138:2379]}","request-path":"/0/members/2062be27cfb43adb/attributes","cluster-id":"f353072e75ed4d57","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T16:22:31.685218Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T16:22:31.685347Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f353072e75ed4d57","local-member-id":"2062be27cfb43adb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T16:22:31.685419Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T16:22:31.685443Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T16:22:31.685459Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T16:22:31.685673Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T16:22:31.685689Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T16:22:31.687853Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T16:22:31.689636Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.138:2379"} {"level":"info","ts":"2026-04-22T16:22:47.322101Z","caller":"traceutil/trace.go:171","msg":"trace[1675437209] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"146.410803ms","start":"2026-04-22T16:22:47.175663Z","end":"2026-04-22T16:22:47.322074Z","steps":["trace[1675437209] 'process raft request' (duration: 146.243202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:22:47.808677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.29958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T16:22:47.808849Z","caller":"traceutil/trace.go:171","msg":"trace[109226320] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:377; }","duration":"477.299053ms","start":"2026-04-22T16:22:47.331528Z","end":"2026-04-22T16:22:47.808827Z","steps":["trace[109226320] 'read index received' (duration: 139.168726ms)","trace[109226320] 'applied index is now lower than readState.Index' (duration: 338.128287ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:22:47.808948Z","caller":"traceutil/trace.go:171","msg":"trace[1151700500] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"481.542736ms","start":"2026-04-22T16:22:47.327396Z","end":"2026-04-22T16:22:47.808939Z","steps":["trace[1151700500] 'process raft request' (duration: 143.378899ms)","trace[1151700500] 'compare' (duration: 336.922637ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:22:47.808999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:22:47.327376Z","time spent":"481.594528ms","remote":"127.0.0.1:37566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:22:47.809295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.761437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-04-22T16:22:47.809319Z","caller":"traceutil/trace.go:171","msg":"trace[257153322] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:367; }","duration":"477.809307ms","start":"2026-04-22T16:22:47.331501Z","end":"2026-04-22T16:22:47.80931Z","steps":["trace[257153322] 'agreement among raft nodes before linearized reading' (duration: 477.715036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:22:47.809341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:22:47.33149Z","time spent":"477.845687ms","remote":"127.0.0.1:37770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4079,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-04-22T16:22:47.809501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.209105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T16:22:47.80959Z","caller":"traceutil/trace.go:171","msg":"trace[1130634036] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:367; }","duration":"164.339936ms","start":"2026-04-22T16:22:47.645227Z","end":"2026-04-22T16:22:47.809567Z","steps":["trace[1130634036] 'agreement among raft nodes before linearized reading' (duration: 164.159145ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:22:47.931006Z","caller":"traceutil/trace.go:171","msg":"trace[1569338608] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"117.199302ms","start":"2026-04-22T16:22:47.813772Z","end":"2026-04-22T16:22:47.930972Z","steps":["trace[1569338608] 'process raft request' (duration: 97.103282ms)","trace[1569338608] 'compare' (duration: 19.914388ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:22:47.931428Z","caller":"traceutil/trace.go:171","msg":"trace[957417422] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"107.816696ms","start":"2026-04-22T16:22:47.823592Z","end":"2026-04-22T16:22:47.931409Z","steps":["trace[957417422] 'process raft request' (duration: 107.568764ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:23:03.495442Z","caller":"traceutil/trace.go:171","msg":"trace[1570667584] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"105.255336ms","start":"2026-04-22T16:23:03.39016Z","end":"2026-04-22T16:23:03.495416Z","steps":["trace[1570667584] 'process raft request' (duration: 92.509637ms)","trace[1570667584] 'compare' (duration: 12.421307ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:23:10.247702Z","caller":"traceutil/trace.go:171","msg":"trace[2033648374] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"232.52318ms","start":"2026-04-22T16:23:10.015153Z","end":"2026-04-22T16:23:10.247676Z","steps":["trace[2033648374] 'read index received' (duration: 232.253428ms)","trace[2033648374] 'applied index is now lower than readState.Index' (duration: 268.872µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:23:10.248681Z","caller":"traceutil/trace.go:171","msg":"trace[491671758] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"284.799172ms","start":"2026-04-22T16:23:09.963869Z","end":"2026-04-22T16:23:10.248668Z","steps":["trace[491671758] 'process raft request' (duration: 283.604265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:23:10.24872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.561617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:23:10.248788Z","caller":"traceutil/trace.go:171","msg":"trace[1246169224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"233.659627ms","start":"2026-04-22T16:23:10.015104Z","end":"2026-04-22T16:23:10.248764Z","steps":["trace[1246169224] 'agreement among raft nodes before linearized reading' (duration: 233.573697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:23:10.24887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.73816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:23:10.248946Z","caller":"traceutil/trace.go:171","msg":"trace[2130637484] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:588; }","duration":"129.808031ms","start":"2026-04-22T16:23:10.11909Z","end":"2026-04-22T16:23:10.248898Z","steps":["trace[2130637484] 'agreement among raft nodes before linearized reading' (duration: 129.743831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:23:10.249075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.794365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:23:10.249121Z","caller":"traceutil/trace.go:171","msg":"trace[22832006] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:588; }","duration":"152.877725ms","start":"2026-04-22T16:23:10.096233Z","end":"2026-04-22T16:23:10.249111Z","steps":["trace[22832006] 'agreement among raft nodes before linearized reading' (duration: 152.813565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:23:10.249102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.441345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:23:10.249305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.476892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:23:10.249333Z","caller":"traceutil/trace.go:171","msg":"trace[66696811] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:588; }","duration":"152.518473ms","start":"2026-04-22T16:23:10.096808Z","end":"2026-04-22T16:23:10.249327Z","steps":["trace[66696811] 'agreement among raft nodes before linearized reading' (duration: 152.432462ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:23:10.24931Z","caller":"traceutil/trace.go:171","msg":"trace[47770276] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:588; }","duration":"130.726116ms","start":"2026-04-22T16:23:10.118558Z","end":"2026-04-22T16:23:10.249284Z","steps":["trace[47770276] 'agreement among raft nodes before linearized reading' (duration: 130.127633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:23:10.249531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.873707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:23:10.24956Z","caller":"traceutil/trace.go:171","msg":"trace[1184260429] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:588; }","duration":"130.917608ms","start":"2026-04-22T16:23:10.118633Z","end":"2026-04-22T16:23:10.249551Z","steps":["trace[1184260429] 'agreement among raft nodes before linearized reading' (duration: 130.875438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:23:10.249736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.456709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:23:10.249874Z","caller":"traceutil/trace.go:171","msg":"trace[796139030] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:588; }","duration":"153.60061ms","start":"2026-04-22T16:23:10.096233Z","end":"2026-04-22T16:23:10.249834Z","steps":["trace[796139030] 'agreement among raft nodes before linearized reading' (duration: 153.430869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:23:10.251287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.57341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T16:23:10.25136Z","caller":"traceutil/trace.go:171","msg":"trace[2005278417] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"226.696781ms","start":"2026-04-22T16:23:10.024649Z","end":"2026-04-22T16:23:10.251346Z","steps":["trace[2005278417] 'agreement among raft nodes before linearized reading' (duration: 223.303869ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:23:10.448603Z","caller":"traceutil/trace.go:171","msg":"trace[1739043690] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"194.300313ms","start":"2026-04-22T16:23:10.254277Z","end":"2026-04-22T16:23:10.448577Z","steps":["trace[1739043690] 'process raft request' (duration: 167.467874ms)","trace[1739043690] 'compare' (duration: 26.725909ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:23:10.451483Z","caller":"traceutil/trace.go:171","msg":"trace[1233216565] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:610; }","duration":"151.419585ms","start":"2026-04-22T16:23:10.300047Z","end":"2026-04-22T16:23:10.451467Z","steps":["trace[1233216565] 'read index received' (duration: 121.640316ms)","trace[1233216565] 'applied index is now lower than readState.Index' (duration: 29.778359ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:23:10.451639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.567477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:23:10.451679Z","caller":"traceutil/trace.go:171","msg":"trace[1075958849] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:590; }","duration":"151.643449ms","start":"2026-04-22T16:23:10.300026Z","end":"2026-04-22T16:23:10.451669Z","steps":["trace[1075958849] 'agreement among raft nodes before linearized reading' (duration: 151.527587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:23:10.451875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.820579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:23:10.451906Z","caller":"traceutil/trace.go:171","msg":"trace[1442788805] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:590; }","duration":"151.87501ms","start":"2026-04-22T16:23:10.300022Z","end":"2026-04-22T16:23:10.451897Z","steps":["trace[1442788805] 'agreement among raft nodes before linearized reading' (duration: 151.82718ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:23:10.458427Z","caller":"traceutil/trace.go:171","msg":"trace[273517154] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"193.119236ms","start":"2026-04-22T16:23:10.261565Z","end":"2026-04-22T16:23:10.454684Z","steps":["trace[273517154] 'process raft request' (duration: 189.815153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:23:25.828937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.47279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-22T16:23:25.829027Z","caller":"traceutil/trace.go:171","msg":"trace[953811292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:745; }","duration":"235.620153ms","start":"2026-04-22T16:23:25.593389Z","end":"2026-04-22T16:23:25.829009Z","steps":["trace[953811292] 'range keys from in-memory index tree' (duration: 235.277639ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:23:55.629172Z","caller":"traceutil/trace.go:171","msg":"trace[1511473531] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"152.309033ms","start":"2026-04-22T16:23:55.476832Z","end":"2026-04-22T16:23:55.629141Z","steps":["trace[1511473531] 'process raft request' (duration: 152.177398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:24:42.705817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.203844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-22T16:24:42.70588Z","caller":"traceutil/trace.go:171","msg":"trace[1058565405] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1814; }","duration":"142.317616ms","start":"2026-04-22T16:24:42.563549Z","end":"2026-04-22T16:24:42.705866Z","steps":["trace[1058565405] 'range keys from in-memory index tree' (duration: 142.05001ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:24:42.849384Z","caller":"traceutil/trace.go:171","msg":"trace[1513113583] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"136.586107ms","start":"2026-04-22T16:24:42.712763Z","end":"2026-04-22T16:24:42.849349Z","steps":["trace[1513113583] 'process raft request' (duration: 130.763908ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:25:16.641152Z","caller":"traceutil/trace.go:171","msg":"trace[35843657] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"104.146473ms","start":"2026-04-22T16:25:16.536971Z","end":"2026-04-22T16:25:16.641117Z","steps":["trace[35843657] 'process raft request' (duration: 94.07339ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:25:16.984824Z","caller":"traceutil/trace.go:171","msg":"trace[2139159836] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"105.382254ms","start":"2026-04-22T16:25:16.879412Z","end":"2026-04-22T16:25:16.984794Z","steps":["trace[2139159836] 'process raft request' (duration: 105.052918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:25:17.295937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.857774ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T16:25:17.296032Z","caller":"traceutil/trace.go:171","msg":"trace[1470864954] linearizableReadLoop","detail":"{readStateIndex:2140; appliedIndex:2139; }","duration":"193.346255ms","start":"2026-04-22T16:25:17.102674Z","end":"2026-04-22T16:25:17.29602Z","steps":["trace[1470864954] 'read index received' (duration: 37.241198ms)","trace[1470864954] 'applied index is now lower than readState.Index' (duration: 156.104357ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:25:17.296128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.461938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T16:25:17.296147Z","caller":"traceutil/trace.go:171","msg":"trace[839758701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2061; }","duration":"193.528348ms","start":"2026-04-22T16:25:17.102612Z","end":"2026-04-22T16:25:17.29614Z","steps":["trace[839758701] 'agreement among raft nodes before linearized reading' (duration: 193.440127ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:25:17.296129Z","caller":"traceutil/trace.go:171","msg":"trace[500603262] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"306.475274ms","start":"2026-04-22T16:25:16.989628Z","end":"2026-04-22T16:25:17.296103Z","steps":["trace[500603262] 'process raft request' (duration: 150.387777ms)","trace[500603262] 'compare' (duration: 155.772593ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:25:17.296247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:25:16.98961Z","time spent":"306.573426ms","remote":"127.0.0.1:37566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:25:17.470195Z","caller":"traceutil/trace.go:171","msg":"trace[1474258408] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"168.513246ms","start":"2026-04-22T16:25:17.301654Z","end":"2026-04-22T16:25:17.470167Z","steps":["trace[1474258408] 'process raft request' (duration: 168.09836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:26:21.855118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.56834ms","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-22T16:26:21.855188Z","caller":"traceutil/trace.go:171","msg":"trace[790398734] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2509; }","duration":"180.64766ms","start":"2026-04-22T16:26:21.674528Z","end":"2026-04-22T16:26:21.855176Z","steps":["trace[790398734] 'range keys from in-memory index tree' (duration: 180.467349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:26:21.855512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.494503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T16:26:21.855538Z","caller":"traceutil/trace.go:171","msg":"trace[327183613] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2509; }","duration":"104.549184ms","start":"2026-04-22T16:26:21.750983Z","end":"2026-04-22T16:26:21.855532Z","steps":["trace[327183613] 'range keys from in-memory index tree' (duration: 104.389572ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:26:54.385359Z","caller":"traceutil/trace.go:171","msg":"trace[315218841] linearizableReadLoop","detail":"{readStateIndex:2790; appliedIndex:2789; }","duration":"156.041269ms","start":"2026-04-22T16:26:54.229296Z","end":"2026-04-22T16:26:54.385337Z","steps":["trace[315218841] 'read index received' (duration: 155.880147ms)","trace[315218841] 'applied index is now lower than readState.Index' (duration: 160.212µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:26:54.385394Z","caller":"traceutil/trace.go:171","msg":"trace[1163509057] transaction","detail":"{read_only:false; response_revision:2689; number_of_response:1; }","duration":"161.013906ms","start":"2026-04-22T16:26:54.224357Z","end":"2026-04-22T16:26:54.38537Z","steps":["trace[1163509057] 'process raft request' (duration: 160.872834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:26:54.403515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.187013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:26:54.403681Z","caller":"traceutil/trace.go:171","msg":"trace[748110372] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2689; }","duration":"174.391526ms","start":"2026-04-22T16:26:54.22926Z","end":"2026-04-22T16:26:54.403652Z","steps":["trace[748110372] 'agreement among raft nodes before linearized reading' (duration: 156.173641ms)","trace[748110372] 'range keys from in-memory index tree' (duration: 18.010373ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:30:46.103503Z","caller":"traceutil/trace.go:171","msg":"trace[1854942875] linearizableReadLoop","detail":"{readStateIndex:4864; appliedIndex:4863; }","duration":"215.67989ms","start":"2026-04-22T16:30:45.887799Z","end":"2026-04-22T16:30:46.103479Z","steps":["trace[1854942875] 'read index received' (duration: 215.582598ms)","trace[1854942875] 'applied index is now lower than readState.Index' (duration: 96.382µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:30:46.103548Z","caller":"traceutil/trace.go:171","msg":"trace[661291151] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"241.730447ms","start":"2026-04-22T16:30:45.861783Z","end":"2026-04-22T16:30:46.103513Z","steps":["trace[661291151] 'process raft request' (duration: 241.525044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:30:46.103647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.832642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:30:46.103683Z","caller":"traceutil/trace.go:171","msg":"trace[533516820] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4690; }","duration":"215.906103ms","start":"2026-04-22T16:30:45.887766Z","end":"2026-04-22T16:30:46.103672Z","steps":["trace[533516820] 'agreement among raft nodes before linearized reading' (duration: 215.839972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:30:46.104054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.992847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-22T16:30:46.104155Z","caller":"traceutil/trace.go:171","msg":"trace[526617332] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4690; }","duration":"155.145149ms","start":"2026-04-22T16:30:45.948984Z","end":"2026-04-22T16:30:46.104129Z","steps":["trace[526617332] 'agreement among raft nodes before linearized reading' (duration: 154.822994ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:30:46.415893Z","caller":"traceutil/trace.go:171","msg":"trace[612466684] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"113.021947ms","start":"2026-04-22T16:30:46.302719Z","end":"2026-04-22T16:30:46.415741Z","steps":["trace[612466684] 'process raft request' (duration: 112.406086ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:30:58.344967Z","caller":"traceutil/trace.go:171","msg":"trace[1179322773] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"202.75449ms","start":"2026-04-22T16:30:58.142173Z","end":"2026-04-22T16:30:58.344927Z","steps":["trace[1179322773] 'process raft request' (duration: 201.593228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:30:58.666312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.70821ms","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-04-22T16:30:58.666391Z","caller":"traceutil/trace.go:171","msg":"trace[1781551592] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4866; }","duration":"101.826852ms","start":"2026-04-22T16:30:58.564548Z","end":"2026-04-22T16:30:58.666375Z","steps":["trace[1781551592] 'range keys from in-memory index tree' (duration: 101.334354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:30:58.666425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.506877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-22T16:30:58.666881Z","caller":"traceutil/trace.go:171","msg":"trace[1247865869] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4866; }","duration":"101.850354ms","start":"2026-04-22T16:30:58.564864Z","end":"2026-04-22T16:30:58.666714Z","steps":["trace[1247865869] 'range keys from in-memory index tree' (duration: 101.352244ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:30:58.677418Z","caller":"traceutil/trace.go:171","msg":"trace[839103974] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"107.055966ms","start":"2026-04-22T16:30:58.570341Z","end":"2026-04-22T16:30:58.677397Z","steps":["trace[839103974] 'process raft request' (duration: 106.827532ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:36.65897Z","caller":"traceutil/trace.go:171","msg":"trace[616110751] linearizableReadLoop","detail":"{readStateIndex:5401; appliedIndex:5400; }","duration":"116.075608ms","start":"2026-04-22T16:31:36.54286Z","end":"2026-04-22T16:31:36.658936Z","steps":["trace[616110751] 'read index received' (duration: 113.18272ms)","trace[616110751] 'applied index is now lower than readState.Index' (duration: 2.891388ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:31:36.659379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.493755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T16:31:36.65947Z","caller":"traceutil/trace.go:171","msg":"trace[329598982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5211; }","duration":"116.617716ms","start":"2026-04-22T16:31:36.542833Z","end":"2026-04-22T16:31:36.65945Z","steps":["trace[329598982] 'agreement among raft nodes before linearized reading' (duration: 116.401323ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:36.659467Z","caller":"traceutil/trace.go:171","msg":"trace[598340111] transaction","detail":"{read_only:false; response_revision:5211; number_of_response:1; }","duration":"124.936554ms","start":"2026-04-22T16:31:36.534513Z","end":"2026-04-22T16:31:36.659449Z","steps":["trace[598340111] 'process raft request' (duration: 121.6122ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:31.745603Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2888} {"level":"info","ts":"2026-04-22T16:32:31.846738Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2888,"took":"99.695039ms","hash":284136942,"current-db-size-bytes":54263808,"current-db-size":"54 MB","current-db-size-in-use-bytes":29507584,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-22T16:32:31.846812Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":284136942,"revision":2888,"compact-revision":-1} {"level":"info","ts":"2026-04-22T16:34:43.791828Z","caller":"traceutil/trace.go:171","msg":"trace[552383426] transaction","detail":"{read_only:false; response_revision:6551; number_of_response:1; }","duration":"101.594981ms","start":"2026-04-22T16:34:43.690208Z","end":"2026-04-22T16:34:43.791803Z","steps":["trace[552383426] 'process raft request' (duration: 101.440369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:35:28.884678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.927586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T16:35:28.884747Z","caller":"traceutil/trace.go:171","msg":"trace[1030305710] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:6790; }","duration":"142.041427ms","start":"2026-04-22T16:35:28.74269Z","end":"2026-04-22T16:35:28.884731Z","steps":["trace[1030305710] 'count revisions from in-memory index tree' (duration: 141.792684ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:35:48.06681Z","caller":"traceutil/trace.go:171","msg":"trace[292677240] linearizableReadLoop","detail":"{readStateIndex:7152; appliedIndex:7151; }","duration":"492.759737ms","start":"2026-04-22T16:35:47.574027Z","end":"2026-04-22T16:35:48.066787Z","steps":["trace[292677240] 'read index received' (duration: 492.548214ms)","trace[292677240] 'applied index is now lower than readState.Index' (duration: 210.343µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:35:48.067014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.95852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:35:48.066961Z","caller":"traceutil/trace.go:171","msg":"trace[1248178208] transaction","detail":"{read_only:false; response_revision:6903; number_of_response:1; }","duration":"572.747576ms","start":"2026-04-22T16:35:47.494162Z","end":"2026-04-22T16:35:48.06691Z","steps":["trace[1248178208] 'process raft request' (duration: 572.485522ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:35:48.067048Z","caller":"traceutil/trace.go:171","msg":"trace[273350306] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:6903; }","duration":"493.064931ms","start":"2026-04-22T16:35:47.573972Z","end":"2026-04-22T16:35:48.067037Z","steps":["trace[273350306] 'agreement among raft nodes before linearized reading' (duration: 492.94211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:35:48.06708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:35:47.573951Z","time spent":"493.120772ms","remote":"127.0.0.1:47366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-22T16:35:48.067492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:35:47.494138Z","time spent":"572.943028ms","remote":"127.0.0.1:37566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:35:48.067707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.359057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:35:48.067788Z","caller":"traceutil/trace.go:171","msg":"trace[1148208406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6903; }","duration":"177.479549ms","start":"2026-04-22T16:35:47.890292Z","end":"2026-04-22T16:35:48.067771Z","steps":["trace[1148208406] 'agreement among raft nodes before linearized reading' (duration: 176.749939ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:37:16.749816Z","caller":"traceutil/trace.go:171","msg":"trace[1178930133] transaction","detail":"{read_only:false; response_revision:7352; number_of_response:1; }","duration":"157.99692ms","start":"2026-04-22T16:37:16.591788Z","end":"2026-04-22T16:37:16.749785Z","steps":["trace[1178930133] 'process raft request' (duration: 95.112838ms)","trace[1178930133] 'compare' (duration: 62.42818ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:37:16.749862Z","caller":"traceutil/trace.go:171","msg":"trace[1681420289] linearizableReadLoop","detail":"{readStateIndex:7619; appliedIndex:7618; }","duration":"100.472585ms","start":"2026-04-22T16:37:16.649353Z","end":"2026-04-22T16:37:16.749826Z","steps":["trace[1681420289] 'read index received' (duration: 37.566042ms)","trace[1681420289] 'applied index is now lower than readState.Index' (duration: 62.905083ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:37:16.750228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.842564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:37:16.750279Z","caller":"traceutil/trace.go:171","msg":"trace[26130326] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:7353; }","duration":"100.943137ms","start":"2026-04-22T16:37:16.649322Z","end":"2026-04-22T16:37:16.750265Z","steps":["trace[26130326] 'agreement among raft nodes before linearized reading' (duration: 100.842614ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:37:31.750235Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5630} {"level":"info","ts":"2026-04-22T16:37:31.819467Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5630,"took":"68.00104ms","hash":192009936,"current-db-size-bytes":54263808,"current-db-size":"54 MB","current-db-size-in-use-bytes":18198528,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-22T16:37:31.81951Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":192009936,"revision":5630,"compact-revision":2888}