{"level":"warn","ts":"2026-05-30T20:57:42.768955Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T20:57:42.769043Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-05-30T20:57:42.769116Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T20:57:42.769133Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-30T20:57:42.769149Z","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-05-30T20:57:42.769979Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-05-30T20:57:42.770078Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-05-30T20:57:42.774725Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.427247ms"} {"level":"info","ts":"2026-05-30T20:57:42.781067Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-05-30T20:57:42.781249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-05-30T20:57:42.781274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-05-30T20:57:42.781284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-30T20:57:42.781337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-05-30T20:57:42.781489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-05-30T20:57:42.78665Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-30T20:57:42.787675Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-30T20:57:42.788732Z","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-05-30T20:57:42.790942Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-30T20:57:42.792389Z","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-05-30T20:57:42.792882Z","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-05-30T20:57:42.792901Z","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-05-30T20:57:42.794106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-05-30T20:57:42.79451Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-30T20:57:42.792344Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-30T20:57:42.798869Z","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-05-30T20:57:42.799695Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-30T20:57:42.799856Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-30T20:57:42.801326Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-30T20:57:42.801367Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-30T20:57:43.782594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-05-30T20:57:43.782649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-30T20:57:43.782681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-05-30T20:57:43.782699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-05-30T20:57:43.782711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-30T20:57:43.782727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-05-30T20:57:43.782745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-30T20:57:43.783652Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-05-30T20:57:43.783698Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T20:57:43.784118Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T20:57:43.784126Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T20:57:43.784746Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T20:57:43.784816Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T20:57:43.784845Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T20:57:43.784889Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-30T20:57:43.784901Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-30T20:57:43.786263Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-05-30T20:57:43.786876Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-30T20:57:45.283488Z","caller":"traceutil/trace.go:171","msg":"trace[1179631434] linearizableReadLoop","detail":"{readStateIndex:31; appliedIndex:30; }","duration":"102.879581ms","start":"2026-05-30T20:57:45.180581Z","end":"2026-05-30T20:57:45.28346Z","steps":["trace[1179631434] 'read index received' (duration: 42.142688ms)","trace[1179631434] 'applied index is now lower than readState.Index' (duration: 60.736043ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T20:57:45.283535Z","caller":"traceutil/trace.go:171","msg":"trace[1835987309] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"122.248853ms","start":"2026-05-30T20:57:45.161254Z","end":"2026-05-30T20:57:45.283503Z","steps":["trace[1835987309] 'process raft request' (duration: 61.499331ms)","trace[1835987309] 'compare' (duration: 60.590541ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T20:57:45.283853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.510699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T20:57:45.283923Z","caller":"traceutil/trace.go:171","msg":"trace[868769597] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:27; }","duration":"131.63276ms","start":"2026-05-30T20:57:45.152275Z","end":"2026-05-30T20:57:45.283908Z","steps":["trace[868769597] 'agreement among raft nodes before linearized reading' (duration: 131.298997ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:57:45.702934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.637078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-30T20:57:45.70316Z","caller":"traceutil/trace.go:171","msg":"trace[1941662365] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"518.285743ms","start":"2026-05-30T20:57:45.184842Z","end":"2026-05-30T20:57:45.703127Z","steps":["trace[1941662365] 'process raft request' (duration: 216.878747ms)","trace[1941662365] 'compare' (duration: 300.500397ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T20:57:45.703268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:57:45.184827Z","time spent":"518.398305ms","remote":"127.0.0.1:44804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":983,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T20:57:45.70354Z","caller":"traceutil/trace.go:171","msg":"trace[311895215] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"518.502027ms","start":"2026-05-30T20:57:45.18501Z","end":"2026-05-30T20:57:45.703512Z","steps":["trace[311895215] 'process raft request' (duration: 518.029791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:57:45.703646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:57:45.184981Z","time spent":"518.615038ms","remote":"127.0.0.1:44804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T20:57:45.703777Z","caller":"traceutil/trace.go:171","msg":"trace[298747604] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"518.038821ms","start":"2026-05-30T20:57:45.185712Z","end":"2026-05-30T20:57:45.70375Z","steps":["trace[298747604] 'process raft request' (duration: 517.793929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:57:45.703826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:57:45.185703Z","time spent":"518.096252ms","remote":"127.0.0.1:44744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":713,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T20:57:45.703808Z","caller":"traceutil/trace.go:171","msg":"trace[1071319972] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"518.728958ms","start":"2026-05-30T20:57:45.185048Z","end":"2026-05-30T20:57:45.703777Z","steps":["trace[1071319972] 'process raft request' (duration: 518.356034ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:57:45.704019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:57:45.185037Z","time spent":"518.875059ms","remote":"127.0.0.1:44804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T20:57:45.704049Z","caller":"traceutil/trace.go:171","msg":"trace[1787411652] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"516.426035ms","start":"2026-05-30T20:57:45.187615Z","end":"2026-05-30T20:57:45.704041Z","steps":["trace[1787411652] 'process raft request' (duration: 515.94305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:57:45.704109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:57:45.187607Z","time spent":"516.484046ms","remote":"127.0.0.1:44372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T20:57:45.704061Z","caller":"traceutil/trace.go:171","msg":"trace[320652572] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"518.319604ms","start":"2026-05-30T20:57:45.185573Z","end":"2026-05-30T20:57:45.703892Z","steps":["trace[320652572] 'process raft request' (duration: 517.897129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:57:45.704483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:57:45.185563Z","time spent":"518.739488ms","remote":"127.0.0.1:44804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T20:57:45.704511Z","caller":"traceutil/trace.go:171","msg":"trace[1951786126] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"418.623736ms","start":"2026-05-30T20:57:45.28587Z","end":"2026-05-30T20:57:45.704494Z","steps":["trace[1951786126] 'process raft request' (duration: 418.553425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:57:45.704599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:57:45.285847Z","time spent":"418.712737ms","remote":"127.0.0.1:44378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T20:57:45.704686Z","caller":"traceutil/trace.go:171","msg":"trace[1829884943] linearizableReadLoop","detail":"{readStateIndex:38; appliedIndex:31; }","duration":"421.080321ms","start":"2026-05-30T20:57:45.283565Z","end":"2026-05-30T20:57:45.704645Z","steps":["trace[1829884943] 'read index received' (duration: 118.141119ms)","trace[1829884943] 'applied index is now lower than readState.Index' (duration: 302.937962ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T20:57:45.704792Z","caller":"traceutil/trace.go:171","msg":"trace[1049742557] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"514.913889ms","start":"2026-05-30T20:57:45.189869Z","end":"2026-05-30T20:57:45.704783Z","steps":["trace[1049742557] 'process raft request' (duration: 513.734897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:57:45.705122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:57:45.189861Z","time spent":"514.987949ms","remote":"127.0.0.1:44420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T20:57:45.705235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.624318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-g7nws\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-05-30T20:57:45.705506Z","caller":"traceutil/trace.go:171","msg":"trace[1309038179] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-g7nws; range_end:; response_count:1; response_revision:35; }","duration":"520.921581ms","start":"2026-05-30T20:57:45.184569Z","end":"2026-05-30T20:57:45.705491Z","steps":["trace[1309038179] 'agreement among raft nodes before linearized reading' (duration: 520.410306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:57:45.705556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:57:45.184558Z","time spent":"520.986591ms","remote":"127.0.0.1:44512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":883,"request content":"key:\"/registry/certificatesigningrequests/csr-g7nws\" "} {"level":"warn","ts":"2026-05-30T20:57:45.705717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.118492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T20:57:45.70579Z","caller":"traceutil/trace.go:171","msg":"trace[795793649] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:35; }","duration":"520.208983ms","start":"2026-05-30T20:57:45.185568Z","end":"2026-05-30T20:57:45.705777Z","steps":["trace[795793649] 'agreement among raft nodes before linearized reading' (duration: 520.114742ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:57:45.705827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:57:45.185561Z","time spent":"520.256993ms","remote":"127.0.0.1:44372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":26,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-05-30T20:57:45.705387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.815851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T20:57:45.706718Z","caller":"traceutil/trace.go:171","msg":"trace[1216954325] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:35; }","duration":"305.176236ms","start":"2026-05-30T20:57:45.401522Z","end":"2026-05-30T20:57:45.706698Z","steps":["trace[1216954325] 'agreement among raft nodes before linearized reading' (duration: 303.832392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:57:45.706927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:57:45.401505Z","time spent":"305.401978ms","remote":"127.0.0.1:44656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-05-30T20:58:18.321613Z","caller":"traceutil/trace.go:171","msg":"trace[1124210560] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"156.321138ms","start":"2026-05-30T20:58:18.165268Z","end":"2026-05-30T20:58:18.321589Z","steps":["trace[1124210560] 'process raft request' (duration: 155.872444ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:18.330085Z","caller":"traceutil/trace.go:171","msg":"trace[127339880] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:540; }","duration":"130.930457ms","start":"2026-05-30T20:58:18.199141Z","end":"2026-05-30T20:58:18.330071Z","steps":["trace[127339880] 'read index received' (duration: 122.645138ms)","trace[127339880] 'applied index is now lower than readState.Index' (duration: 8.284759ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T20:58:18.330231Z","caller":"traceutil/trace.go:171","msg":"trace[1273316207] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"117.789768ms","start":"2026-05-30T20:58:18.212421Z","end":"2026-05-30T20:58:18.330211Z","steps":["trace[1273316207] 'process raft request' (duration: 117.530406ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:18.330294Z","caller":"traceutil/trace.go:171","msg":"trace[982123247] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"157.491048ms","start":"2026-05-30T20:58:18.172787Z","end":"2026-05-30T20:58:18.330278Z","steps":["trace[982123247] 'process raft request' (duration: 156.883293ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:18.330374Z","caller":"traceutil/trace.go:171","msg":"trace[384304392] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"108.969285ms","start":"2026-05-30T20:58:18.221393Z","end":"2026-05-30T20:58:18.330362Z","steps":["trace[384304392] 'process raft request' (duration: 108.621112ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:18.330437Z","caller":"traceutil/trace.go:171","msg":"trace[1367727792] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"155.873245ms","start":"2026-05-30T20:58:18.174552Z","end":"2026-05-30T20:58:18.330426Z","steps":["trace[1367727792] 'process raft request' (duration: 155.168478ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:18.330543Z","caller":"traceutil/trace.go:171","msg":"trace[297600654] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"152.110025ms","start":"2026-05-30T20:58:18.178407Z","end":"2026-05-30T20:58:18.330517Z","steps":["trace[297600654] 'process raft request' (duration: 151.346878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:18.330561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.367682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:18.330588Z","caller":"traceutil/trace.go:171","msg":"trace[611747417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:530; }","duration":"131.460132ms","start":"2026-05-30T20:58:18.19912Z","end":"2026-05-30T20:58:18.33058Z","steps":["trace[611747417] 'agreement among raft nodes before linearized reading' (duration: 131.328281ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:18.330617Z","caller":"traceutil/trace.go:171","msg":"trace[169562003] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"151.438829ms","start":"2026-05-30T20:58:18.179169Z","end":"2026-05-30T20:58:18.330608Z","steps":["trace[169562003] 'process raft request' (duration: 150.625471ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:18.330659Z","caller":"traceutil/trace.go:171","msg":"trace[147394285] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"151.257157ms","start":"2026-05-30T20:58:18.179381Z","end":"2026-05-30T20:58:18.330639Z","steps":["trace[147394285] 'process raft request' (duration: 150.442189ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:18.330712Z","caller":"traceutil/trace.go:171","msg":"trace[194223620] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"142.319142ms","start":"2026-05-30T20:58:18.188385Z","end":"2026-05-30T20:58:18.330704Z","steps":["trace[194223620] 'process raft request' (duration: 141.490685ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:18.330836Z","caller":"traceutil/trace.go:171","msg":"trace[1135209305] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"138.37964ms","start":"2026-05-30T20:58:18.192425Z","end":"2026-05-30T20:58:18.330805Z","steps":["trace[1135209305] 'process raft request' (duration: 137.481842ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:18.330224Z","caller":"traceutil/trace.go:171","msg":"trace[2026878850] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"150.085416ms","start":"2026-05-30T20:58:18.180112Z","end":"2026-05-30T20:58:18.330198Z","steps":["trace[2026878850] 'process raft request' (duration: 149.735313ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.320195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.487171ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T20:58:24.320343Z","caller":"traceutil/trace.go:171","msg":"trace[1197527721] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"199.372772ms","start":"2026-05-30T20:58:24.120958Z","end":"2026-05-30T20:58:24.32033Z","steps":["trace[1197527721] 'read index received' (duration: 41.583516ms)","trace[1197527721] 'applied index is now lower than readState.Index' (duration: 157.788336ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T20:58:24.32044Z","caller":"traceutil/trace.go:171","msg":"trace[139462024] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"200.149759ms","start":"2026-05-30T20:58:24.120277Z","end":"2026-05-30T20:58:24.320427Z","steps":["trace[139462024] 'process raft request' (duration: 42.295973ms)","trace[139462024] 'compare' (duration: 157.35341ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T20:58:24.320607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.582675ms","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":"warn","ts":"2026-05-30T20:58:24.320547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.582854ms","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-05-30T20:58:24.320685Z","caller":"traceutil/trace.go:171","msg":"trace[1987190158] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"199.682056ms","start":"2026-05-30T20:58:24.120984Z","end":"2026-05-30T20:58:24.320666Z","steps":["trace[1987190158] 'agreement among raft nodes before linearized reading' (duration: 199.562174ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:24.320709Z","caller":"traceutil/trace.go:171","msg":"trace[1048989439] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"199.732146ms","start":"2026-05-30T20:58:24.120955Z","end":"2026-05-30T20:58:24.320688Z","steps":["trace[1048989439] 'agreement among raft nodes before linearized reading' (duration: 199.560334ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.320984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.605121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.321019Z","caller":"traceutil/trace.go:171","msg":"trace[756780921] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"176.658781ms","start":"2026-05-30T20:58:24.144353Z","end":"2026-05-30T20:58:24.321012Z","steps":["trace[756780921] 'agreement among raft nodes before linearized reading' (duration: 176.60562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.32105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.159923ms","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-05-30T20:58:24.321097Z","caller":"traceutil/trace.go:171","msg":"trace[2040266133] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"199.224384ms","start":"2026-05-30T20:58:24.121861Z","end":"2026-05-30T20:58:24.321085Z","steps":["trace[2040266133] 'agreement among raft nodes before linearized reading' (duration: 199.162643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.321295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.441707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.321322Z","caller":"traceutil/trace.go:171","msg":"trace[990538587] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"125.507327ms","start":"2026-05-30T20:58:24.195808Z","end":"2026-05-30T20:58:24.321316Z","steps":["trace[990538587] 'agreement among raft nodes before linearized reading' (duration: 125.375785ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.321482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.054016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.321508Z","caller":"traceutil/trace.go:171","msg":"trace[1463886938] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"177.092206ms","start":"2026-05-30T20:58:24.144409Z","end":"2026-05-30T20:58:24.321502Z","steps":["trace[1463886938] 'agreement among raft nodes before linearized reading' (duration: 177.052856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.321539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.120746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.321584Z","caller":"traceutil/trace.go:171","msg":"trace[1280848877] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"177.182857ms","start":"2026-05-30T20:58:24.144391Z","end":"2026-05-30T20:58:24.321574Z","steps":["trace[1280848877] 'agreement among raft nodes before linearized reading' (duration: 177.109346ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:24.566905Z","caller":"traceutil/trace.go:171","msg":"trace[1750515663] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"112.939063ms","start":"2026-05-30T20:58:24.453938Z","end":"2026-05-30T20:58:24.566877Z","steps":["trace[1750515663] 'read index received' (duration: 112.558029ms)","trace[1750515663] 'applied index is now lower than readState.Index' (duration: 337.264µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T20:58:24.567238Z","caller":"traceutil/trace.go:171","msg":"trace[1287626915] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"147.637566ms","start":"2026-05-30T20:58:24.419582Z","end":"2026-05-30T20:58:24.567219Z","steps":["trace[1287626915] 'process raft request' (duration: 146.989038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.567543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.586151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ppkz6\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-30T20:58:24.568269Z","caller":"traceutil/trace.go:171","msg":"trace[826772182] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ppkz6; range_end:; response_count:1; response_revision:627; }","duration":"113.688042ms","start":"2026-05-30T20:58:24.453897Z","end":"2026-05-30T20:58:24.567585Z","steps":["trace[826772182] 'agreement among raft nodes before linearized reading' (duration: 113.303997ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:24.760812Z","caller":"traceutil/trace.go:171","msg":"trace[2023821987] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"193.829785ms","start":"2026-05-30T20:58:24.566955Z","end":"2026-05-30T20:58:24.760785Z","steps":["trace[2023821987] 'read index received' (duration: 141.76571ms)","trace[2023821987] 'applied index is now lower than readState.Index' (duration: 52.063055ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T20:58:24.761407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.005855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T20:58:24.761419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.359976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T20:58:24.761511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.081745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.761474Z","caller":"traceutil/trace.go:171","msg":"trace[4297947] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:628; }","duration":"211.101826ms","start":"2026-05-30T20:58:24.550356Z","end":"2026-05-30T20:58:24.761458Z","steps":["trace[4297947] 'agreement among raft nodes before linearized reading' (duration: 210.979244ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:24.761499Z","caller":"traceutil/trace.go:171","msg":"trace[1219405355] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"280.857927ms","start":"2026-05-30T20:58:24.480612Z","end":"2026-05-30T20:58:24.76147Z","steps":["trace[1219405355] 'process raft request' (duration: 228.202875ms)","trace[1219405355] 'compare' (duration: 51.68857ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T20:58:24.761541Z","caller":"traceutil/trace.go:171","msg":"trace[837364850] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:628; }","duration":"211.131436ms","start":"2026-05-30T20:58:24.550401Z","end":"2026-05-30T20:58:24.761533Z","steps":["trace[837364850] 'agreement among raft nodes before linearized reading' (duration: 211.091415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.761543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.796984ms","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-05-30T20:58:24.761586Z","caller":"traceutil/trace.go:171","msg":"trace[439786821] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:628; }","duration":"279.862714ms","start":"2026-05-30T20:58:24.481708Z","end":"2026-05-30T20:58:24.761571Z","steps":["trace[439786821] 'agreement among raft nodes before linearized reading' (duration: 279.769413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.761527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.418514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.76151Z","caller":"traceutil/trace.go:171","msg":"trace[532756532] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:628; }","duration":"210.473578ms","start":"2026-05-30T20:58:24.551024Z","end":"2026-05-30T20:58:24.761497Z","steps":["trace[532756532] 'agreement among raft nodes before linearized reading' (duration: 210.340927ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:24.761743Z","caller":"traceutil/trace.go:171","msg":"trace[55970028] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:628; }","duration":"245.683307ms","start":"2026-05-30T20:58:24.51601Z","end":"2026-05-30T20:58:24.761693Z","steps":["trace[55970028] 'agreement among raft nodes before linearized reading' (duration: 245.386663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.761888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.833509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.76194Z","caller":"traceutil/trace.go:171","msg":"trace[1870259363] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:628; }","duration":"245.8762ms","start":"2026-05-30T20:58:24.516035Z","end":"2026-05-30T20:58:24.761911Z","steps":["trace[1870259363] 'agreement among raft nodes before linearized reading' (duration: 245.817169ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.761906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.729303ms","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-05-30T20:58:24.762098Z","caller":"traceutil/trace.go:171","msg":"trace[578345356] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:628; }","duration":"280.299269ms","start":"2026-05-30T20:58:24.48176Z","end":"2026-05-30T20:58:24.762059Z","steps":["trace[578345356] 'agreement among raft nodes before linearized reading' (duration: 279.686132ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:24.817605Z","caller":"traceutil/trace.go:171","msg":"trace[1907484488] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"234.912951ms","start":"2026-05-30T20:58:24.582665Z","end":"2026-05-30T20:58:24.817578Z","steps":["trace[1907484488] 'process raft request' (duration: 234.680348ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.817769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.354301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.817854Z","caller":"traceutil/trace.go:171","msg":"trace[228903660] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:629; }","duration":"190.473703ms","start":"2026-05-30T20:58:24.627361Z","end":"2026-05-30T20:58:24.817835Z","steps":["trace[228903660] 'agreement among raft nodes before linearized reading' (duration: 190.303991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.818127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.221723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T20:58:24.81814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.747883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.818185Z","caller":"traceutil/trace.go:171","msg":"trace[1944701119] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:629; }","duration":"246.300045ms","start":"2026-05-30T20:58:24.571871Z","end":"2026-05-30T20:58:24.818171Z","steps":["trace[1944701119] 'agreement among raft nodes before linearized reading' (duration: 246.209984ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.818229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.723158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.818267Z","caller":"traceutil/trace.go:171","msg":"trace[779622797] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:629; }","duration":"191.769889ms","start":"2026-05-30T20:58:24.626486Z","end":"2026-05-30T20:58:24.818256Z","steps":["trace[779622797] 'agreement among raft nodes before linearized reading' (duration: 191.723579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.818272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.364508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.818302Z","caller":"traceutil/trace.go:171","msg":"trace[1877561050] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:629; }","duration":"218.408529ms","start":"2026-05-30T20:58:24.599885Z","end":"2026-05-30T20:58:24.818294Z","steps":["trace[1877561050] 'agreement among raft nodes before linearized reading' (duration: 218.362338ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.818356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.430497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.818395Z","caller":"traceutil/trace.go:171","msg":"trace[1173551980] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:629; }","duration":"246.479128ms","start":"2026-05-30T20:58:24.571905Z","end":"2026-05-30T20:58:24.818384Z","steps":["trace[1173551980] 'agreement among raft nodes before linearized reading' (duration: 246.422647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.818141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.246411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.818518Z","caller":"traceutil/trace.go:171","msg":"trace[890141704] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:629; }","duration":"245.646967ms","start":"2026-05-30T20:58:24.572861Z","end":"2026-05-30T20:58:24.818508Z","steps":["trace[890141704] 'agreement among raft nodes before linearized reading' (duration: 245.229661ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.81855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.12986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T20:58:24.818564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.343692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.818589Z","caller":"traceutil/trace.go:171","msg":"trace[935026021] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:629; }","duration":"219.20434ms","start":"2026-05-30T20:58:24.599375Z","end":"2026-05-30T20:58:24.818579Z","steps":["trace[935026021] 'agreement among raft nodes before linearized reading' (duration: 219.149729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.81819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.717158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.818615Z","caller":"traceutil/trace.go:171","msg":"trace[1577974670] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:629; }","duration":"143.431632ms","start":"2026-05-30T20:58:24.675171Z","end":"2026-05-30T20:58:24.818602Z","steps":["trace[1577974670] 'agreement among raft nodes before linearized reading' (duration: 143.360222ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:24.81864Z","caller":"traceutil/trace.go:171","msg":"trace[1045921717] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:629; }","duration":"192.179795ms","start":"2026-05-30T20:58:24.626448Z","end":"2026-05-30T20:58:24.818627Z","steps":["trace[1045921717] 'agreement among raft nodes before linearized reading' (duration: 191.720878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:58:24.818684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.620065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:24.818726Z","caller":"traceutil/trace.go:171","msg":"trace[1586265226] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:629; }","duration":"143.661866ms","start":"2026-05-30T20:58:24.675052Z","end":"2026-05-30T20:58:24.818714Z","steps":["trace[1586265226] 'agreement among raft nodes before linearized reading' (duration: 143.601415ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:24.818221Z","caller":"traceutil/trace.go:171","msg":"trace[1257147439] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:629; }","duration":"218.852264ms","start":"2026-05-30T20:58:24.599349Z","end":"2026-05-30T20:58:24.818202Z","steps":["trace[1257147439] 'agreement among raft nodes before linearized reading' (duration: 218.696842ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:25.171524Z","caller":"traceutil/trace.go:171","msg":"trace[180245229] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"339.473076ms","start":"2026-05-30T20:58:24.832026Z","end":"2026-05-30T20:58:25.171499Z","steps":["trace[180245229] 'process raft request' (duration: 297.306085ms)","trace[180245229] 'compare' (duration: 42.031185ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T20:58:25.171662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T20:58:24.832014Z","time spent":"339.583011ms","remote":"127.0.0.1:44494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T20:58:25.32585Z","caller":"traceutil/trace.go:171","msg":"trace[681839774] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"129.784135ms","start":"2026-05-30T20:58:25.196039Z","end":"2026-05-30T20:58:25.325824Z","steps":["trace[681839774] 'read index received' (duration: 96.013996ms)","trace[681839774] 'applied index is now lower than readState.Index' (duration: 33.768919ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T20:58:25.32596Z","caller":"traceutil/trace.go:171","msg":"trace[516908259] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"138.156386ms","start":"2026-05-30T20:58:25.187775Z","end":"2026-05-30T20:58:25.325931Z","steps":["trace[516908259] 'process raft request' (duration: 104.379957ms)","trace[516908259] 'compare' (duration: 33.506976ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T20:58:25.326063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.006296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T20:58:25.32611Z","caller":"traceutil/trace.go:171","msg":"trace[875515981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"130.09027ms","start":"2026-05-30T20:58:25.196005Z","end":"2026-05-30T20:58:25.326095Z","steps":["trace[875515981] 'agreement among raft nodes before linearized reading' (duration: 129.976405ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T20:58:38.874547Z","caller":"traceutil/trace.go:171","msg":"trace[1689661332] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"123.275654ms","start":"2026-05-30T20:58:38.751245Z","end":"2026-05-30T20:58:38.87452Z","steps":["trace[1689661332] 'process raft request' (duration: 123.143109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:59:09.962558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.438163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-30T20:59:09.962639Z","caller":"traceutil/trace.go:171","msg":"trace[1111213648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1193; }","duration":"145.559426ms","start":"2026-05-30T20:59:09.817061Z","end":"2026-05-30T20:59:09.962621Z","steps":["trace[1111213648] 'range keys from in-memory index tree' (duration: 145.252398ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T20:59:56.405247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.277877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-30T20:59:56.405558Z","caller":"traceutil/trace.go:171","msg":"trace[1897693541] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1863; }","duration":"111.633084ms","start":"2026-05-30T20:59:56.293905Z","end":"2026-05-30T20:59:56.405539Z","steps":["trace[1897693541] 'range keys from in-memory index tree' (duration: 111.036062ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:00:29.257155Z","caller":"traceutil/trace.go:171","msg":"trace[204644571] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"201.49991ms","start":"2026-05-30T21:00:29.055638Z","end":"2026-05-30T21:00:29.257138Z","steps":["trace[204644571] 'process raft request' (duration: 114.023402ms)","trace[204644571] 'compare' (duration: 87.309725ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T21:00:29.796923Z","caller":"traceutil/trace.go:171","msg":"trace[545315876] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"111.323467ms","start":"2026-05-30T21:00:29.685549Z","end":"2026-05-30T21:00:29.796872Z","steps":["trace[545315876] 'process raft request' (duration: 49.791443ms)","trace[545315876] 'compare' (duration: 61.390331ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T21:00:30.872232Z","caller":"traceutil/trace.go:171","msg":"trace[1167381214] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"133.197759ms","start":"2026-05-30T21:00:30.738998Z","end":"2026-05-30T21:00:30.872196Z","steps":["trace[1167381214] 'process raft request' (duration: 132.978825ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:00:31.284802Z","caller":"traceutil/trace.go:171","msg":"trace[1140081136] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"156.21621ms","start":"2026-05-30T21:00:31.128551Z","end":"2026-05-30T21:00:31.284767Z","steps":["trace[1140081136] 'process raft request' (duration: 155.877684ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:01:52.260435Z","caller":"traceutil/trace.go:171","msg":"trace[33044182] linearizableReadLoop","detail":"{readStateIndex:2738; appliedIndex:2737; }","duration":"162.300513ms","start":"2026-05-30T21:01:52.098112Z","end":"2026-05-30T21:01:52.260413Z","steps":["trace[33044182] 'read index received' (duration: 157.206696ms)","trace[33044182] 'applied index is now lower than readState.Index' (duration: 5.092537ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T21:01:52.260959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.82039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:7462"} {"level":"info","ts":"2026-05-30T21:01:52.261084Z","caller":"traceutil/trace.go:171","msg":"trace[2100802701] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:2638; }","duration":"163.007842ms","start":"2026-05-30T21:01:52.098053Z","end":"2026-05-30T21:01:52.261061Z","steps":["trace[2100802701] 'agreement among raft nodes before linearized reading' (duration: 162.454155ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:05:58.806966Z","caller":"traceutil/trace.go:171","msg":"trace[621008587] transaction","detail":"{read_only:false; response_revision:4545; number_of_response:1; }","duration":"140.491825ms","start":"2026-05-30T21:05:58.666453Z","end":"2026-05-30T21:05:58.806945Z","steps":["trace[621008587] 'process raft request' (duration: 140.374323ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:05:58.825181Z","caller":"traceutil/trace.go:171","msg":"trace[914591864] transaction","detail":"{read_only:false; response_revision:4546; number_of_response:1; }","duration":"148.451589ms","start":"2026-05-30T21:05:58.67665Z","end":"2026-05-30T21:05:58.825102Z","steps":["trace[914591864] 'process raft request' (duration: 148.271196ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:05:58.825247Z","caller":"traceutil/trace.go:171","msg":"trace[190765887] transaction","detail":"{read_only:false; response_revision:4547; number_of_response:1; }","duration":"147.50786ms","start":"2026-05-30T21:05:58.677693Z","end":"2026-05-30T21:05:58.825201Z","steps":["trace[190765887] 'process raft request' (duration: 147.305616ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:05:58.825586Z","caller":"traceutil/trace.go:171","msg":"trace[236980616] transaction","detail":"{read_only:false; response_revision:4548; number_of_response:1; }","duration":"139.125806ms","start":"2026-05-30T21:05:58.686443Z","end":"2026-05-30T21:05:58.825568Z","steps":["trace[236980616] 'process raft request' (duration: 138.590385ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:06:02.753798Z","caller":"traceutil/trace.go:171","msg":"trace[324251404] transaction","detail":"{read_only:false; response_revision:4665; number_of_response:1; }","duration":"140.309876ms","start":"2026-05-30T21:06:02.613471Z","end":"2026-05-30T21:06:02.75378Z","steps":["trace[324251404] 'process raft request' (duration: 140.212884ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:06:13.94887Z","caller":"traceutil/trace.go:171","msg":"trace[156406910] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"195.369101ms","start":"2026-05-30T21:06:13.753475Z","end":"2026-05-30T21:06:13.948844Z","steps":["trace[156406910] 'process raft request' (duration: 156.827026ms)","trace[156406910] 'compare' (duration: 38.444963ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T21:06:14.148097Z","caller":"traceutil/trace.go:171","msg":"trace[754148621] linearizableReadLoop","detail":"{readStateIndex:5074; appliedIndex:5072; }","duration":"165.439424ms","start":"2026-05-30T21:06:13.982595Z","end":"2026-05-30T21:06:14.148035Z","steps":["trace[754148621] 'read index received' (duration: 22.460772ms)","trace[754148621] 'applied index is now lower than readState.Index' (duration: 142.977192ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T21:06:14.148183Z","caller":"traceutil/trace.go:171","msg":"trace[638249878] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"186.946627ms","start":"2026-05-30T21:06:13.961197Z","end":"2026-05-30T21:06:14.148143Z","steps":["trace[638249878] 'process raft request' (duration: 176.307213ms)","trace[638249878] 'compare' (duration: 10.353368ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T21:06:14.148506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.863262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1447ec4-6096-44e7-b430-a4a2ba04f63e\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-05-30T21:06:14.148511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.328446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T21:06:14.148567Z","caller":"traceutil/trace.go:171","msg":"trace[1421773296] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4889; }","duration":"121.452859ms","start":"2026-05-30T21:06:14.0271Z","end":"2026-05-30T21:06:14.148552Z","steps":["trace[1421773296] 'agreement among raft nodes before linearized reading' (duration: 121.306576ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:06:14.148629Z","caller":"traceutil/trace.go:171","msg":"trace[670515276] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d1447ec4-6096-44e7-b430-a4a2ba04f63e; range_end:; response_count:1; response_revision:4889; }","duration":"165.982504ms","start":"2026-05-30T21:06:13.982562Z","end":"2026-05-30T21:06:14.148544Z","steps":["trace[670515276] 'agreement among raft nodes before linearized reading' (duration: 165.730809ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:07:43.813793Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2918} {"level":"info","ts":"2026-05-30T21:07:43.920902Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2918,"took":"105.696949ms","hash":2091284716,"current-db-size-bytes":54243328,"current-db-size":"54 MB","current-db-size-in-use-bytes":29343744,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-30T21:07:43.920977Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2091284716,"revision":2918,"compact-revision":-1} {"level":"info","ts":"2026-05-30T21:10:02.129764Z","caller":"traceutil/trace.go:171","msg":"trace[1469381491] transaction","detail":"{read_only:false; response_revision:6562; number_of_response:1; }","duration":"138.951827ms","start":"2026-05-30T21:10:01.990785Z","end":"2026-05-30T21:10:02.129737Z","steps":["trace[1469381491] 'process raft request' (duration: 138.797994ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:10:02.158171Z","caller":"traceutil/trace.go:171","msg":"trace[752615597] transaction","detail":"{read_only:false; response_revision:6563; number_of_response:1; }","duration":"165.635824ms","start":"2026-05-30T21:10:01.992503Z","end":"2026-05-30T21:10:02.158139Z","steps":["trace[752615597] 'process raft request' (duration: 150.775866ms)","trace[752615597] 'compare' (duration: 14.667215ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T21:10:02.158251Z","caller":"traceutil/trace.go:171","msg":"trace[1067654730] transaction","detail":"{read_only:false; response_revision:6564; number_of_response:1; }","duration":"163.682473ms","start":"2026-05-30T21:10:01.994515Z","end":"2026-05-30T21:10:02.158197Z","steps":["trace[1067654730] 'process raft request' (duration: 163.553391ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T21:12:43.820856Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5616} {"level":"info","ts":"2026-05-30T21:12:43.916513Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5616,"took":"94.40042ms","hash":1534606314,"current-db-size-bytes":54243328,"current-db-size":"54 MB","current-db-size-in-use-bytes":18292736,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-30T21:12:43.916573Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1534606314,"revision":5616,"compact-revision":2918}