{"level":"warn","ts":"2026-06-02T23:45:23.838016Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T23:45:23.838129Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35: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-06-02T23:45:23.838211Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T23:45:23.838223Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-06-02T23:45:23.838245Z","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-06-02T23:45:23.839085Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]} {"level":"info","ts":"2026-06-02T23:45:23.839174Z","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.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35: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-06-02T23:45:23.843621Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.097615ms"} {"level":"info","ts":"2026-06-02T23:45:23.849291Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"} {"level":"info","ts":"2026-06-02T23:45:23.849359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"} {"level":"info","ts":"2026-06-02T23:45:23.849385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"} {"level":"info","ts":"2026-06-02T23:45:23.849399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-02T23:45:23.849412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"} {"level":"info","ts":"2026-06-02T23:45:23.849448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"warn","ts":"2026-06-02T23:45:23.858816Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-02T23:45:23.861123Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-02T23:45:23.862714Z","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-06-02T23:45:23.865121Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-02T23:45:23.869269Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-02T23:45:23.869475Z","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-06-02T23:45:23.8696Z","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-06-02T23:45:23.869625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"info","ts":"2026-06-02T23:45:23.86963Z","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-06-02T23:45:23.869735Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-06-02T23:45:23.871853Z","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-06-02T23:45:23.872033Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-06-02T23:45:23.872075Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-02T23:45:23.872124Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-02T23:45:23.872094Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-06-02T23:45:24.449622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"} {"level":"info","ts":"2026-06-02T23:45:24.449683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"} {"level":"info","ts":"2026-06-02T23:45:24.449925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"} {"level":"info","ts":"2026-06-02T23:45:24.449958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"} {"level":"info","ts":"2026-06-02T23:45:24.449977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"} {"level":"info","ts":"2026-06-02T23:45:24.450085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"} {"level":"info","ts":"2026-06-02T23:45:24.45018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"} {"level":"info","ts":"2026-06-02T23:45:24.557927Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T23:45:24.679105Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"} {"level":"info","ts":"2026-06-02T23:45:24.679157Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T23:45:24.679222Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T23:45:24.679604Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-02T23:45:24.679678Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-02T23:45:24.682609Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-02T23:45:24.683853Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"} {"level":"info","ts":"2026-06-02T23:45:24.818293Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T23:45:24.818632Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T23:45:24.819067Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-06-02T23:45:24.983224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.767306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-02T23:45:24.983311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.465885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T23:45:24.983325Z","caller":"traceutil/trace.go:171","msg":"trace[1317661250] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"119.904968ms","start":"2026-06-02T23:45:24.863404Z","end":"2026-06-02T23:45:24.983309Z","steps":["trace[1317661250] 'range keys from in-memory index tree' (duration: 119.667475ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:45:24.98336Z","caller":"traceutil/trace.go:171","msg":"trace[641260418] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"105.517636ms","start":"2026-06-02T23:45:24.877819Z","end":"2026-06-02T23:45:24.983336Z","steps":["trace[641260418] 'range keys from in-memory index tree' (duration: 105.434164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:45:24.983252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.403694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T23:45:24.983525Z","caller":"traceutil/trace.go:171","msg":"trace[1626152097] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"105.720589ms","start":"2026-06-02T23:45:24.877793Z","end":"2026-06-02T23:45:24.983513Z","steps":["trace[1626152097] 'count revisions from in-memory index tree' (duration: 105.320942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:45:24.983598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.421877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T23:45:24.983684Z","caller":"traceutil/trace.go:171","msg":"trace[765137568] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"120.545478ms","start":"2026-06-02T23:45:24.863115Z","end":"2026-06-02T23:45:24.98366Z","steps":["trace[765137568] 'count revisions from in-memory index tree' (duration: 120.304526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:45:24.983795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.869134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T23:45:24.983819Z","caller":"traceutil/trace.go:171","msg":"trace[493106131] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"129.903245ms","start":"2026-06-02T23:45:24.85391Z","end":"2026-06-02T23:45:24.983814Z","steps":["trace[493106131] 'count revisions from in-memory index tree' (duration: 129.847183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:45:24.983843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.961945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-02T23:45:24.983886Z","caller":"traceutil/trace.go:171","msg":"trace[1274595466] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"130.020557ms","start":"2026-06-02T23:45:24.853856Z","end":"2026-06-02T23:45:24.983877Z","steps":["trace[1274595466] 'range keys from in-memory index tree' (duration: 129.874224ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:00.140269Z","caller":"traceutil/trace.go:171","msg":"trace[1445381846] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"125.391743ms","start":"2026-06-02T23:46:00.014847Z","end":"2026-06-02T23:46:00.140238Z","steps":["trace[1445381846] 'process raft request' (duration: 125.193787ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:00.140337Z","caller":"traceutil/trace.go:171","msg":"trace[99342639] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"116.951777ms","start":"2026-06-02T23:46:00.023332Z","end":"2026-06-02T23:46:00.140284Z","steps":["trace[99342639] 'process raft request' (duration: 116.779652ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:00.140511Z","caller":"traceutil/trace.go:171","msg":"trace[474752764] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"121.796326ms","start":"2026-06-02T23:46:00.018703Z","end":"2026-06-02T23:46:00.140499Z","steps":["trace[474752764] 'process raft request' (duration: 121.373965ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:00.140528Z","caller":"traceutil/trace.go:171","msg":"trace[107137753] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"117.083401ms","start":"2026-06-02T23:46:00.023419Z","end":"2026-06-02T23:46:00.140503Z","steps":["trace[107137753] 'process raft request' (duration: 116.764942ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:00.140523Z","caller":"traceutil/trace.go:171","msg":"trace[729618187] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"129.43212ms","start":"2026-06-02T23:46:00.011031Z","end":"2026-06-02T23:46:00.140463Z","steps":["trace[729618187] 'process raft request' (duration: 128.868536ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:00.140604Z","caller":"traceutil/trace.go:171","msg":"trace[754067268] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"115.761146ms","start":"2026-06-02T23:46:00.024826Z","end":"2026-06-02T23:46:00.140588Z","steps":["trace[754067268] 'process raft request' (duration: 115.398916ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:00.140521Z","caller":"traceutil/trace.go:171","msg":"trace[1809432992] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"116.938836ms","start":"2026-06-02T23:46:00.023403Z","end":"2026-06-02T23:46:00.140342Z","steps":["trace[1809432992] 'process raft request' (duration: 116.743571ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:00.140629Z","caller":"traceutil/trace.go:171","msg":"trace[1182551130] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"112.044838ms","start":"2026-06-02T23:46:00.028575Z","end":"2026-06-02T23:46:00.140619Z","steps":["trace[1182551130] 'process raft request' (duration: 111.698679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:02.65848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.807987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:46:02.658586Z","caller":"traceutil/trace.go:171","msg":"trace[1351857615] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:565; }","duration":"172.962451ms","start":"2026-06-02T23:46:02.485601Z","end":"2026-06-02T23:46:02.658564Z","steps":["trace[1351857615] 'count revisions from in-memory index tree' (duration: 172.689614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:02.658693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.106724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:46:02.658768Z","caller":"traceutil/trace.go:171","msg":"trace[251984446] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:565; }","duration":"100.196206ms","start":"2026-06-02T23:46:02.558551Z","end":"2026-06-02T23:46:02.658748Z","steps":["trace[251984446] 'range keys from in-memory index tree' (duration: 100.042392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:02.658839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.557067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:46:02.658871Z","caller":"traceutil/trace.go:171","msg":"trace[610268570] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:565; }","duration":"173.624419ms","start":"2026-06-02T23:46:02.485237Z","end":"2026-06-02T23:46:02.658861Z","steps":["trace[610268570] 'range keys from in-memory index tree' (duration: 173.421294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:02.658927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.238858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:46:02.658919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.136234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:46:02.658967Z","caller":"traceutil/trace.go:171","msg":"trace[1747226458] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:565; }","duration":"173.290199ms","start":"2026-06-02T23:46:02.485665Z","end":"2026-06-02T23:46:02.658955Z","steps":["trace[1747226458] 'range keys from in-memory index tree' (duration: 173.212697ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:02.659002Z","caller":"traceutil/trace.go:171","msg":"trace[435674955] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:565; }","duration":"100.254747ms","start":"2026-06-02T23:46:02.558726Z","end":"2026-06-02T23:46:02.658981Z","steps":["trace[435674955] 'range keys from in-memory index tree' (duration: 100.052032ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:06.467675Z","caller":"traceutil/trace.go:171","msg":"trace[2003193941] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:608; }","duration":"141.800338ms","start":"2026-06-02T23:46:06.325836Z","end":"2026-06-02T23:46:06.467637Z","steps":["trace[2003193941] 'read index received' (duration: 58.250784ms)","trace[2003193941] 'applied index is now lower than readState.Index' (duration: 83.545634ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:46:06.467792Z","caller":"traceutil/trace.go:171","msg":"trace[290458850] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"152.547273ms","start":"2026-06-02T23:46:06.315196Z","end":"2026-06-02T23:46:06.467743Z","steps":["trace[290458850] 'process raft request' (duration: 151.221859ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:06.467969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.105337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-02T23:46:06.468018Z","caller":"traceutil/trace.go:171","msg":"trace[367959574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:589; }","duration":"142.202439ms","start":"2026-06-02T23:46:06.3258Z","end":"2026-06-02T23:46:06.468002Z","steps":["trace[367959574] 'agreement among raft nodes before linearized reading' (duration: 142.015464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:06.468304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.646294ms","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-06-02T23:46:06.468402Z","caller":"traceutil/trace.go:171","msg":"trace[577088568] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"127.791278ms","start":"2026-06-02T23:46:06.34059Z","end":"2026-06-02T23:46:06.468382Z","steps":["trace[577088568] 'agreement among raft nodes before linearized reading' (duration: 127.367657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:06.468582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.444375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-b9gwc\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-02T23:46:06.468703Z","caller":"traceutil/trace.go:171","msg":"trace[842411279] range","detail":"{range_begin:/registry/pods/kube-system/cilium-b9gwc; range_end:; response_count:1; response_revision:589; }","duration":"121.628731ms","start":"2026-06-02T23:46:06.347047Z","end":"2026-06-02T23:46:06.468676Z","steps":["trace[842411279] 'agreement among raft nodes before linearized reading' (duration: 120.981524ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:06.937867Z","caller":"traceutil/trace.go:171","msg":"trace[166978512] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"413.340005ms","start":"2026-06-02T23:46:06.524491Z","end":"2026-06-02T23:46:06.937831Z","steps":["trace[166978512] 'process raft request' (duration: 413.161861ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:06.939496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:06.52446Z","time spent":"413.507029ms","remote":"127.0.0.1:47970","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-06-02T23:46:06.964826Z","caller":"traceutil/trace.go:171","msg":"trace[1479368703] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"207.853142ms","start":"2026-06-02T23:46:06.756915Z","end":"2026-06-02T23:46:06.964768Z","steps":["trace[1479368703] 'process raft request' (duration: 207.559455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:35.29767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.475986ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T23:47:35.29784Z","caller":"traceutil/trace.go:171","msg":"trace[556137636] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"190.079684ms","start":"2026-06-02T23:47:35.107736Z","end":"2026-06-02T23:47:35.297816Z","steps":["trace[556137636] 'process raft request' (duration: 17.057597ms)","trace[556137636] 'compare' (duration: 172.263462ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:47:35.445194Z","caller":"traceutil/trace.go:171","msg":"trace[1852904141] linearizableReadLoop","detail":"{readStateIndex:1877; appliedIndex:1876; }","duration":"218.231271ms","start":"2026-06-02T23:47:35.226923Z","end":"2026-06-02T23:47:35.445154Z","steps":["trace[1852904141] 'read index received' (duration: 212.655351ms)","trace[1852904141] 'applied index is now lower than readState.Index' (duration: 5.57434ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:47:35.445349Z","caller":"traceutil/trace.go:171","msg":"trace[396439990] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"313.803743ms","start":"2026-06-02T23:47:35.131507Z","end":"2026-06-02T23:47:35.445311Z","steps":["trace[396439990] 'process raft request' (duration: 308.009259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:35.4455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.264724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:47:35.445543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:35.131487Z","time spent":"313.943095ms","remote":"127.0.0.1:47716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:47:35.445571Z","caller":"traceutil/trace.go:171","msg":"trace[1542273522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1807; }","duration":"156.429598ms","start":"2026-06-02T23:47:35.289125Z","end":"2026-06-02T23:47:35.445554Z","steps":["trace[1542273522] 'agreement among raft nodes before linearized reading' (duration: 156.282076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:35.445651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.72568ms","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-06-02T23:47:35.445763Z","caller":"traceutil/trace.go:171","msg":"trace[591053374] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1807; }","duration":"218.885403ms","start":"2026-06-02T23:47:35.226856Z","end":"2026-06-02T23:47:35.445741Z","steps":["trace[591053374] 'agreement among raft nodes before linearized reading' (duration: 218.497596ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:35.906636Z","caller":"traceutil/trace.go:171","msg":"trace[1340545480] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"118.555415ms","start":"2026-06-02T23:47:35.788034Z","end":"2026-06-02T23:47:35.906589Z","steps":["trace[1340545480] 'process raft request' (duration: 118.362071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:05.780722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.084091ms","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-06-02T23:48:05.780858Z","caller":"traceutil/trace.go:171","msg":"trace[668251359] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2031; }","duration":"106.300825ms","start":"2026-06-02T23:48:05.674531Z","end":"2026-06-02T23:48:05.780832Z","steps":["trace[668251359] 'range keys from in-memory index tree' (duration: 105.828857ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:05.789257Z","caller":"traceutil/trace.go:171","msg":"trace[1878147006] transaction","detail":"{read_only:false; response_revision:2032; number_of_response:1; }","duration":"109.949767ms","start":"2026-06-02T23:48:05.679273Z","end":"2026-06-02T23:48:05.789223Z","steps":["trace[1878147006] 'process raft request' (duration: 109.785934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:11.394795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.648259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-02T23:48:11.395076Z","caller":"traceutil/trace.go:171","msg":"trace[1988460484] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2060; }","duration":"102.994024ms","start":"2026-06-02T23:48:11.292058Z","end":"2026-06-02T23:48:11.395052Z","steps":["trace[1988460484] 'range keys from in-memory index tree' (duration: 102.414155ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:11.784192Z","caller":"traceutil/trace.go:171","msg":"trace[1449865747] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"312.90927ms","start":"2026-06-02T23:48:11.47125Z","end":"2026-06-02T23:48:11.784159Z","steps":["trace[1449865747] 'process raft request' (duration: 312.732917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:11.784664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:48:11.471224Z","time spent":"313.166254ms","remote":"127.0.0.1:47716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:48:11.966327Z","caller":"traceutil/trace.go:171","msg":"trace[1384733931] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"394.880657ms","start":"2026-06-02T23:48:11.571385Z","end":"2026-06-02T23:48:11.966265Z","steps":["trace[1384733931] 'process raft request' (duration: 304.185841ms)","trace[1384733931] 'compare' (duration: 90.522073ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:48:11.966426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.712617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:48:11.966511Z","caller":"traceutil/trace.go:171","msg":"trace[1546050957] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2065; }","duration":"197.89599ms","start":"2026-06-02T23:48:11.768601Z","end":"2026-06-02T23:48:11.966497Z","steps":["trace[1546050957] 'agreement among raft nodes before linearized reading' (duration: 197.734338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:11.966553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:48:11.571356Z","time spent":"395.091371ms","remote":"127.0.0.1:47716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:48:11.966274Z","caller":"traceutil/trace.go:171","msg":"trace[1457075198] linearizableReadLoop","detail":"{readStateIndex:2142; appliedIndex:2140; }","duration":"197.505804ms","start":"2026-06-02T23:48:11.768711Z","end":"2026-06-02T23:48:11.966217Z","steps":["trace[1457075198] 'read index received' (duration: 15.339229ms)","trace[1457075198] 'applied index is now lower than readState.Index' (duration: 182.165175ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:48:11.967284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.169446ms","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-06-02T23:48:11.96732Z","caller":"traceutil/trace.go:171","msg":"trace[1662581550] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2065; }","duration":"139.226287ms","start":"2026-06-02T23:48:11.82808Z","end":"2026-06-02T23:48:11.967306Z","steps":["trace[1662581550] 'agreement among raft nodes before linearized reading' (duration: 139.075674ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:47.464227Z","caller":"traceutil/trace.go:171","msg":"trace[1140584700] linearizableReadLoop","detail":"{readStateIndex:2783; appliedIndex:2782; }","duration":"102.848889ms","start":"2026-06-02T23:49:47.361339Z","end":"2026-06-02T23:49:47.464188Z","steps":["trace[1140584700] 'read index received' (duration: 100.888327ms)","trace[1140584700] 'applied index is now lower than readState.Index' (duration: 1.958982ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:49:47.464602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.239455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-02T23:49:47.465184Z","caller":"traceutil/trace.go:171","msg":"trace[628893499] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2684; }","duration":"103.854854ms","start":"2026-06-02T23:49:47.361304Z","end":"2026-06-02T23:49:47.465159Z","steps":["trace[628893499] 'agreement among raft nodes before linearized reading' (duration: 103.169643ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:47.464776Z","caller":"traceutil/trace.go:171","msg":"trace[390310831] transaction","detail":"{read_only:false; response_revision:2684; number_of_response:1; }","duration":"133.976892ms","start":"2026-06-02T23:49:47.330778Z","end":"2026-06-02T23:49:47.464755Z","steps":["trace[390310831] 'process raft request' (duration: 131.588814ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:52:48.579575Z","caller":"traceutil/trace.go:171","msg":"trace[1329789073] transaction","detail":"{read_only:false; response_revision:3770; number_of_response:1; }","duration":"106.004155ms","start":"2026-06-02T23:52:48.473522Z","end":"2026-06-02T23:52:48.579526Z","steps":["trace[1329789073] 'process raft request' (duration: 62.856623ms)","trace[1329789073] 'compare' (duration: 42.883126ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:53:44.100735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.943989ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T23:53:44.100887Z","caller":"traceutil/trace.go:171","msg":"trace[1359777436] transaction","detail":"{read_only:false; response_revision:4556; number_of_response:1; }","duration":"202.387833ms","start":"2026-06-02T23:53:43.898475Z","end":"2026-06-02T23:53:44.100863Z","steps":["trace[1359777436] 'process raft request' (duration: 71.181508ms)","trace[1359777436] 'compare' (duration: 130.630073ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:53:44.254032Z","caller":"traceutil/trace.go:171","msg":"trace[47766711] transaction","detail":"{read_only:false; response_revision:4557; number_of_response:1; }","duration":"127.226212ms","start":"2026-06-02T23:53:44.126775Z","end":"2026-06-02T23:53:44.254001Z","steps":["trace[47766711] 'process raft request' (duration: 126.907946ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:53:46.477703Z","caller":"traceutil/trace.go:171","msg":"trace[927351613] linearizableReadLoop","detail":"{readStateIndex:4785; appliedIndex:4783; }","duration":"154.957529ms","start":"2026-06-02T23:53:46.322703Z","end":"2026-06-02T23:53:46.477661Z","steps":["trace[927351613] 'read index received' (duration: 15.361081ms)","trace[927351613] 'applied index is now lower than readState.Index' (duration: 139.593968ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:53:46.478482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.764015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29fb3fe8-eba3-4925-839c-b335c1ee29e8\" ","response":"range_response_count:1 size:4065"} {"level":"info","ts":"2026-06-02T23:53:46.478635Z","caller":"traceutil/trace.go:171","msg":"trace[2144830574] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-29fb3fe8-eba3-4925-839c-b335c1ee29e8; range_end:; response_count:1; response_revision:4609; }","duration":"155.966099ms","start":"2026-06-02T23:53:46.322648Z","end":"2026-06-02T23:53:46.478614Z","steps":["trace[2144830574] 'agreement among raft nodes before linearized reading' (duration: 155.175034ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:53:46.4791Z","caller":"traceutil/trace.go:171","msg":"trace[180088329] transaction","detail":"{read_only:false; response_revision:4609; number_of_response:1; }","duration":"164.789928ms","start":"2026-06-02T23:53:46.314219Z","end":"2026-06-02T23:53:46.479009Z","steps":["trace[180088329] 'process raft request' (duration: 162.36457ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:53:47.023911Z","caller":"traceutil/trace.go:171","msg":"trace[790974141] transaction","detail":"{read_only:false; response_revision:4614; number_of_response:1; }","duration":"100.819662ms","start":"2026-06-02T23:53:46.923062Z","end":"2026-06-02T23:53:47.023882Z","steps":["trace[790974141] 'process raft request' (duration: 78.837117ms)","trace[790974141] 'compare' (duration: 21.851903ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:53:47.03826Z","caller":"traceutil/trace.go:171","msg":"trace[1474303948] transaction","detail":"{read_only:false; response_revision:4615; number_of_response:1; }","duration":"113.537759ms","start":"2026-06-02T23:53:46.924689Z","end":"2026-06-02T23:53:47.038227Z","steps":["trace[1474303948] 'process raft request' (duration: 113.268194ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:53:47.038435Z","caller":"traceutil/trace.go:171","msg":"trace[275254] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"111.712893ms","start":"2026-06-02T23:53:46.926698Z","end":"2026-06-02T23:53:47.038411Z","steps":["trace[275254] 'process raft request' (duration: 111.442037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:53:51.074697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.119926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a0dcfbb3-1bfa-46ac-8a70-4317d37e8773\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-02T23:53:51.074967Z","caller":"traceutil/trace.go:171","msg":"trace[574263385] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a0dcfbb3-1bfa-46ac-8a70-4317d37e8773; range_end:; response_count:1; response_revision:4730; }","duration":"140.498933ms","start":"2026-06-02T23:53:50.934443Z","end":"2026-06-02T23:53:51.074942Z","steps":["trace[574263385] 'range keys from in-memory index tree' (duration: 139.929013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:53:51.07516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.495426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a0dcfbb3-1bfa-46ac-8a70-4317d37e8773\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-02T23:53:51.075279Z","caller":"traceutil/trace.go:171","msg":"trace[1785754742] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a0dcfbb3-1bfa-46ac-8a70-4317d37e8773; range_end:; response_count:1; response_revision:4730; }","duration":"209.73008ms","start":"2026-06-02T23:53:50.865519Z","end":"2026-06-02T23:53:51.075249Z","steps":["trace[1785754742] 'range keys from in-memory index tree' (duration: 209.002276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:53:51.0755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.017307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-02T23:53:51.075619Z","caller":"traceutil/trace.go:171","msg":"trace[96669705] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4730; }","duration":"154.242741ms","start":"2026-06-02T23:53:50.921349Z","end":"2026-06-02T23:53:51.075591Z","steps":["trace[96669705] 'range keys from in-memory index tree' (duration: 153.848323ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:53:51.218636Z","caller":"traceutil/trace.go:171","msg":"trace[1790790276] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"137.907049ms","start":"2026-06-02T23:53:51.080132Z","end":"2026-06-02T23:53:51.218039Z","steps":["trace[1790790276] 'process raft request' (duration: 137.658594ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:53:51.239028Z","caller":"traceutil/trace.go:171","msg":"trace[1536129261] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"158.329742ms","start":"2026-06-02T23:53:51.080647Z","end":"2026-06-02T23:53:51.238977Z","steps":["trace[1536129261] 'process raft request' (duration: 157.74933ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:53:51.239294Z","caller":"traceutil/trace.go:171","msg":"trace[1603235140] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"158.064317ms","start":"2026-06-02T23:53:51.081208Z","end":"2026-06-02T23:53:51.239273Z","steps":["trace[1603235140] 'process raft request' (duration: 157.944095ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:53:51.239294Z","caller":"traceutil/trace.go:171","msg":"trace[1537153696] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"156.419673ms","start":"2026-06-02T23:53:51.08285Z","end":"2026-06-02T23:53:51.23927Z","steps":["trace[1537153696] 'process raft request' (duration: 156.365502ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:53:51.239376Z","caller":"traceutil/trace.go:171","msg":"trace[795322821] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"158.20955ms","start":"2026-06-02T23:53:51.081152Z","end":"2026-06-02T23:53:51.239361Z","steps":["trace[795322821] 'process raft request' (duration: 157.774571ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:04.251386Z","caller":"traceutil/trace.go:171","msg":"trace[1777167373] linearizableReadLoop","detail":"{readStateIndex:5093; appliedIndex:5092; }","duration":"150.592577ms","start":"2026-06-02T23:54:04.100767Z","end":"2026-06-02T23:54:04.25136Z","steps":["trace[1777167373] 'read index received' (duration: 150.319631ms)","trace[1777167373] 'applied index is now lower than readState.Index' (duration: 271.826µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:54:04.251682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.891633ms","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-06-02T23:54:04.251735Z","caller":"traceutil/trace.go:171","msg":"trace[478762806] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4910; }","duration":"151.028506ms","start":"2026-06-02T23:54:04.100691Z","end":"2026-06-02T23:54:04.25172Z","steps":["trace[478762806] 'agreement among raft nodes before linearized reading' (duration: 150.808231ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:04.252027Z","caller":"traceutil/trace.go:171","msg":"trace[1013808182] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"226.359795ms","start":"2026-06-02T23:54:04.025653Z","end":"2026-06-02T23:54:04.252012Z","steps":["trace[1013808182] 'process raft request' (duration: 225.5506ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:04.37916Z","caller":"traceutil/trace.go:171","msg":"trace[187362933] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"114.463918ms","start":"2026-06-02T23:54:04.264659Z","end":"2026-06-02T23:54:04.379123Z","steps":["trace[187362933] 'process raft request' (duration: 78.016772ms)","trace[187362933] 'compare' (duration: 36.240862ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:54:04.393862Z","caller":"traceutil/trace.go:171","msg":"trace[356614821] linearizableReadLoop","detail":"{readStateIndex:5095; appliedIndex:5093; }","duration":"103.270446ms","start":"2026-06-02T23:54:04.290574Z","end":"2026-06-02T23:54:04.393844Z","steps":["trace[356614821] 'read index received' (duration: 52.112007ms)","trace[356614821] 'applied index is now lower than readState.Index' (duration: 51.156909ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:54:04.393935Z","caller":"traceutil/trace.go:171","msg":"trace[685226876] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"123.024999ms","start":"2026-06-02T23:54:04.27089Z","end":"2026-06-02T23:54:04.393915Z","steps":["trace[685226876] 'process raft request' (duration: 122.840575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:04.394221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.626872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:54:04.394336Z","caller":"traceutil/trace.go:171","msg":"trace[1905840693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4912; }","duration":"103.811486ms","start":"2026-06-02T23:54:04.290501Z","end":"2026-06-02T23:54:04.394313Z","steps":["trace[1905840693] 'agreement among raft nodes before linearized reading' (duration: 103.480439ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:04.588003Z","caller":"traceutil/trace.go:171","msg":"trace[55876252] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"185.728746ms","start":"2026-06-02T23:54:04.40223Z","end":"2026-06-02T23:54:04.587958Z","steps":["trace[55876252] 'process raft request' (duration: 104.595661ms)","trace[55876252] 'compare' (duration: 80.805088ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:54:04.589615Z","caller":"traceutil/trace.go:171","msg":"trace[1518834040] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"181.232406ms","start":"2026-06-02T23:54:04.408366Z","end":"2026-06-02T23:54:04.589598Z","steps":["trace[1518834040] 'process raft request' (duration: 181.192635ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:04.58989Z","caller":"traceutil/trace.go:171","msg":"trace[387793183] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"186.106053ms","start":"2026-06-02T23:54:04.403776Z","end":"2026-06-02T23:54:04.589882Z","steps":["trace[387793183] 'process raft request' (duration: 185.624374ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:04.590049Z","caller":"traceutil/trace.go:171","msg":"trace[1170514953] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"185.932711ms","start":"2026-06-02T23:54:04.404111Z","end":"2026-06-02T23:54:04.590044Z","steps":["trace[1170514953] 'process raft request' (duration: 185.355489ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:04.590145Z","caller":"traceutil/trace.go:171","msg":"trace[223767990] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"185.634815ms","start":"2026-06-02T23:54:04.404505Z","end":"2026-06-02T23:54:04.59014Z","steps":["trace[223767990] 'process raft request' (duration: 184.996412ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:04.590296Z","caller":"traceutil/trace.go:171","msg":"trace[797929383] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"182.3986ms","start":"2026-06-02T23:54:04.407891Z","end":"2026-06-02T23:54:04.59029Z","steps":["trace[797929383] 'process raft request' (duration: 181.634234ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:24.706384Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2882} {"level":"info","ts":"2026-06-02T23:55:24.79185Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2882,"took":"83.50749ms","hash":3459218996,"current-db-size-bytes":52170752,"current-db-size":"52 MB","current-db-size-in-use-bytes":28938240,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-02T23:55:24.792015Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3459218996,"revision":2882,"compact-revision":-1} {"level":"warn","ts":"2026-06-02T23:58:06.864938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.257481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-02T23:58:06.865042Z","caller":"traceutil/trace.go:171","msg":"trace[1032926591] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6679; }","duration":"224.379433ms","start":"2026-06-02T23:58:06.640638Z","end":"2026-06-02T23:58:06.865018Z","steps":["trace[1032926591] 'range keys from in-memory index tree' (duration: 224.059547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:58:06.86567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.443715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-02T23:58:06.865711Z","caller":"traceutil/trace.go:171","msg":"trace[1882564919] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6679; }","duration":"224.535027ms","start":"2026-06-02T23:58:06.641166Z","end":"2026-06-02T23:58:06.865701Z","steps":["trace[1882564919] 'range keys from in-memory index tree' (duration: 224.325722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:58:06.866203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.626658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-02T23:58:06.866245Z","caller":"traceutil/trace.go:171","msg":"trace[513631670] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6679; }","duration":"162.808292ms","start":"2026-06-02T23:58:06.703424Z","end":"2026-06-02T23:58:06.866233Z","steps":["trace[513631670] 'range keys from in-memory index tree' (duration: 162.366684ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T00:00:24.712982Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5556} {"level":"info","ts":"2026-06-03T00:00:24.783334Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5556,"took":"68.997214ms","hash":1708653946,"current-db-size-bytes":52170752,"current-db-size":"52 MB","current-db-size-in-use-bytes":18378752,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-03T00:00:24.783408Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1708653946,"revision":5556,"compact-revision":2882}