{"level":"warn","ts":"2026-05-05T06:50:19.620229Z","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-05T06:50:19.620358Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169: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.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-05T06:50:19.620463Z","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-05T06:50:19.620488Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-05-05T06:50:19.620528Z","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-05T06:50:19.621849Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-05-05T06:50:19.621921Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-05T06:50:19.625172Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.043131ms"} {"level":"info","ts":"2026-05-05T06:50:19.638436Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-05-05T06:50:19.638561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T06:50:19.638595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-05-05T06:50:19.638615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T06:50:19.638637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-05-05T06:50:19.63869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-05-05T06:50:19.64546Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T06:50:19.648783Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T06:50:19.649974Z","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-05T06:50:19.653048Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T06:50:19.653882Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T06:50:19.653905Z","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-05T06:50:19.654001Z","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-05T06:50:19.654026Z","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-05T06:50:19.655452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-05-05T06:50:19.655722Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-05-05T06:50:19.657277Z","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-05T06:50:19.657412Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-05-05T06:50:19.657515Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T06:50:19.657563Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T06:50:19.657564Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-05-05T06:50:20.639981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T06:50:20.64006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T06:50:20.640146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-05-05T06:50:20.640184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-05-05T06:50:20.640207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-05-05T06:50:20.640241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-05-05T06:50:20.640269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-05-05T06:50:20.64125Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:50:20.642356Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T06:50:20.642359Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T06:50:20.642395Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T06:50:20.642655Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T06:50:20.642715Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T06:50:20.644462Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:50:20.644604Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:50:20.644659Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:50:20.645816Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-05-05T06:50:20.645947Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T06:50:23.14354Z","caller":"traceutil/trace.go:171","msg":"trace[537643908] linearizableReadLoop","detail":"{readStateIndex:119; appliedIndex:118; }","duration":"133.524971ms","start":"2026-05-05T06:50:23.009985Z","end":"2026-05-05T06:50:23.14351Z","steps":["trace[537643908] 'read index received' (duration: 133.397468ms)","trace[537643908] 'applied index is now lower than readState.Index' (duration: 126.163µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:50:23.14359Z","caller":"traceutil/trace.go:171","msg":"trace[894018793] transaction","detail":"{read_only:false; response_revision:114; number_of_response:1; }","duration":"224.88106ms","start":"2026-05-05T06:50:22.91867Z","end":"2026-05-05T06:50:23.143551Z","steps":["trace[894018793] 'process raft request' (duration: 224.646614ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:23.143833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.801208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T06:50:23.144053Z","caller":"traceutil/trace.go:171","msg":"trace[625307862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:114; }","duration":"134.058984ms","start":"2026-05-05T06:50:23.009936Z","end":"2026-05-05T06:50:23.143995Z","steps":["trace[625307862] 'agreement among raft nodes before linearized reading' (duration: 133.748307ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:36.484169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.917756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-05-05T06:50:36.484316Z","caller":"traceutil/trace.go:171","msg":"trace[356004163] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:412; }","duration":"166.134901ms","start":"2026-05-05T06:50:36.318161Z","end":"2026-05-05T06:50:36.484296Z","steps":["trace[356004163] 'range keys from in-memory index tree' (duration: 165.730751ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:50:36.95589Z","caller":"traceutil/trace.go:171","msg":"trace[1460578892] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:425; }","duration":"230.325386ms","start":"2026-05-05T06:50:36.725535Z","end":"2026-05-05T06:50:36.955861Z","steps":["trace[1460578892] 'read index received' (duration: 230.111761ms)","trace[1460578892] 'applied index is now lower than readState.Index' (duration: 212.245µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:50:36.95603Z","caller":"traceutil/trace.go:171","msg":"trace[148913135] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"462.797133ms","start":"2026-05-05T06:50:36.493197Z","end":"2026-05-05T06:50:36.955995Z","steps":["trace[148913135] 'process raft request' (duration: 462.491316ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:36.956122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.570602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T06:50:36.956389Z","caller":"traceutil/trace.go:171","msg":"trace[313156819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:413; }","duration":"230.90195ms","start":"2026-05-05T06:50:36.725464Z","end":"2026-05-05T06:50:36.956366Z","steps":["trace[313156819] 'agreement among raft nodes before linearized reading' (duration: 230.575142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:36.956127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.679889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T06:50:36.956523Z","caller":"traceutil/trace.go:171","msg":"trace[463448939] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:413; }","duration":"211.055927ms","start":"2026-05-05T06:50:36.745425Z","end":"2026-05-05T06:50:36.956481Z","steps":["trace[463448939] 'agreement among raft nodes before linearized reading' (duration: 210.642678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:36.957264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:36.493174Z","time spent":"463.085309ms","remote":"127.0.0.1:34862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:51:52.701808Z","caller":"traceutil/trace.go:171","msg":"trace[1597062917] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"192.429815ms","start":"2026-05-05T06:51:52.509315Z","end":"2026-05-05T06:51:52.701744Z","steps":["trace[1597062917] 'process raft request' (duration: 192.081986ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:51:52.702009Z","caller":"traceutil/trace.go:171","msg":"trace[1214582342] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"192.565288ms","start":"2026-05-05T06:51:52.50937Z","end":"2026-05-05T06:51:52.701935Z","steps":["trace[1214582342] 'process raft request' (duration: 192.312122ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:51:52.702227Z","caller":"traceutil/trace.go:171","msg":"trace[126556044] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"190.336236ms","start":"2026-05-05T06:51:52.511842Z","end":"2026-05-05T06:51:52.702178Z","steps":["trace[126556044] 'process raft request' (duration: 189.933996ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:51:52.702266Z","caller":"traceutil/trace.go:171","msg":"trace[647641633] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"186.767063ms","start":"2026-05-05T06:51:52.515465Z","end":"2026-05-05T06:51:52.702232Z","steps":["trace[647641633] 'process raft request' (duration: 186.421735ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:51:52.702345Z","caller":"traceutil/trace.go:171","msg":"trace[528785476] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"184.759206ms","start":"2026-05-05T06:51:52.517571Z","end":"2026-05-05T06:51:52.70233Z","steps":["trace[528785476] 'process raft request' (duration: 184.455709ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:51:52.702371Z","caller":"traceutil/trace.go:171","msg":"trace[1993135724] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"178.07344ms","start":"2026-05-05T06:51:52.524267Z","end":"2026-05-05T06:51:52.70234Z","steps":["trace[1993135724] 'process raft request' (duration: 177.935657ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:51:55.652087Z","caller":"traceutil/trace.go:171","msg":"trace[932002169] linearizableReadLoop","detail":"{readStateIndex:772; appliedIndex:771; }","duration":"270.048099ms","start":"2026-05-05T06:51:55.382009Z","end":"2026-05-05T06:51:55.652057Z","steps":["trace[932002169] 'read index received' (duration: 269.806364ms)","trace[932002169] 'applied index is now lower than readState.Index' (duration: 239.815µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:51:55.652161Z","caller":"traceutil/trace.go:171","msg":"trace[2073325193] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"272.032296ms","start":"2026-05-05T06:51:55.38008Z","end":"2026-05-05T06:51:55.652112Z","steps":["trace[2073325193] 'process raft request' (duration: 271.77585ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:51:55.652409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.782787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-05T06:51:55.652464Z","caller":"traceutil/trace.go:171","msg":"trace[364490344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:739; }","duration":"264.922771ms","start":"2026-05-05T06:51:55.387527Z","end":"2026-05-05T06:51:55.65245Z","steps":["trace[364490344] 'agreement among raft nodes before linearized reading' (duration: 264.723556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:51:55.652454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.408437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T06:51:55.652571Z","caller":"traceutil/trace.go:171","msg":"trace[1279997250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:739; }","duration":"270.583502ms","start":"2026-05-05T06:51:55.381959Z","end":"2026-05-05T06:51:55.652542Z","steps":["trace[1279997250] 'agreement among raft nodes before linearized reading' (duration: 270.238654ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:51:55.98084Z","caller":"traceutil/trace.go:171","msg":"trace[1577147476] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"323.593694ms","start":"2026-05-05T06:51:55.657203Z","end":"2026-05-05T06:51:55.980796Z","steps":["trace[1577147476] 'process raft request' (duration: 323.038901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:51:55.981213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:55.657144Z","time spent":"323.801278ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:51:55.989796Z","caller":"traceutil/trace.go:171","msg":"trace[1343505435] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"331.842176ms","start":"2026-05-05T06:51:55.657897Z","end":"2026-05-05T06:51:55.98974Z","steps":["trace[1343505435] 'process raft request' (duration: 331.614911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:51:55.990034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:55.657873Z","time spent":"332.04596ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:51:55.990367Z","caller":"traceutil/trace.go:171","msg":"trace[2008407491] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"276.356376ms","start":"2026-05-05T06:51:55.713978Z","end":"2026-05-05T06:51:55.990334Z","steps":["trace[2008407491] 'process raft request' (duration: 275.822063ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:51:59.017615Z","caller":"traceutil/trace.go:171","msg":"trace[1754002440] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"132.386538ms","start":"2026-05-05T06:51:58.885193Z","end":"2026-05-05T06:51:59.017579Z","steps":["trace[1754002440] 'process raft request' (duration: 131.61688ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:51:59.375414Z","caller":"traceutil/trace.go:171","msg":"trace[1471673413] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"426.403785ms","start":"2026-05-05T06:51:58.948978Z","end":"2026-05-05T06:51:59.375382Z","steps":["trace[1471673413] 'process raft request' (duration: 425.31549ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:51:59.375665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:58.948942Z","time spent":"426.6114ms","remote":"127.0.0.1:34862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:52:00.451683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.715497ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:52:00.45198Z","caller":"traceutil/trace.go:171","msg":"trace[1800379830] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"1.382011115s","start":"2026-05-05T06:51:59.069877Z","end":"2026-05-05T06:52:00.451888Z","steps":["trace[1800379830] 'process raft request' (duration: 688.648363ms)","trace[1800379830] 'compare' (duration: 692.547673ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:52:00.452472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.069845Z","time spent":"1.382467965s","remote":"127.0.0.1:35164","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-05-05T06:52:00.463369Z","caller":"traceutil/trace.go:171","msg":"trace[1956698108] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:795; }","duration":"1.258106893s","start":"2026-05-05T06:51:59.205242Z","end":"2026-05-05T06:52:00.463349Z","steps":["trace[1956698108] 'read index received' (duration: 169.122842ms)","trace[1956698108] 'applied index is now lower than readState.Index' (duration: 1.088982871s)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:52:00.463488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.258236876s","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-05T06:52:00.463515Z","caller":"traceutil/trace.go:171","msg":"trace[1299426491] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:764; }","duration":"1.258277127s","start":"2026-05-05T06:51:59.205231Z","end":"2026-05-05T06:52:00.463508Z","steps":["trace[1299426491] 'agreement among raft nodes before linearized reading' (duration: 1.258220286s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.463541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.205188Z","time spent":"1.258346548s","remote":"127.0.0.1:52750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T06:52:00.463713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.451526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.463776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.322844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.463833Z","caller":"traceutil/trace.go:171","msg":"trace[179516599] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:764; }","duration":"678.605069ms","start":"2026-05-05T06:51:59.785204Z","end":"2026-05-05T06:52:00.463809Z","steps":["trace[179516599] 'agreement among raft nodes before linearized reading' (duration: 678.402114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.463795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.258370289s","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":"warn","ts":"2026-05-05T06:52:00.463865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124890396s","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-05T06:52:00.463881Z","caller":"traceutil/trace.go:171","msg":"trace[1494419002] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:764; }","duration":"946.444557ms","start":"2026-05-05T06:51:59.517413Z","end":"2026-05-05T06:52:00.463858Z","steps":["trace[1494419002] 'agreement among raft nodes before linearized reading' (duration: 946.269273ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.463909Z","caller":"traceutil/trace.go:171","msg":"trace[1341989735] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:764; }","duration":"1.124953737s","start":"2026-05-05T06:51:59.338941Z","end":"2026-05-05T06:52:00.463895Z","steps":["trace[1341989735] 'agreement among raft nodes before linearized reading' (duration: 1.124889735s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.463884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.785195Z","time spent":"678.67903ms","remote":"127.0.0.1:52888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-05T06:52:00.463935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.338928Z","time spent":"1.125001378s","remote":"127.0.0.1:52760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.463946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.517379Z","time spent":"946.551189ms","remote":"127.0.0.1:52824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.463894Z","caller":"traceutil/trace.go:171","msg":"trace[1900368369] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:764; }","duration":"1.258530363s","start":"2026-05-05T06:51:59.205341Z","end":"2026-05-05T06:52:00.463871Z","steps":["trace[1900368369] 'agreement among raft nodes before linearized reading' (duration: 1.258238106s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.205314Z","time spent":"1.258682476s","remote":"127.0.0.1:52750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.464035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124986688s","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":"warn","ts":"2026-05-05T06:52:00.464047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.195016056s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.46412Z","caller":"traceutil/trace.go:171","msg":"trace[1157996280] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:764; }","duration":"1.125109391s","start":"2026-05-05T06:51:59.33899Z","end":"2026-05-05T06:52:00.464099Z","steps":["trace[1157996280] 'agreement among raft nodes before linearized reading' (duration: 1.124822614s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042368477s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.152007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.014519379s","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-05T06:52:00.464159Z","caller":"traceutil/trace.go:171","msg":"trace[974032045] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:764; }","duration":"1.042411288s","start":"2026-05-05T06:51:59.42174Z","end":"2026-05-05T06:52:00.464152Z","steps":["trace[974032045] 'agreement among raft nodes before linearized reading' (duration: 1.042361837s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.288859ms","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-05-05T06:52:00.464165Z","caller":"traceutil/trace.go:171","msg":"trace[1574845117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:764; }","duration":"1.19516905s","start":"2026-05-05T06:51:59.268954Z","end":"2026-05-05T06:52:00.464123Z","steps":["trace[1574845117] 'agreement among raft nodes before linearized reading' (duration: 1.194989556s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.421734Z","time spent":"1.042441658s","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-05T06:52:00.464145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.056408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-05T06:52:00.464169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.338983Z","time spent":"1.125176672s","remote":"127.0.0.1:52760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T06:52:00.464216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.268933Z","time spent":"1.195272532s","remote":"127.0.0.1:34674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T06:52:00.464233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.369102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.273517ms","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-05T06:52:00.464263Z","caller":"traceutil/trace.go:171","msg":"trace[1062744927] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:764; }","duration":"545.411872ms","start":"2026-05-05T06:51:59.918845Z","end":"2026-05-05T06:52:00.464257Z","steps":["trace[1062744927] 'agreement among raft nodes before linearized reading' (duration: 545.373181ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042488109s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.918836Z","time spent":"545.451573ms","remote":"127.0.0.1:52924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T06:52:00.464317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.125577ms","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":"warn","ts":"2026-05-05T06:52:00.464323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.325868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T06:52:00.464336Z","caller":"traceutil/trace.go:171","msg":"trace[968445768] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:764; }","duration":"970.173268ms","start":"2026-05-05T06:51:59.494158Z","end":"2026-05-05T06:52:00.464331Z","steps":["trace[968445768] 'agreement among raft nodes before linearized reading' (duration: 970.141107ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.464359Z","caller":"traceutil/trace.go:171","msg":"trace[800193902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:764; }","duration":"452.413559ms","start":"2026-05-05T06:52:00.011936Z","end":"2026-05-05T06:52:00.464349Z","steps":["trace[800193902] 'agreement among raft nodes before linearized reading' (duration: 452.264916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.51861ms","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-05T06:52:00.464352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.234372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.494143Z","time spent":"970.2194ms","remote":"127.0.0.1:52810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-05T06:52:00.464389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.440657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.039081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.464417Z","caller":"traceutil/trace.go:171","msg":"trace[936600240] 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:764; }","duration":"728.617652ms","start":"2026-05-05T06:51:59.735788Z","end":"2026-05-05T06:52:00.464405Z","steps":["trace[936600240] 'agreement among raft nodes before linearized reading' (duration: 728.55579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042821377s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.464449Z","caller":"traceutil/trace.go:171","msg":"trace[79531578] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:764; }","duration":"237.112533ms","start":"2026-05-05T06:52:00.227324Z","end":"2026-05-05T06:52:00.464437Z","steps":["trace[79531578] 'agreement among raft nodes before linearized reading' (duration: 237.052102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.735762Z","time spent":"728.682634ms","remote":"127.0.0.1:52880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.464476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.81098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.864111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.125465ms","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-05T06:52:00.464528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.04542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.375624ms","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":"warn","ts":"2026-05-05T06:52:00.464543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.415541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.218255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.464566Z","caller":"traceutil/trace.go:171","msg":"trace[555019533] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:764; }","duration":"598.426264ms","start":"2026-05-05T06:51:59.866132Z","end":"2026-05-05T06:52:00.464558Z","steps":["trace[555019533] 'agreement among raft nodes before linearized reading' (duration: 598.392653ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.46457Z","caller":"traceutil/trace.go:171","msg":"trace[1861228043] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:764; }","duration":"212.248865ms","start":"2026-05-05T06:52:00.252316Z","end":"2026-05-05T06:52:00.464564Z","steps":["trace[1861228043] 'agreement among raft nodes before linearized reading' (duration: 212.214475ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.464569Z","caller":"traceutil/trace.go:171","msg":"trace[663403728] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:764; }","duration":"175.097231ms","start":"2026-05-05T06:52:00.289457Z","end":"2026-05-05T06:52:00.464554Z","steps":["trace[663403728] 'agreement among raft nodes before linearized reading' (duration: 175.04574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.917902ms","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":"warn","ts":"2026-05-05T06:52:00.464605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.008329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.464625Z","caller":"traceutil/trace.go:171","msg":"trace[1852295269] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:764; }","duration":"175.072921ms","start":"2026-05-05T06:52:00.289546Z","end":"2026-05-05T06:52:00.464619Z","steps":["trace[1852295269] 'agreement among raft nodes before linearized reading' (duration: 175.04197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.682399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.012025ms","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-05T06:52:00.464676Z","caller":"traceutil/trace.go:171","msg":"trace[1159549511] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:764; }","duration":"527.72083ms","start":"2026-05-05T06:51:59.93695Z","end":"2026-05-05T06:52:00.464671Z","steps":["trace[1159549511] 'agreement among raft nodes before linearized reading' (duration: 527.688559ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.535237ms","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-05T06:52:00.464702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.93694Z","time spent":"527.756461ms","remote":"127.0.0.1:52926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T06:52:00.464626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.485865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.410502ms","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":"warn","ts":"2026-05-05T06:52:00.46473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.634274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.094143001s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.100657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.065906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.464814Z","caller":"traceutil/trace.go:171","msg":"trace[1523468908] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:764; }","duration":"1.094216933s","start":"2026-05-05T06:51:59.370585Z","end":"2026-05-05T06:52:00.464802Z","steps":["trace[1523468908] 'agreement among raft nodes before linearized reading' (duration: 1.094140231s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.0149536s","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-05T06:52:00.464869Z","caller":"traceutil/trace.go:171","msg":"trace[1946829173] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:764; }","duration":"1.01497972s","start":"2026-05-05T06:51:59.449884Z","end":"2026-05-05T06:52:00.464863Z","steps":["trace[1946829173] 'agreement among raft nodes before linearized reading' (duration: 1.01494592s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.674759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.370573Z","time spent":"1.094276594s","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.464221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.352046ms","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-05-05T06:52:00.46708Z","caller":"traceutil/trace.go:171","msg":"trace[1239724132] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:764; }","duration":"682.226623ms","start":"2026-05-05T06:51:59.784841Z","end":"2026-05-05T06:52:00.467068Z","steps":["trace[1239724132] 'agreement among raft nodes before linearized reading' (duration: 679.346486ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.467126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.784834Z","time spent":"682.276104ms","remote":"127.0.0.1:52888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.464203Z","caller":"traceutil/trace.go:171","msg":"trace[851876999] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:764; }","duration":"545.339321ms","start":"2026-05-05T06:51:59.918854Z","end":"2026-05-05T06:52:00.464194Z","steps":["trace[851876999] 'agreement among raft nodes before linearized reading' (duration: 545.30148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.46721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.91884Z","time spent":"548.34971ms","remote":"127.0.0.1:52924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-05T06:52:00.46436Z","caller":"traceutil/trace.go:171","msg":"trace[462148839] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:764; }","duration":"1.042695505s","start":"2026-05-05T06:51:59.421623Z","end":"2026-05-05T06:52:00.464319Z","steps":["trace[462148839] 'agreement among raft nodes before linearized reading' (duration: 1.042389378s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.46732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.421619Z","time spent":"1.045681054s","remote":"127.0.0.1:52782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.464442Z","caller":"traceutil/trace.go:171","msg":"trace[269833194] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:764; }","duration":"236.55823ms","start":"2026-05-05T06:52:00.227867Z","end":"2026-05-05T06:52:00.464425Z","steps":["trace[269833194] 'agreement among raft nodes before linearized reading' (duration: 236.467438ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.4648Z","caller":"traceutil/trace.go:171","msg":"trace[97924785] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:764; }","duration":"212.719826ms","start":"2026-05-05T06:52:00.252072Z","end":"2026-05-05T06:52:00.464791Z","steps":["trace[97924785] 'agreement among raft nodes before linearized reading' (duration: 212.630344ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.464843Z","caller":"traceutil/trace.go:171","msg":"trace[1031360133] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:764; }","duration":"401.117197ms","start":"2026-05-05T06:52:00.063716Z","end":"2026-05-05T06:52:00.464833Z","steps":["trace[1031360133] 'agreement among raft nodes before linearized reading' (duration: 401.067735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.467568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:00.063687Z","time spent":"403.864751ms","remote":"127.0.0.1:52952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.464281Z","caller":"traceutil/trace.go:171","msg":"trace[1324764096] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:764; }","duration":"969.311599ms","start":"2026-05-05T06:51:59.49496Z","end":"2026-05-05T06:52:00.464272Z","steps":["trace[1324764096] 'agreement among raft nodes before linearized reading' (duration: 969.268948ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.464836Z","caller":"traceutil/trace.go:171","msg":"trace[232486051] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:764; }","duration":"429.171019ms","start":"2026-05-05T06:52:00.035651Z","end":"2026-05-05T06:52:00.464822Z","steps":["trace[232486051] 'agreement among raft nodes before linearized reading' (duration: 429.092748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.467772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:00.035643Z","time spent":"432.113018ms","remote":"127.0.0.1:52948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-05-05T06:52:00.464638Z","caller":"traceutil/trace.go:171","msg":"trace[692675837] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:764; }","duration":"400.975704ms","start":"2026-05-05T06:52:00.063642Z","end":"2026-05-05T06:52:00.464617Z","steps":["trace[692675837] 'agreement among raft nodes before linearized reading' (duration: 400.893862ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.464678Z","caller":"traceutil/trace.go:171","msg":"trace[546560922] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:764; }","duration":"635.044176ms","start":"2026-05-05T06:51:59.829628Z","end":"2026-05-05T06:52:00.464672Z","steps":["trace[546560922] 'agreement among raft nodes before linearized reading' (duration: 635.011185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.468003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.829621Z","time spent":"638.371163ms","remote":"127.0.0.1:52896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.464594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.866121Z","time spent":"598.467365ms","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.464323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.221103ms","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-05T06:52:00.468145Z","caller":"traceutil/trace.go:171","msg":"trace[705804223] 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:764; }","duration":"732.053901ms","start":"2026-05-05T06:51:59.736079Z","end":"2026-05-05T06:52:00.468133Z","steps":["trace[705804223] 'agreement among raft nodes before linearized reading' (duration: 728.223582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.467707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.494952Z","time spent":"972.665246ms","remote":"127.0.0.1:52810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-05-05T06:52:00.464755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.108124ms","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":"warn","ts":"2026-05-05T06:52:00.468194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.73607Z","time spent":"732.105912ms","remote":"127.0.0.1:52880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"info","ts":"2026-05-05T06:52:00.468226Z","caller":"traceutil/trace.go:171","msg":"trace[1667207740] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:764; }","duration":"403.590234ms","start":"2026-05-05T06:52:00.064621Z","end":"2026-05-05T06:52:00.468212Z","steps":["trace[1667207740] 'agreement among raft nodes before linearized reading' (duration: 400.107003ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.468275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:00.06461Z","time spent":"403.650606ms","remote":"127.0.0.1:52952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"info","ts":"2026-05-05T06:52:00.464536Z","caller":"traceutil/trace.go:171","msg":"trace[1795157752] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:764; }","duration":"465.162176ms","start":"2026-05-05T06:51:59.999368Z","end":"2026-05-05T06:52:00.46453Z","steps":["trace[1795157752] 'agreement among raft nodes before linearized reading' (duration: 465.129465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.468341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.999359Z","time spent":"468.966305ms","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.46451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.193989ms","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-05T06:52:00.468469Z","caller":"traceutil/trace.go:171","msg":"trace[2108380350] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:764; }","duration":"602.11459ms","start":"2026-05-05T06:51:59.866269Z","end":"2026-05-05T06:52:00.468383Z","steps":["trace[2108380350] 'agreement among raft nodes before linearized reading' (duration: 598.22509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.490043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.468533Z","caller":"traceutil/trace.go:171","msg":"trace[1973777530] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:764; }","duration":"601.550017ms","start":"2026-05-05T06:51:59.866974Z","end":"2026-05-05T06:52:00.468524Z","steps":["trace[1973777530] 'agreement among raft nodes before linearized reading' (duration: 597.471563ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.464181Z","caller":"traceutil/trace.go:171","msg":"trace[46442786] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:764; }","duration":"527.225409ms","start":"2026-05-05T06:51:59.936939Z","end":"2026-05-05T06:52:00.464165Z","steps":["trace[46442786] 'agreement among raft nodes before linearized reading' (duration: 527.105836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.468569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.866941Z","time spent":"601.618988ms","remote":"127.0.0.1:52896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-05-05T06:52:00.468578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.936917Z","time spent":"531.650191ms","remote":"127.0.0.1:52926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-05T06:52:00.464202Z","caller":"traceutil/trace.go:171","msg":"trace[735484652] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:764; }","duration":"1.014776285s","start":"2026-05-05T06:51:59.449398Z","end":"2026-05-05T06:52:00.464175Z","steps":["trace[735484652] 'agreement among raft nodes before linearized reading' (duration: 1.014383936s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.468676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.449376Z","time spent":"1.019284871s","remote":"127.0.0.1:52788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.464212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124312912s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.468723Z","caller":"traceutil/trace.go:171","msg":"trace[1725415947] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:764; }","duration":"1.128865618s","start":"2026-05-05T06:51:59.339851Z","end":"2026-05-05T06:52:00.468716Z","steps":["trace[1725415947] 'agreement among raft nodes before linearized reading' (duration: 1.124341903s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.468758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.339828Z","time spent":"1.12891765s","remote":"127.0.0.1:52750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-05T06:52:00.464278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.576992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.468524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.866241Z","time spent":"602.268254ms","remote":"127.0.0.1:52908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.468845Z","caller":"traceutil/trace.go:171","msg":"trace[1221224914] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:764; }","duration":"684.189719ms","start":"2026-05-05T06:51:59.784648Z","end":"2026-05-05T06:52:00.468838Z","steps":["trace[1221224914] 'agreement among raft nodes before linearized reading' (duration: 679.606992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.468868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.784624Z","time spent":"684.236609ms","remote":"127.0.0.1:52888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-05T06:52:00.464267Z","caller":"traceutil/trace.go:171","msg":"trace[1274994970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:764; }","duration":"445.204252ms","start":"2026-05-05T06:52:00.019038Z","end":"2026-05-05T06:52:00.464242Z","steps":["trace[1274994970] 'agreement among raft nodes before linearized reading' (duration: 444.845084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.468977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:00.018974Z","time spent":"449.996973ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-05T06:52:00.464387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:00.011903Z","time spent":"452.478831ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T06:52:00.46442Z","caller":"traceutil/trace.go:171","msg":"trace[1178541010] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:764; }","duration":"174.323474ms","start":"2026-05-05T06:52:00.290089Z","end":"2026-05-05T06:52:00.464413Z","steps":["trace[1178541010] 'agreement among raft nodes before linearized reading' (duration: 174.219401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.529391ms","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-05-05T06:52:00.469549Z","caller":"traceutil/trace.go:171","msg":"trace[60974741] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:764; }","duration":"549.945458ms","start":"2026-05-05T06:51:59.91959Z","end":"2026-05-05T06:52:00.469535Z","steps":["trace[60974741] 'agreement among raft nodes before linearized reading' (duration: 544.524582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.46445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.813795ms","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-05T06:52:00.469676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.919584Z","time spent":"550.075801ms","remote":"127.0.0.1:52924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-05-05T06:52:00.469699Z","caller":"traceutil/trace.go:171","msg":"trace[1362475319] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:764; }","duration":"469.054526ms","start":"2026-05-05T06:52:00.000618Z","end":"2026-05-05T06:52:00.469673Z","steps":["trace[1362475319] 'agreement among raft nodes before linearized reading' (duration: 463.815904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.46448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.944941ms","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":"warn","ts":"2026-05-05T06:52:00.469758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:00.000614Z","time spent":"469.128378ms","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"info","ts":"2026-05-05T06:52:00.469761Z","caller":"traceutil/trace.go:171","msg":"trace[230277097] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:764; }","duration":"470.226394ms","start":"2026-05-05T06:51:59.99952Z","end":"2026-05-05T06:52:00.469747Z","steps":["trace[230277097] 'agreement among raft nodes before linearized reading' (duration: 464.946541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.469853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.999516Z","time spent":"470.322406ms","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.464477Z","caller":"traceutil/trace.go:171","msg":"trace[167761151] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:764; }","duration":"1.042918649s","start":"2026-05-05T06:51:59.421549Z","end":"2026-05-05T06:52:00.464468Z","steps":["trace[167761151] 'agreement among raft nodes before linearized reading' (duration: 1.042855008s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.469904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.421523Z","time spent":"1.048364656s","remote":"127.0.0.1:52782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-05T06:52:00.464511Z","caller":"traceutil/trace.go:171","msg":"trace[1848495800] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:764; }","duration":"194.857201ms","start":"2026-05-05T06:52:00.269643Z","end":"2026-05-05T06:52:00.4645Z","steps":["trace[1848495800] 'agreement among raft nodes before linearized reading' (duration: 194.81013ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.464514Z","caller":"traceutil/trace.go:171","msg":"trace[1885554977] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:764; }","duration":"194.929703ms","start":"2026-05-05T06:52:00.269578Z","end":"2026-05-05T06:52:00.464508Z","steps":["trace[1885554977] 'agreement among raft nodes before linearized reading' (duration: 194.887342ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.464567Z","caller":"traceutil/trace.go:171","msg":"trace[905270832] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:764; }","duration":"194.438891ms","start":"2026-05-05T06:52:00.270122Z","end":"2026-05-05T06:52:00.464561Z","steps":["trace[905270832] 'agreement among raft nodes before linearized reading' (duration: 194.405211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.493215ms","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-05T06:52:00.470092Z","caller":"traceutil/trace.go:171","msg":"trace[2104587632] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:764; }","duration":"498.995723ms","start":"2026-05-05T06:51:59.971084Z","end":"2026-05-05T06:52:00.47008Z","steps":["trace[2104587632] 'agreement among raft nodes before linearized reading' (duration: 493.497665ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.470139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.971075Z","time spent":"499.045264ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.464625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.637677ms","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-05T06:52:00.47021Z","caller":"traceutil/trace.go:171","msg":"trace[309260339] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:764; }","duration":"640.219846ms","start":"2026-05-05T06:51:59.829971Z","end":"2026-05-05T06:52:00.470191Z","steps":["trace[309260339] 'agreement among raft nodes before linearized reading' (duration: 634.636586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.470281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.829966Z","time spent":"640.298868ms","remote":"127.0.0.1:52896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-05T06:52:00.464696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093204619s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.470346Z","caller":"traceutil/trace.go:171","msg":"trace[37890422] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:764; }","duration":"1.09972194s","start":"2026-05-05T06:51:59.370596Z","end":"2026-05-05T06:52:00.470318Z","steps":["trace[37890422] 'agreement among raft nodes before linearized reading' (duration: 1.093191558s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.360279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.470422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.370582Z","time spent":"1.099825233s","remote":"127.0.0.1:52774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.470431Z","caller":"traceutil/trace.go:171","msg":"trace[1082758327] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:764; }","duration":"243.112632ms","start":"2026-05-05T06:52:00.227303Z","end":"2026-05-05T06:52:00.470416Z","steps":["trace[1082758327] 'agreement among raft nodes before linearized reading' (duration: 237.365949ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.464712Z","caller":"traceutil/trace.go:171","msg":"trace[1936707582] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:764; }","duration":"970.621869ms","start":"2026-05-05T06:51:59.494083Z","end":"2026-05-05T06:52:00.464705Z","steps":["trace[1936707582] 'agreement among raft nodes before linearized reading' (duration: 970.531467ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.920632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.470804Z","caller":"traceutil/trace.go:171","msg":"trace[19116916] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:764; }","duration":"993.973022ms","start":"2026-05-05T06:51:59.476815Z","end":"2026-05-05T06:52:00.470788Z","steps":["trace[19116916] 'agreement among raft nodes before linearized reading' (duration: 987.915231ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.468141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:00.063487Z","time spent":"404.344912ms","remote":"127.0.0.1:52952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.464771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.577496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.470859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.47681Z","time spent":"994.032343ms","remote":"127.0.0.1:52802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"info","ts":"2026-05-05T06:52:00.470875Z","caller":"traceutil/trace.go:171","msg":"trace[605999791] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:764; }","duration":"834.686918ms","start":"2026-05-05T06:51:59.636172Z","end":"2026-05-05T06:52:00.470859Z","steps":["trace[605999791] 'agreement among raft nodes before linearized reading' (duration: 828.566835ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.471034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.636164Z","time spent":"834.859562ms","remote":"127.0.0.1:52834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-05T06:52:00.470697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.494073Z","time spent":"976.545756ms","remote":"127.0.0.1:52810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.464782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.613167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:00.471171Z","caller":"traceutil/trace.go:171","msg":"trace[1610795104] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:764; }","duration":"995.011506ms","start":"2026-05-05T06:51:59.47615Z","end":"2026-05-05T06:52:00.471162Z","steps":["trace[1610795104] 'agreement among raft nodes before linearized reading' (duration: 988.613807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.862696ms","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":"warn","ts":"2026-05-05T06:52:00.471212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.476146Z","time spent":"995.049407ms","remote":"127.0.0.1:52802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.471212Z","caller":"traceutil/trace.go:171","msg":"trace[85505436] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:764; }","duration":"753.265825ms","start":"2026-05-05T06:51:59.717933Z","end":"2026-05-05T06:52:00.471199Z","steps":["trace[85505436] 'agreement among raft nodes before linearized reading' (duration: 746.859306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.46485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.750187ms","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-05T06:52:00.46486Z","caller":"traceutil/trace.go:171","msg":"trace[794091374] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:764; }","duration":"493.658969ms","start":"2026-05-05T06:51:59.971133Z","end":"2026-05-05T06:52:00.464792Z","steps":["trace[794091374] 'agreement among raft nodes before linearized reading' (duration: 493.417673ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.943961ms","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-05T06:52:00.464916Z","caller":"traceutil/trace.go:171","msg":"trace[1990999977] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:764; }","duration":"988.779581ms","start":"2026-05-05T06:51:59.476119Z","end":"2026-05-05T06:52:00.464898Z","steps":["trace[1990999977] 'agreement among raft nodes before linearized reading' (duration: 988.679569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.464914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.780813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.449865Z","time spent":"1.015023321s","remote":"127.0.0.1:52788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-05-05T06:52:00.464963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.873197ms","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":"warn","ts":"2026-05-05T06:52:00.464969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.875526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015487262s","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":"warn","ts":"2026-05-05T06:52:00.464985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.697744ms","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":"warn","ts":"2026-05-05T06:52:00.465017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.699472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.350125ms","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-05-05T06:52:00.465024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.935828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.465058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.634111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.465076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.424488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-05T06:52:00.465274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.763007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T06:52:00.464656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.812396ms","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-05T06:52:00.464778Z","caller":"traceutil/trace.go:171","msg":"trace[170991220] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:764; }","duration":"527.651909ms","start":"2026-05-05T06:51:59.937117Z","end":"2026-05-05T06:52:00.464769Z","steps":["trace[170991220] 'agreement among raft nodes before linearized reading' (duration: 527.494695ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.471291Z","caller":"traceutil/trace.go:171","msg":"trace[701120907] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:764; }","duration":"754.227607ms","start":"2026-05-05T06:51:59.717049Z","end":"2026-05-05T06:52:00.471276Z","steps":["trace[701120907] 'agreement among raft nodes before linearized reading' (duration: 747.782768ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.471311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.476106Z","time spent":"995.19043ms","remote":"127.0.0.1:52802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"info","ts":"2026-05-05T06:52:00.471321Z","caller":"traceutil/trace.go:171","msg":"trace[479274051] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:764; }","duration":"778.092412ms","start":"2026-05-05T06:51:59.693218Z","end":"2026-05-05T06:52:00.471311Z","steps":["trace[479274051] 'agreement among raft nodes before linearized reading' (duration: 771.716064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.471332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.717926Z","time spent":"753.391287ms","remote":"127.0.0.1:52864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-05T06:52:00.471351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.717017Z","time spent":"754.320239ms","remote":"127.0.0.1:52864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.471364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.693179Z","time spent":"778.173754ms","remote":"127.0.0.1:52850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"info","ts":"2026-05-05T06:52:00.47137Z","caller":"traceutil/trace.go:171","msg":"trace[282334985] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:764; }","duration":"436.278244ms","start":"2026-05-05T06:52:00.035075Z","end":"2026-05-05T06:52:00.471353Z","steps":["trace[282334985] 'agreement among raft nodes before linearized reading' (duration: 429.787243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.471403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:00.03506Z","time spent":"436.328695ms","remote":"127.0.0.1:52948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.471423Z","caller":"traceutil/trace.go:171","msg":"trace[1416208769] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:764; }","duration":"436.355046ms","start":"2026-05-05T06:52:00.035058Z","end":"2026-05-05T06:52:00.471413Z","steps":["trace[1416208769] 'agreement among raft nodes before linearized reading' (duration: 429.883065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.471423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.971117Z","time spent":"500.293653ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.471438Z","caller":"traceutil/trace.go:171","msg":"trace[366654999] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:764; }","duration":"805.806266ms","start":"2026-05-05T06:51:59.665622Z","end":"2026-05-05T06:52:00.471428Z","steps":["trace[366654999] 'agreement among raft nodes before linearized reading' (duration: 799.320705ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.471464Z","caller":"traceutil/trace.go:171","msg":"trace[1849724409] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:764; }","duration":"1.022003814s","start":"2026-05-05T06:51:59.449453Z","end":"2026-05-05T06:52:00.471457Z","steps":["trace[1849724409] 'agreement among raft nodes before linearized reading' (duration: 1.015492052s)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.471468Z","caller":"traceutil/trace.go:171","msg":"trace[589400940] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:764; }","duration":"778.42489ms","start":"2026-05-05T06:51:59.693037Z","end":"2026-05-05T06:52:00.471462Z","steps":["trace[589400940] 'agreement among raft nodes before linearized reading' (duration: 771.898908ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.471457Z","caller":"traceutil/trace.go:171","msg":"trace[989142483] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:764; }","duration":"777.818486ms","start":"2026-05-05T06:51:59.693616Z","end":"2026-05-05T06:52:00.471435Z","steps":["trace[989142483] 'agreement among raft nodes before linearized reading' (duration: 771.321675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.47149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.449434Z","time spent":"1.022048654s","remote":"127.0.0.1:52788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-05-05T06:52:00.47149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.693008Z","time spent":"778.475611ms","remote":"127.0.0.1:52850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.471509Z","caller":"traceutil/trace.go:171","msg":"trace[955997564] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:764; }","duration":"953.412808ms","start":"2026-05-05T06:51:59.518082Z","end":"2026-05-05T06:52:00.471495Z","steps":["trace[955997564] 'agreement among raft nodes before linearized reading' (duration: 946.918518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.471534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.937106Z","time spent":"534.419606ms","remote":"127.0.0.1:52926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-05T06:52:00.471541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.69361Z","time spent":"777.899218ms","remote":"127.0.0.1:52850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-05-05T06:52:00.471478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.665611Z","time spent":"805.856568ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-05T06:52:00.471564Z","caller":"traceutil/trace.go:171","msg":"trace[1335367946] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:764; }","duration":"836.161512ms","start":"2026-05-05T06:51:59.635395Z","end":"2026-05-05T06:52:00.471556Z","steps":["trace[1335367946] 'agreement among raft nodes before linearized reading' (duration: 829.64031ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:00.471563Z","caller":"traceutil/trace.go:171","msg":"trace[1331090723] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:764; }","duration":"836.288735ms","start":"2026-05-05T06:51:59.635266Z","end":"2026-05-05T06:52:00.471555Z","steps":["trace[1331090723] 'agreement among raft nodes before linearized reading' (duration: 829.723302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.471587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.635382Z","time spent":"836.197612ms","remote":"127.0.0.1:52834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T06:52:00.471599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.635239Z","time spent":"836.346377ms","remote":"127.0.0.1:52834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.471539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.518058Z","time spent":"953.47326ms","remote":"127.0.0.1:52824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-05-05T06:52:00.471509Z","caller":"traceutil/trace.go:171","msg":"trace[1383906775] 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:764; }","duration":"735.693947ms","start":"2026-05-05T06:51:59.735807Z","end":"2026-05-05T06:52:00.471501Z","steps":["trace[1383906775] 'agreement among raft nodes before linearized reading' (duration: 728.812267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.471448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:00.035045Z","time spent":"436.394647ms","remote":"127.0.0.1:52948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-05T06:52:00.471483Z","caller":"traceutil/trace.go:171","msg":"trace[1814001206] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:764; }","duration":"953.996752ms","start":"2026-05-05T06:51:59.51747Z","end":"2026-05-05T06:52:00.471467Z","steps":["trace[1814001206] 'agreement among raft nodes before linearized reading' (duration: 947.495141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.47181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.51743Z","time spent":"954.369731ms","remote":"127.0.0.1:52824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T06:52:00.471702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.735796Z","time spent":"735.875021ms","remote":"127.0.0.1:52880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:00.471482Z","caller":"traceutil/trace.go:171","msg":"trace[521627272] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:764; }","duration":"754.517624ms","start":"2026-05-05T06:51:59.716952Z","end":"2026-05-05T06:52:00.47147Z","steps":["trace[521627272] 'agreement among raft nodes before linearized reading' (duration: 747.941691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:00.472201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:51:59.716946Z","time spent":"755.243901ms","remote":"127.0.0.1:52864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:14.786451Z","caller":"traceutil/trace.go:171","msg":"trace[2043379474] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"235.162309ms","start":"2026-05-05T06:52:14.55125Z","end":"2026-05-05T06:52:14.786413Z","steps":["trace[2043379474] 'process raft request' (duration: 234.948554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:15.210269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.220892ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:52:15.210429Z","caller":"traceutil/trace.go:171","msg":"trace[340878377] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:925; }","duration":"260.401296ms","start":"2026-05-05T06:52:14.95Z","end":"2026-05-05T06:52:15.210401Z","steps":["trace[340878377] 'range keys from in-memory index tree' (duration: 260.198551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:15.210768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.507854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:52:15.211084Z","caller":"traceutil/trace.go:171","msg":"trace[958617979] linearizableReadLoop","detail":"{readStateIndex:966; appliedIndex:962; }","duration":"577.719964ms","start":"2026-05-05T06:52:14.633335Z","end":"2026-05-05T06:52:15.211055Z","steps":["trace[958617979] 'read index received' (duration: 152.891878ms)","trace[958617979] 'applied index is now lower than readState.Index' (duration: 424.826846ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:52:15.211068Z","caller":"traceutil/trace.go:171","msg":"trace[1863176278] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"659.417491ms","start":"2026-05-05T06:52:14.551609Z","end":"2026-05-05T06:52:15.211026Z","steps":["trace[1863176278] 'process raft request' (duration: 516.517108ms)","trace[1863176278] 'compare' (duration: 142.290238ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:52:15.211157Z","caller":"traceutil/trace.go:171","msg":"trace[1765124357] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"606.936498ms","start":"2026-05-05T06:52:14.604213Z","end":"2026-05-05T06:52:15.21115Z","steps":["trace[1765124357] 'process raft request' (duration: 606.787435ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:15.2111Z","caller":"traceutil/trace.go:171","msg":"trace[370376334] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"659.31765ms","start":"2026-05-05T06:52:14.551757Z","end":"2026-05-05T06:52:15.211075Z","steps":["trace[370376334] 'process raft request' (duration: 659.179406ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:15.211264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:14.604181Z","time spent":"607.00409ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:52:15.211264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:14.551582Z","time spent":"659.575756ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:52:15.211275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T06:52:15.211336Z","caller":"traceutil/trace.go:171","msg":"trace[1439735812] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:928; }","duration":"578.124284ms","start":"2026-05-05T06:52:14.633198Z","end":"2026-05-05T06:52:15.211323Z","steps":["trace[1439735812] 'agreement among raft nodes before linearized reading' (duration: 577.96381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:15.211334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:14.551735Z","time spent":"659.554815ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:52:15.211378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:14.63309Z","time spent":"578.273498ms","remote":"127.0.0.1:35180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":94,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:52:15.21287Z","caller":"traceutil/trace.go:171","msg":"trace[1066169879] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"223.692029ms","start":"2026-05-05T06:52:14.989159Z","end":"2026-05-05T06:52:15.212851Z","steps":["trace[1066169879] 'process raft request' (duration: 223.522335ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:15.212932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.671689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T06:52:15.212961Z","caller":"traceutil/trace.go:171","msg":"trace[835497942] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:929; }","duration":"376.75577ms","start":"2026-05-05T06:52:14.836197Z","end":"2026-05-05T06:52:15.212953Z","steps":["trace[835497942] 'agreement among raft nodes before linearized reading' (duration: 376.610967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:15.212979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:14.836176Z","time spent":"376.798612ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-05T06:53:29.370303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.049794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18ac98d8346c1bcd\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-05-05T06:53:29.370466Z","caller":"traceutil/trace.go:171","msg":"trace[519965585] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18ac98d8346c1bcd; range_end:; response_count:1; response_revision:1982; }","duration":"495.270599ms","start":"2026-05-05T06:53:28.87517Z","end":"2026-05-05T06:53:29.370441Z","steps":["trace[519965585] 'range keys from in-memory index tree' (duration: 494.87605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:53:29.370526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:53:28.875148Z","time spent":"495.366131ms","remote":"127.0.0.1:34758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1005,"request content":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18ac98d8346c1bcd\" "} {"level":"info","ts":"2026-05-05T06:53:29.404967Z","caller":"traceutil/trace.go:171","msg":"trace[1519023816] linearizableReadLoop","detail":"{readStateIndex:2063; appliedIndex:2062; }","duration":"135.659472ms","start":"2026-05-05T06:53:29.269278Z","end":"2026-05-05T06:53:29.404937Z","steps":["trace[1519023816] 'read index received' (duration: 135.482128ms)","trace[1519023816] 'applied index is now lower than readState.Index' (duration: 176.044µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:53:29.405015Z","caller":"traceutil/trace.go:171","msg":"trace[771497339] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"232.513574ms","start":"2026-05-05T06:53:29.172465Z","end":"2026-05-05T06:53:29.404979Z","steps":["trace[771497339] 'process raft request' (duration: 232.282609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:53:29.405188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.862847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:53:29.405234Z","caller":"traceutil/trace.go:171","msg":"trace[1849767324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1983; }","duration":"136.017321ms","start":"2026-05-05T06:53:29.269205Z","end":"2026-05-05T06:53:29.405222Z","steps":["trace[1849767324] 'agreement among raft nodes before linearized reading' (duration: 135.892038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:53:29.464435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.392244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T06:53:29.464523Z","caller":"traceutil/trace.go:171","msg":"trace[1670035395] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1985; }","duration":"186.507757ms","start":"2026-05-05T06:53:29.277994Z","end":"2026-05-05T06:53:29.464502Z","steps":["trace[1670035395] 'agreement among raft nodes before linearized reading' (duration: 186.315892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:53:29.464436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.74815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-95fe34a6-34cc-4923-8f94-58db4af4d1e9\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-05T06:53:29.464632Z","caller":"traceutil/trace.go:171","msg":"trace[844382941] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-95fe34a6-34cc-4923-8f94-58db4af4d1e9; range_end:; response_count:1; response_revision:1985; }","duration":"162.003227ms","start":"2026-05-05T06:53:29.302605Z","end":"2026-05-05T06:53:29.464608Z","steps":["trace[844382941] 'agreement among raft nodes before linearized reading' (duration: 161.70333ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:53:29.597822Z","caller":"traceutil/trace.go:171","msg":"trace[882300245] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"125.732549ms","start":"2026-05-05T06:53:29.472054Z","end":"2026-05-05T06:53:29.597787Z","steps":["trace[882300245] 'process raft request' (duration: 125.466262ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:53:29.872716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.42476ms","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-05-05T06:53:29.872822Z","caller":"traceutil/trace.go:171","msg":"trace[349899006] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1987; }","duration":"185.569614ms","start":"2026-05-05T06:53:29.68722Z","end":"2026-05-05T06:53:29.872789Z","steps":["trace[349899006] 'range keys from in-memory index tree' (duration: 185.263007ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:53:29.970684Z","caller":"traceutil/trace.go:171","msg":"trace[457652522] linearizableReadLoop","detail":"{readStateIndex:2069; appliedIndex:2068; }","duration":"242.779145ms","start":"2026-05-05T06:53:29.727871Z","end":"2026-05-05T06:53:29.970651Z","steps":["trace[457652522] 'read index received' (duration: 242.722874ms)","trace[457652522] 'applied index is now lower than readState.Index' (duration: 54.381µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:53:29.97078Z","caller":"traceutil/trace.go:171","msg":"trace[1594474756] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"247.130441ms","start":"2026-05-05T06:53:29.723606Z","end":"2026-05-05T06:53:29.970736Z","steps":["trace[1594474756] 'process raft request' (duration: 246.877165ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:53:29.971012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.118813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T06:53:29.971077Z","caller":"traceutil/trace.go:171","msg":"trace[367729290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1988; }","duration":"243.230376ms","start":"2026-05-05T06:53:29.72783Z","end":"2026-05-05T06:53:29.97106Z","steps":["trace[367729290] 'agreement among raft nodes before linearized reading' (duration: 243.014551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:53:29.971076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.22334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T06:53:29.971134Z","caller":"traceutil/trace.go:171","msg":"trace[1749675809] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1988; }","duration":"128.308133ms","start":"2026-05-05T06:53:29.842806Z","end":"2026-05-05T06:53:29.971114Z","steps":["trace[1749675809] 'agreement among raft nodes before linearized reading' (duration: 128.162609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:53:29.971015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.967848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-05T06:53:29.971262Z","caller":"traceutil/trace.go:171","msg":"trace[2031415387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1988; }","duration":"138.222085ms","start":"2026-05-05T06:53:29.832977Z","end":"2026-05-05T06:53:29.9712Z","steps":["trace[2031415387] 'agreement among raft nodes before linearized reading' (duration: 137.923467ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:53:42.774993Z","caller":"traceutil/trace.go:171","msg":"trace[1629578153] linearizableReadLoop","detail":"{readStateIndex:2184; appliedIndex:2183; }","duration":"154.137375ms","start":"2026-05-05T06:53:42.620819Z","end":"2026-05-05T06:53:42.774957Z","steps":["trace[1629578153] 'read index received' (duration: 151.48522ms)","trace[1629578153] 'applied index is now lower than readState.Index' (duration: 2.650405ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:53:42.775023Z","caller":"traceutil/trace.go:171","msg":"trace[930451825] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"365.283194ms","start":"2026-05-05T06:53:42.409689Z","end":"2026-05-05T06:53:42.774972Z","steps":["trace[930451825] 'process raft request' (duration: 362.625529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:53:42.775214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:53:42.409669Z","time spent":"365.449349ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:53:42.775212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.344899ms","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-05T06:53:42.775309Z","caller":"traceutil/trace.go:171","msg":"trace[1625557833] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:2101; }","duration":"154.513754ms","start":"2026-05-05T06:53:42.620772Z","end":"2026-05-05T06:53:42.775285Z","steps":["trace[1625557833] 'agreement among raft nodes before linearized reading' (duration: 154.316609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:54:13.110707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.51069ms","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-05-05T06:54:13.110817Z","caller":"traceutil/trace.go:171","msg":"trace[1278187163] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2281; }","duration":"133.696264ms","start":"2026-05-05T06:54:12.9771Z","end":"2026-05-05T06:54:13.110796Z","steps":["trace[1278187163] 'range keys from in-memory index tree' (duration: 133.285244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:54:14.441486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.969473ms","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-05-05T06:54:14.441648Z","caller":"traceutil/trace.go:171","msg":"trace[940517084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2283; }","duration":"217.2134ms","start":"2026-05-05T06:54:14.224406Z","end":"2026-05-05T06:54:14.441619Z","steps":["trace[940517084] 'range keys from in-memory index tree' (duration: 216.659736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:54:14.441709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.11189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:54:14.441834Z","caller":"traceutil/trace.go:171","msg":"trace[1983962075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2283; }","duration":"173.272323ms","start":"2026-05-05T06:54:14.268527Z","end":"2026-05-05T06:54:14.441799Z","steps":["trace[1983962075] 'range keys from in-memory index tree' (duration: 173.008716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:54:14.441848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.877483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-05T06:54:14.441704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.222191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T06:54:14.441937Z","caller":"traceutil/trace.go:171","msg":"trace[663057474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2283; }","duration":"242.025287ms","start":"2026-05-05T06:54:14.199889Z","end":"2026-05-05T06:54:14.441914Z","steps":["trace[663057474] 'range keys from in-memory index tree' (duration: 241.678938ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:54:14.44198Z","caller":"traceutil/trace.go:171","msg":"trace[1601615882] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:2283; }","duration":"516.55477ms","start":"2026-05-05T06:54:13.925394Z","end":"2026-05-05T06:54:14.441949Z","steps":["trace[1601615882] 'range keys from in-memory index tree' (duration: 516.041397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:54:14.44198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.065601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"warn","ts":"2026-05-05T06:54:14.442101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.308542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-05-05T06:54:14.442083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:54:13.925376Z","time spent":"516.689652ms","remote":"127.0.0.1:34716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.169\" "} {"level":"info","ts":"2026-05-05T06:54:14.44225Z","caller":"traceutil/trace.go:171","msg":"trace[107366294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2283; }","duration":"217.481825ms","start":"2026-05-05T06:54:14.224747Z","end":"2026-05-05T06:54:14.442229Z","steps":["trace[107366294] 'range keys from in-memory index tree' (duration: 216.614454ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:54:14.442153Z","caller":"traceutil/trace.go:171","msg":"trace[83820121] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2283; }","duration":"216.255196ms","start":"2026-05-05T06:54:14.225873Z","end":"2026-05-05T06:54:14.442129Z","steps":["trace[83820121] 'range keys from in-memory index tree' (duration: 215.706632ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:54:14.442835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.39346ms","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-05-05T06:54:14.444023Z","caller":"traceutil/trace.go:171","msg":"trace[1301498450] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2283; }","duration":"325.293676ms","start":"2026-05-05T06:54:14.118708Z","end":"2026-05-05T06:54:14.444001Z","steps":["trace[1301498450] 'range keys from in-memory index tree' (duration: 322.554019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:54:14.444072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:54:14.118679Z","time spent":"325.377438ms","remote":"127.0.0.1:38384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-05T06:54:14.73018Z","caller":"traceutil/trace.go:171","msg":"trace[798727272] transaction","detail":"{read_only:false; response_revision:2284; number_of_response:1; }","duration":"282.503078ms","start":"2026-05-05T06:54:14.447646Z","end":"2026-05-05T06:54:14.730149Z","steps":["trace[798727272] 'process raft request' (duration: 282.19178ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:54:14.730538Z","caller":"traceutil/trace.go:171","msg":"trace[1021592676] linearizableReadLoop","detail":"{readStateIndex:2378; appliedIndex:2374; }","duration":"203.37799ms","start":"2026-05-05T06:54:14.527131Z","end":"2026-05-05T06:54:14.730509Z","steps":["trace[1021592676] 'read index received' (duration: 201.483073ms)","trace[1021592676] 'applied index is now lower than readState.Index' (duration: 1.893467ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:54:14.730569Z","caller":"traceutil/trace.go:171","msg":"trace[443381526] transaction","detail":"{read_only:false; response_revision:2285; number_of_response:1; }","duration":"282.820125ms","start":"2026-05-05T06:54:14.447708Z","end":"2026-05-05T06:54:14.730528Z","steps":["trace[443381526] 'process raft request' (duration: 282.390245ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:54:14.730817Z","caller":"traceutil/trace.go:171","msg":"trace[1799487184] transaction","detail":"{read_only:false; response_revision:2286; number_of_response:1; }","duration":"283.052031ms","start":"2026-05-05T06:54:14.447746Z","end":"2026-05-05T06:54:14.730798Z","steps":["trace[1799487184] 'process raft request' (duration: 282.59ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:54:14.73087Z","caller":"traceutil/trace.go:171","msg":"trace[131471808] transaction","detail":"{read_only:false; response_revision:2287; number_of_response:1; }","duration":"283.057991ms","start":"2026-05-05T06:54:14.447801Z","end":"2026-05-05T06:54:14.730859Z","steps":["trace[131471808] 'process raft request' (duration: 282.659682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:54:14.730823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.665978ms","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-05-05T06:54:14.731024Z","caller":"traceutil/trace.go:171","msg":"trace[199736693] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2287; }","duration":"203.925923ms","start":"2026-05-05T06:54:14.527088Z","end":"2026-05-05T06:54:14.731013Z","steps":["trace[199736693] 'agreement among raft nodes before linearized reading' (duration: 203.526573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:54:50.928976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.7952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5460"} {"level":"warn","ts":"2026-05-05T06:54:50.92899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.77906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T06:54:50.929071Z","caller":"traceutil/trace.go:171","msg":"trace[116977560] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2485; }","duration":"222.945294ms","start":"2026-05-05T06:54:50.706107Z","end":"2026-05-05T06:54:50.929052Z","steps":["trace[116977560] 'range keys from in-memory index tree' (duration: 222.637376ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:54:50.929212Z","caller":"traceutil/trace.go:171","msg":"trace[156142172] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2485; }","duration":"222.947464ms","start":"2026-05-05T06:54:50.706151Z","end":"2026-05-05T06:54:50.929098Z","steps":["trace[156142172] 'count revisions from in-memory index tree' (duration: 222.719648ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:54:51.059031Z","caller":"traceutil/trace.go:171","msg":"trace[310541974] transaction","detail":"{read_only:false; response_revision:2488; number_of_response:1; }","duration":"125.429766ms","start":"2026-05-05T06:54:50.933574Z","end":"2026-05-05T06:54:51.059004Z","steps":["trace[310541974] 'process raft request' (duration: 125.344754ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:54:51.059255Z","caller":"traceutil/trace.go:171","msg":"trace[204234739] transaction","detail":"{read_only:false; response_revision:2489; number_of_response:1; }","duration":"125.305033ms","start":"2026-05-05T06:54:50.933919Z","end":"2026-05-05T06:54:51.059224Z","steps":["trace[204234739] 'process raft request' (duration: 125.043697ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:54:51.059438Z","caller":"traceutil/trace.go:171","msg":"trace[1549010722] transaction","detail":"{read_only:false; response_revision:2490; number_of_response:1; }","duration":"125.476247ms","start":"2026-05-05T06:54:50.933943Z","end":"2026-05-05T06:54:51.059419Z","steps":["trace[1549010722] 'process raft request' (duration: 125.235701ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:54:51.059055Z","caller":"traceutil/trace.go:171","msg":"trace[2133713033] transaction","detail":"{read_only:false; response_revision:2487; number_of_response:1; }","duration":"125.514948ms","start":"2026-05-05T06:54:50.933483Z","end":"2026-05-05T06:54:51.058998Z","steps":["trace[2133713033] 'process raft request' (duration: 100.892739ms)","trace[2133713033] 'compare' (duration: 24.397723ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:55:05.563564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.37186ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:55:05.563738Z","caller":"traceutil/trace.go:171","msg":"trace[55968542] linearizableReadLoop","detail":"{readStateIndex:2835; appliedIndex:2834; }","duration":"489.897027ms","start":"2026-05-05T06:55:05.073822Z","end":"2026-05-05T06:55:05.563719Z","steps":["trace[55968542] 'read index received' (duration: 64.25544ms)","trace[55968542] 'applied index is now lower than readState.Index' (duration: 425.637257ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:55:05.563796Z","caller":"traceutil/trace.go:171","msg":"trace[903218584] transaction","detail":"{read_only:false; response_revision:2725; number_of_response:1; }","duration":"491.2334ms","start":"2026-05-05T06:55:05.07252Z","end":"2026-05-05T06:55:05.563754Z","steps":["trace[903218584] 'process raft request' (duration: 65.552612ms)","trace[903218584] 'compare' (duration: 424.880808ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:55:05.563927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.114592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:8555"} {"level":"info","ts":"2026-05-05T06:55:05.563956Z","caller":"traceutil/trace.go:171","msg":"trace[1704591783] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2725; }","duration":"490.208414ms","start":"2026-05-05T06:55:05.073738Z","end":"2026-05-05T06:55:05.563946Z","steps":["trace[1704591783] 'agreement among raft nodes before linearized reading' (duration: 490.056061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:05.563967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:05.072491Z","time spent":"491.385613ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:55:05.563989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:05.073698Z","time spent":"490.283906ms","remote":"127.0.0.1:34848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":8578,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-05T06:55:05.566024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.313591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-05-05T06:55:05.566104Z","caller":"traceutil/trace.go:171","msg":"trace[181015167] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2727; }","duration":"442.418964ms","start":"2026-05-05T06:55:05.123664Z","end":"2026-05-05T06:55:05.566083Z","steps":["trace[181015167] 'agreement among raft nodes before linearized reading' (duration: 442.185168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:05.566074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.91767ms","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":"warn","ts":"2026-05-05T06:55:05.566151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:05.123654Z","time spent":"442.487996ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-05-05T06:55:05.566183Z","caller":"traceutil/trace.go:171","msg":"trace[1098932555] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2727; }","duration":"367.123975ms","start":"2026-05-05T06:55:05.199035Z","end":"2026-05-05T06:55:05.566159Z","steps":["trace[1098932555] 'agreement among raft nodes before linearized reading' (duration: 366.892139ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:05.566388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.977004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T06:55:05.566423Z","caller":"traceutil/trace.go:171","msg":"trace[586485882] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2727; }","duration":"440.009995ms","start":"2026-05-05T06:55:05.126403Z","end":"2026-05-05T06:55:05.566413Z","steps":["trace[586485882] 'agreement among raft nodes before linearized reading' (duration: 439.925483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:05.56645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:05.126371Z","time spent":"440.073247ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-05T06:55:05.566614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:05.199004Z","time spent":"367.589366ms","remote":"127.0.0.1:38384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-05-05T06:55:05.566672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.636419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T06:55:05.56671Z","caller":"traceutil/trace.go:171","msg":"trace[1829085402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2727; }","duration":"442.68594ms","start":"2026-05-05T06:55:05.124013Z","end":"2026-05-05T06:55:05.566699Z","steps":["trace[1829085402] 'agreement among raft nodes before linearized reading' (duration: 442.583358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:05.566748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:05.124009Z","time spent":"442.733071ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T06:55:05.566917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.018488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-05T06:55:05.566944Z","caller":"traceutil/trace.go:171","msg":"trace[1371980659] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2727; }","duration":"443.0932ms","start":"2026-05-05T06:55:05.123844Z","end":"2026-05-05T06:55:05.566937Z","steps":["trace[1371980659] 'agreement among raft nodes before linearized reading' (duration: 443.020498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:05.566977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:05.123817Z","time spent":"443.149922ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-05T06:55:05.567085Z","caller":"traceutil/trace.go:171","msg":"trace[454561835] transaction","detail":"{read_only:false; response_revision:2726; number_of_response:1; }","duration":"456.317451ms","start":"2026-05-05T06:55:05.110757Z","end":"2026-05-05T06:55:05.567075Z","steps":["trace[454561835] 'process raft request' (duration: 454.949708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:05.567176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:05.110739Z","time spent":"456.379693ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:55:05.567234Z","caller":"traceutil/trace.go:171","msg":"trace[622231517] transaction","detail":"{read_only:false; response_revision:2727; number_of_response:1; }","duration":"431.362815ms","start":"2026-05-05T06:55:05.13581Z","end":"2026-05-05T06:55:05.567173Z","steps":["trace[622231517] 'process raft request' (duration: 429.992132ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:05.567503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:05.135793Z","time spent":"431.57827ms","remote":"127.0.0.1:34940","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-05-05T06:55:08.372034Z","caller":"traceutil/trace.go:171","msg":"trace[792989036] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"175.84573ms","start":"2026-05-05T06:55:08.196161Z","end":"2026-05-05T06:55:08.372007Z","steps":["trace[792989036] 'process raft request' (duration: 175.577943ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:55:08.378008Z","caller":"traceutil/trace.go:171","msg":"trace[1439368704] transaction","detail":"{read_only:false; response_revision:2750; number_of_response:1; }","duration":"132.532178ms","start":"2026-05-05T06:55:08.245441Z","end":"2026-05-05T06:55:08.377973Z","steps":["trace[1439368704] 'process raft request' (duration: 132.425335ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:09.266053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.063394ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T06:55:09.268177Z","caller":"traceutil/trace.go:171","msg":"trace[1852978783] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"259.665426ms","start":"2026-05-05T06:55:09.008479Z","end":"2026-05-05T06:55:09.268144Z","steps":["trace[1852978783] 'process raft request' (duration: 259.459201ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:55:37.95753Z","caller":"traceutil/trace.go:171","msg":"trace[583275149] transaction","detail":"{read_only:false; response_revision:2928; number_of_response:1; }","duration":"265.014447ms","start":"2026-05-05T06:55:37.692478Z","end":"2026-05-05T06:55:37.957493Z","steps":["trace[583275149] 'process raft request' (duration: 205.69456ms)","trace[583275149] 'compare' (duration: 58.898886ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:55:37.957941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.576125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-05-05T06:55:37.957318Z","caller":"traceutil/trace.go:171","msg":"trace[702801017] linearizableReadLoop","detail":"{readStateIndex:3044; appliedIndex:3042; }","duration":"211.94829ms","start":"2026-05-05T06:55:37.745341Z","end":"2026-05-05T06:55:37.957289Z","steps":["trace[702801017] 'read index received' (duration: 6.62992ms)","trace[702801017] 'applied index is now lower than readState.Index' (duration: 205.31678ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:55:37.958304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.533675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-05T06:55:37.958301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.90931ms","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-05T06:55:37.958353Z","caller":"traceutil/trace.go:171","msg":"trace[939399198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2928; }","duration":"210.635838ms","start":"2026-05-05T06:55:37.747704Z","end":"2026-05-05T06:55:37.95834Z","steps":["trace[939399198] 'agreement among raft nodes before linearized reading' (duration: 210.404382ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:55:37.958377Z","caller":"traceutil/trace.go:171","msg":"trace[1241307562] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2928; }","duration":"210.017322ms","start":"2026-05-05T06:55:37.74834Z","end":"2026-05-05T06:55:37.958358Z","steps":["trace[1241307562] 'agreement among raft nodes before linearized reading' (duration: 209.783567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:37.958343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.06473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-05T06:55:37.958582Z","caller":"traceutil/trace.go:171","msg":"trace[304824835] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2928; }","duration":"212.719058ms","start":"2026-05-05T06:55:37.745307Z","end":"2026-05-05T06:55:37.958026Z","steps":["trace[304824835] 'agreement among raft nodes before linearized reading' (duration: 212.302908ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:55:37.958529Z","caller":"traceutil/trace.go:171","msg":"trace[2130200233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2928; }","duration":"209.266305ms","start":"2026-05-05T06:55:37.749246Z","end":"2026-05-05T06:55:37.958512Z","steps":["trace[2130200233] 'agreement among raft nodes before linearized reading' (duration: 208.965118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:37.958899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.653558ms","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-05-05T06:55:37.958945Z","caller":"traceutil/trace.go:171","msg":"trace[2080541053] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2928; }","duration":"210.786771ms","start":"2026-05-05T06:55:37.748147Z","end":"2026-05-05T06:55:37.958934Z","steps":["trace[2080541053] 'agreement among raft nodes before linearized reading' (duration: 210.039633ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:55:38.389651Z","caller":"traceutil/trace.go:171","msg":"trace[2022842955] transaction","detail":"{read_only:false; response_revision:2933; number_of_response:1; }","duration":"426.220325ms","start":"2026-05-05T06:55:37.96341Z","end":"2026-05-05T06:55:38.389631Z","steps":["trace[2022842955] 'process raft request' (duration: 426.173804ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:55:38.389737Z","caller":"traceutil/trace.go:171","msg":"trace[1085108296] transaction","detail":"{read_only:false; response_revision:2931; number_of_response:1; }","duration":"426.612125ms","start":"2026-05-05T06:55:37.963088Z","end":"2026-05-05T06:55:38.3897Z","steps":["trace[1085108296] 'process raft request' (duration: 426.42109ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:55:38.389754Z","caller":"traceutil/trace.go:171","msg":"trace[1498954317] transaction","detail":"{read_only:false; response_revision:2932; number_of_response:1; }","duration":"426.564724ms","start":"2026-05-05T06:55:37.96316Z","end":"2026-05-05T06:55:38.389725Z","steps":["trace[1498954317] 'process raft request' (duration: 426.387669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:38.389801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:37.963391Z","time spent":"426.335498ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:55:38.38965Z","caller":"traceutil/trace.go:171","msg":"trace[1105802122] transaction","detail":"{read_only:false; response_revision:2930; number_of_response:1; }","duration":"426.862041ms","start":"2026-05-05T06:55:37.962752Z","end":"2026-05-05T06:55:38.389614Z","steps":["trace[1105802122] 'process raft request' (duration: 426.609295ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:38.389912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:37.963152Z","time spent":"426.676766ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:55:38.389916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:37.963069Z","time spent":"426.752398ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:55:38.39001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:37.962711Z","time spent":"427.205219ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:55:38.410331Z","caller":"traceutil/trace.go:171","msg":"trace[276654064] linearizableReadLoop","detail":"{readStateIndex:3050; appliedIndex:3045; }","duration":"141.233548ms","start":"2026-05-05T06:55:38.269046Z","end":"2026-05-05T06:55:38.410279Z","steps":["trace[276654064] 'read index received' (duration: 120.391297ms)","trace[276654064] 'applied index is now lower than readState.Index' (duration: 20.840681ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:55:38.410385Z","caller":"traceutil/trace.go:171","msg":"trace[50574470] transaction","detail":"{read_only:false; response_revision:2934; number_of_response:1; }","duration":"320.019569ms","start":"2026-05-05T06:55:38.090314Z","end":"2026-05-05T06:55:38.410334Z","steps":["trace[50574470] 'process raft request' (duration: 319.812034ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:38.410493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.445093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:55:38.410556Z","caller":"traceutil/trace.go:171","msg":"trace[1638266842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2934; }","duration":"141.561416ms","start":"2026-05-05T06:55:38.26898Z","end":"2026-05-05T06:55:38.410542Z","steps":["trace[1638266842] 'agreement among raft nodes before linearized reading' (duration: 141.432193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:38.410647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:38.090287Z","time spent":"320.231485ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:55:38.821555Z","caller":"traceutil/trace.go:171","msg":"trace[361044174] linearizableReadLoop","detail":"{readStateIndex:3051; appliedIndex:3050; }","duration":"269.593177ms","start":"2026-05-05T06:55:38.55194Z","end":"2026-05-05T06:55:38.821533Z","steps":["trace[361044174] 'read index received' (duration: 269.481974ms)","trace[361044174] 'applied index is now lower than readState.Index' (duration: 110.143µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:55:38.821635Z","caller":"traceutil/trace.go:171","msg":"trace[701578439] transaction","detail":"{read_only:false; response_revision:2935; number_of_response:1; }","duration":"290.587401ms","start":"2026-05-05T06:55:38.531004Z","end":"2026-05-05T06:55:38.821592Z","steps":["trace[701578439] 'process raft request' (duration: 290.379256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:38.821777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.808082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-05T06:55:38.821819Z","caller":"traceutil/trace.go:171","msg":"trace[1541966094] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2935; }","duration":"269.900443ms","start":"2026-05-05T06:55:38.551908Z","end":"2026-05-05T06:55:38.821808Z","steps":["trace[1541966094] 'agreement among raft nodes before linearized reading' (duration: 269.708479ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:55:38.825279Z","caller":"traceutil/trace.go:171","msg":"trace[1750775950] transaction","detail":"{read_only:false; response_revision:2936; number_of_response:1; }","duration":"238.656332ms","start":"2026-05-05T06:55:38.586608Z","end":"2026-05-05T06:55:38.825264Z","steps":["trace[1750775950] 'process raft request' (duration: 238.473917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:39.085413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.044372ms","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-05T06:55:39.0855Z","caller":"traceutil/trace.go:171","msg":"trace[1851785216] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:2936; }","duration":"254.175866ms","start":"2026-05-05T06:55:38.831305Z","end":"2026-05-05T06:55:39.085481Z","steps":["trace[1851785216] 'range keys from in-memory index tree' (duration: 253.833617ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:55:44.53296Z","caller":"traceutil/trace.go:171","msg":"trace[490076872] linearizableReadLoop","detail":"{readStateIndex:3082; appliedIndex:3081; }","duration":"111.159874ms","start":"2026-05-05T06:55:44.421775Z","end":"2026-05-05T06:55:44.532935Z","steps":["trace[490076872] 'read index received' (duration: 110.96945ms)","trace[490076872] 'applied index is now lower than readState.Index' (duration: 189.114µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:55:44.533019Z","caller":"traceutil/trace.go:171","msg":"trace[160624740] transaction","detail":"{read_only:false; response_revision:2964; number_of_response:1; }","duration":"111.653987ms","start":"2026-05-05T06:55:44.421336Z","end":"2026-05-05T06:55:44.53299Z","steps":["trace[160624740] 'process raft request' (duration: 111.433361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:44.533251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.466592ms","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-05-05T06:55:44.533333Z","caller":"traceutil/trace.go:171","msg":"trace[358476274] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2964; }","duration":"111.588465ms","start":"2026-05-05T06:55:44.421727Z","end":"2026-05-05T06:55:44.533315Z","steps":["trace[358476274] 'agreement among raft nodes before linearized reading' (duration: 111.330188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:44.870266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.807487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:55:44.870482Z","caller":"traceutil/trace.go:171","msg":"trace[273323939] linearizableReadLoop","detail":"{readStateIndex:3083; appliedIndex:3082; }","duration":"337.4456ms","start":"2026-05-05T06:55:44.533023Z","end":"2026-05-05T06:55:44.870468Z","steps":["trace[273323939] 'read index received' (duration: 147.388327ms)","trace[273323939] 'applied index is now lower than readState.Index' (duration: 190.056283ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:55:44.870576Z","caller":"traceutil/trace.go:171","msg":"trace[471077623] transaction","detail":"{read_only:false; response_revision:2965; number_of_response:1; }","duration":"445.399826ms","start":"2026-05-05T06:55:44.425167Z","end":"2026-05-05T06:55:44.870567Z","steps":["trace[471077623] 'process raft request' (duration: 255.240271ms)","trace[471077623] 'compare' (duration: 189.5234ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:55:44.870616Z","caller":"traceutil/trace.go:171","msg":"trace[217593780] transaction","detail":"{read_only:false; response_revision:2966; number_of_response:1; }","duration":"333.032683ms","start":"2026-05-05T06:55:44.537559Z","end":"2026-05-05T06:55:44.870592Z","steps":["trace[217593780] 'process raft request' (duration: 332.847958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:44.870644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:44.425151Z","time spent":"445.467719ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:55:44.87073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:44.537541Z","time spent":"333.130076ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:55:44.870919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.834155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-05T06:55:44.870987Z","caller":"traceutil/trace.go:171","msg":"trace[261313897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2966; }","duration":"447.959808ms","start":"2026-05-05T06:55:44.423013Z","end":"2026-05-05T06:55:44.870973Z","steps":["trace[261313897] 'agreement among raft nodes before linearized reading' (duration: 447.685651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:44.87103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:44.422994Z","time spent":"448.02776ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-05T06:55:44.871033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.804404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-05T06:55:44.871068Z","caller":"traceutil/trace.go:171","msg":"trace[1160766678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2966; }","duration":"447.857026ms","start":"2026-05-05T06:55:44.423202Z","end":"2026-05-05T06:55:44.871059Z","steps":["trace[1160766678] 'agreement among raft nodes before linearized reading' (duration: 447.727093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:44.871102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:44.423195Z","time spent":"447.899077ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T06:55:44.871032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.680654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-05T06:55:44.871142Z","caller":"traceutil/trace.go:171","msg":"trace[1828517193] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2966; }","duration":"317.871389ms","start":"2026-05-05T06:55:44.55326Z","end":"2026-05-05T06:55:44.871131Z","steps":["trace[1828517193] 'agreement among raft nodes before linearized reading' (duration: 317.635433ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:44.871174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:55:44.553246Z","time spent":"317.92027ms","remote":"127.0.0.1:34866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-05-05T06:55:45.03792Z","caller":"traceutil/trace.go:171","msg":"trace[997980460] transaction","detail":"{read_only:false; response_revision:2969; number_of_response:1; }","duration":"161.717511ms","start":"2026-05-05T06:55:44.876169Z","end":"2026-05-05T06:55:45.037887Z","steps":["trace[997980460] 'process raft request' (duration: 161.632729ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:55:45.038075Z","caller":"traceutil/trace.go:171","msg":"trace[1587164532] transaction","detail":"{read_only:false; response_revision:2968; number_of_response:1; }","duration":"162.46935ms","start":"2026-05-05T06:55:44.875572Z","end":"2026-05-05T06:55:45.038041Z","steps":["trace[1587164532] 'process raft request' (duration: 107.061966ms)","trace[1587164532] 'compare' (duration: 55.006784ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:55:45.038236Z","caller":"traceutil/trace.go:171","msg":"trace[483104785] linearizableReadLoop","detail":"{readStateIndex:3088; appliedIndex:3085; }","duration":"138.575785ms","start":"2026-05-05T06:55:44.899632Z","end":"2026-05-05T06:55:45.038208Z","steps":["trace[483104785] 'read index received' (duration: 82.837693ms)","trace[483104785] 'applied index is now lower than readState.Index' (duration: 55.736282ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:55:45.038426Z","caller":"traceutil/trace.go:171","msg":"trace[182592125] transaction","detail":"{read_only:false; response_revision:2970; number_of_response:1; }","duration":"160.951413ms","start":"2026-05-05T06:55:44.877461Z","end":"2026-05-05T06:55:45.038413Z","steps":["trace[182592125] 'process raft request' (duration: 160.387609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:55:45.03852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.829971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1315"} {"level":"info","ts":"2026-05-05T06:55:45.038597Z","caller":"traceutil/trace.go:171","msg":"trace[196917126] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2970; }","duration":"138.984864ms","start":"2026-05-05T06:55:44.899598Z","end":"2026-05-05T06:55:45.038583Z","steps":["trace[196917126] 'agreement among raft nodes before linearized reading' (duration: 138.735218ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:58:09.706933Z","caller":"traceutil/trace.go:171","msg":"trace[1019291241] transaction","detail":"{read_only:false; response_revision:3926; number_of_response:1; }","duration":"341.19599ms","start":"2026-05-05T06:58:09.365018Z","end":"2026-05-05T06:58:09.706214Z","steps":["trace[1019291241] 'process raft request' (duration: 340.841742ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:58:09.707126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:58:09.365002Z","time spent":"342.02988ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:58:09.734111Z","caller":"traceutil/trace.go:171","msg":"trace[1610914975] linearizableReadLoop","detail":"{readStateIndex:4081; appliedIndex:4079; }","duration":"204.694023ms","start":"2026-05-05T06:58:09.52939Z","end":"2026-05-05T06:58:09.734084Z","steps":["trace[1610914975] 'read index received' (duration: 176.554362ms)","trace[1610914975] 'applied index is now lower than readState.Index' (duration: 28.138281ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:58:09.734276Z","caller":"traceutil/trace.go:171","msg":"trace[960902762] transaction","detail":"{read_only:false; response_revision:3927; number_of_response:1; }","duration":"262.545593ms","start":"2026-05-05T06:58:09.471714Z","end":"2026-05-05T06:58:09.73426Z","steps":["trace[960902762] 'process raft request' (duration: 262.210105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:58:09.734624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.235006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-05T06:58:09.734683Z","caller":"traceutil/trace.go:171","msg":"trace[103636794] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3927; }","duration":"205.327638ms","start":"2026-05-05T06:58:09.529342Z","end":"2026-05-05T06:58:09.73467Z","steps":["trace[103636794] 'agreement among raft nodes before linearized reading' (duration: 205.216095ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:58:15.015089Z","caller":"traceutil/trace.go:171","msg":"trace[569717114] linearizableReadLoop","detail":"{readStateIndex:4110; appliedIndex:4109; }","duration":"100.139399ms","start":"2026-05-05T06:58:14.914926Z","end":"2026-05-05T06:58:15.015065Z","steps":["trace[569717114] 'read index received' (duration: 99.925264ms)","trace[569717114] 'applied index is now lower than readState.Index' (duration: 213.215µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:58:15.015121Z","caller":"traceutil/trace.go:171","msg":"trace[368087728] transaction","detail":"{read_only:false; response_revision:3955; number_of_response:1; }","duration":"196.010466ms","start":"2026-05-05T06:58:14.819085Z","end":"2026-05-05T06:58:15.015095Z","steps":["trace[368087728] 'process raft request' (duration: 195.844362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:58:15.015271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.328193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-b9m2g\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-05-05T06:58:15.015305Z","caller":"traceutil/trace.go:171","msg":"trace[1337453856] range","detail":"{range_begin:/registry/pods/openstack/keepalived-b9m2g; range_end:; response_count:1; response_revision:3955; }","duration":"100.422545ms","start":"2026-05-05T06:58:14.914874Z","end":"2026-05-05T06:58:15.015296Z","steps":["trace[1337453856] 'agreement among raft nodes before linearized reading' (duration: 100.278332ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:28.317436Z","caller":"traceutil/trace.go:171","msg":"trace[221853889] transaction","detail":"{read_only:false; response_revision:4805; number_of_response:1; }","duration":"135.728175ms","start":"2026-05-05T06:59:28.181684Z","end":"2026-05-05T06:59:28.317412Z","steps":["trace[221853889] 'process raft request' (duration: 133.164675ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:34.844097Z","caller":"traceutil/trace.go:171","msg":"trace[314654783] transaction","detail":"{read_only:false; response_revision:4988; number_of_response:1; }","duration":"251.36338ms","start":"2026-05-05T06:59:34.592707Z","end":"2026-05-05T06:59:34.84407Z","steps":["trace[314654783] 'process raft request' (duration: 251.191346ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:34.889936Z","caller":"traceutil/trace.go:171","msg":"trace[1379360612] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"235.013096ms","start":"2026-05-05T06:59:34.654892Z","end":"2026-05-05T06:59:34.889905Z","steps":["trace[1379360612] 'process raft request' (duration: 234.724039ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:34.889972Z","caller":"traceutil/trace.go:171","msg":"trace[2147076085] linearizableReadLoop","detail":"{readStateIndex:5185; appliedIndex:5183; }","duration":"227.182713ms","start":"2026-05-05T06:59:34.66276Z","end":"2026-05-05T06:59:34.889943Z","steps":["trace[2147076085] 'read index received' (duration: 181.228374ms)","trace[2147076085] 'applied index is now lower than readState.Index' (duration: 45.953249ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:59:34.890075Z","caller":"traceutil/trace.go:171","msg":"trace[1887164875] transaction","detail":"{read_only:false; response_revision:4990; number_of_response:1; }","duration":"127.819701ms","start":"2026-05-05T06:59:34.762213Z","end":"2026-05-05T06:59:34.890032Z","steps":["trace[1887164875] 'process raft request' (duration: 127.593615ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:34.994593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.820658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-scxbd\" ","response":"range_response_count:1 size:5151"} {"level":"info","ts":"2026-05-05T06:59:34.994682Z","caller":"traceutil/trace.go:171","msg":"trace[540755981] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-scxbd; range_end:; response_count:1; response_revision:4991; }","duration":"331.961342ms","start":"2026-05-05T06:59:34.662697Z","end":"2026-05-05T06:59:34.994658Z","steps":["trace[540755981] 'agreement among raft nodes before linearized reading' (duration: 227.461339ms)","trace[540755981] 'range keys from in-memory index tree' (duration: 104.301048ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:59:34.994718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:59:34.662674Z","time spent":"332.037064ms","remote":"127.0.0.1:34862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":5174,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-scxbd\" "} {"level":"warn","ts":"2026-05-05T06:59:34.995177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.4602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T06:59:34.995421Z","caller":"traceutil/trace.go:171","msg":"trace[1763797234] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:4991; }","duration":"230.680465ms","start":"2026-05-05T06:59:34.764615Z","end":"2026-05-05T06:59:34.995295Z","steps":["trace[1763797234] 'agreement among raft nodes before linearized reading' (duration: 125.595718ms)","trace[1763797234] 'count revisions from in-memory index tree' (duration: 104.830571ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:59:35.035725Z","caller":"traceutil/trace.go:171","msg":"trace[357983328] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"128.2527ms","start":"2026-05-05T06:59:34.907446Z","end":"2026-05-05T06:59:35.035699Z","steps":["trace[357983328] 'process raft request' (duration: 128.095746ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:35.041748Z","caller":"traceutil/trace.go:171","msg":"trace[1160913717] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"133.700848ms","start":"2026-05-05T06:59:34.908008Z","end":"2026-05-05T06:59:35.041709Z","steps":["trace[1160913717] 'process raft request' (duration: 133.403231ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:37.814158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.5334ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:59:37.814274Z","caller":"traceutil/trace.go:171","msg":"trace[2090410977] transaction","detail":"{read_only:false; response_revision:5129; number_of_response:1; }","duration":"450.431803ms","start":"2026-05-05T06:59:37.363821Z","end":"2026-05-05T06:59:37.814253Z","steps":["trace[2090410977] 'process raft request' (duration: 202.710908ms)","trace[2090410977] 'compare' (duration: 247.268594ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:59:37.814337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:59:37.363804Z","time spent":"450.502284ms","remote":"127.0.0.1:35140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5068,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:59:37.833738Z","caller":"traceutil/trace.go:171","msg":"trace[1358170411] transaction","detail":"{read_only:false; response_revision:5130; number_of_response:1; }","duration":"469.235314ms","start":"2026-05-05T06:59:37.364489Z","end":"2026-05-05T06:59:37.833725Z","steps":["trace[1358170411] 'process raft request' (duration: 468.814554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:37.833854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:59:37.36447Z","time spent":"469.332076ms","remote":"127.0.0.1:34862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5837,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:59:37.833443Z","caller":"traceutil/trace.go:171","msg":"trace[242974104] linearizableReadLoop","detail":"{readStateIndex:5328; appliedIndex:5326; }","duration":"430.821042ms","start":"2026-05-05T06:59:37.402602Z","end":"2026-05-05T06:59:37.833423Z","steps":["trace[242974104] 'read index received' (duration: 164.00893ms)","trace[242974104] 'applied index is now lower than readState.Index' (duration: 266.810692ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:59:37.834866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.263406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:778261"} {"level":"warn","ts":"2026-05-05T06:59:37.835101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.974406ms","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-05T06:59:37.83598Z","caller":"traceutil/trace.go:171","msg":"trace[1879180180] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5130; }","duration":"379.851496ms","start":"2026-05-05T06:59:37.456115Z","end":"2026-05-05T06:59:37.835967Z","steps":["trace[1879180180] 'agreement among raft nodes before linearized reading' (duration: 378.896274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:37.83603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:59:37.456079Z","time spent":"379.935458ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-05T06:59:37.83538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.154235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-05-05T06:59:37.83625Z","caller":"traceutil/trace.go:171","msg":"trace[212943482] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5130; }","duration":"278.044576ms","start":"2026-05-05T06:59:37.55819Z","end":"2026-05-05T06:59:37.836234Z","steps":["trace[212943482] 'agreement among raft nodes before linearized reading' (duration: 277.128025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:37.83544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.304056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:59:37.836574Z","caller":"traceutil/trace.go:171","msg":"trace[716429128] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:5130; }","duration":"306.457883ms","start":"2026-05-05T06:59:37.530096Z","end":"2026-05-05T06:59:37.836554Z","steps":["trace[716429128] 'agreement among raft nodes before linearized reading' (duration: 305.303776ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:37.836634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:59:37.530085Z","time spent":"306.531754ms","remote":"127.0.0.1:35086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-05-05T06:59:37.835556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.629046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8d8629db-6976-4ab1-8ea8-1ac142ff93c8\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-05-05T06:59:37.836846Z","caller":"traceutil/trace.go:171","msg":"trace[1439190404] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8d8629db-6976-4ab1-8ea8-1ac142ff93c8; range_end:; response_count:1; response_revision:5130; }","duration":"327.949808ms","start":"2026-05-05T06:59:37.508881Z","end":"2026-05-05T06:59:37.836831Z","steps":["trace[1439190404] 'agreement among raft nodes before linearized reading' (duration: 326.587276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:37.836904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:59:37.508862Z","time spent":"328.02611ms","remote":"127.0.0.1:34862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3624,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8d8629db-6976-4ab1-8ea8-1ac142ff93c8\" "} {"level":"warn","ts":"2026-05-05T06:59:37.835641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.927176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-b9m2g\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-05-05T06:59:37.837055Z","caller":"traceutil/trace.go:171","msg":"trace[135294098] range","detail":"{range_begin:/registry/pods/openstack/keepalived-b9m2g; range_end:; response_count:1; response_revision:5130; }","duration":"369.37686ms","start":"2026-05-05T06:59:37.467663Z","end":"2026-05-05T06:59:37.83704Z","steps":["trace[135294098] 'agreement among raft nodes before linearized reading' (duration: 367.913716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:37.837105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:59:37.467641Z","time spent":"369.448912ms","remote":"127.0.0.1:34862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-b9m2g\" "} {"level":"info","ts":"2026-05-05T06:59:37.835916Z","caller":"traceutil/trace.go:171","msg":"trace[1587424378] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5130; }","duration":"433.308561ms","start":"2026-05-05T06:59:37.402586Z","end":"2026-05-05T06:59:37.835895Z","steps":["trace[1587424378] 'agreement among raft nodes before linearized reading' (duration: 431.628551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:37.837412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:59:37.402514Z","time spent":"434.877338ms","remote":"127.0.0.1:34776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":25,"response size":778284,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"warn","ts":"2026-05-05T06:59:39.612644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.368179ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T06:59:39.612833Z","caller":"traceutil/trace.go:171","msg":"trace[1753599076] linearizableReadLoop","detail":"{readStateIndex:5344; appliedIndex:5343; }","duration":"138.851639ms","start":"2026-05-05T06:59:39.473956Z","end":"2026-05-05T06:59:39.612807Z","steps":["trace[1753599076] 'read index received' (duration: 53.491µs)","trace[1753599076] 'applied index is now lower than readState.Index' (duration: 138.796228ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:59:39.613303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.337081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:778261"} {"level":"info","ts":"2026-05-05T06:59:39.613375Z","caller":"traceutil/trace.go:171","msg":"trace[848752060] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5145; }","duration":"139.461034ms","start":"2026-05-05T06:59:39.473899Z","end":"2026-05-05T06:59:39.61336Z","steps":["trace[848752060] 'agreement among raft nodes before linearized reading' (duration: 138.971513ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:39.615056Z","caller":"traceutil/trace.go:171","msg":"trace[357956148] transaction","detail":"{read_only:false; response_revision:5146; number_of_response:1; }","duration":"137.863766ms","start":"2026-05-05T06:59:39.477176Z","end":"2026-05-05T06:59:39.61504Z","steps":["trace[357956148] 'process raft request' (duration: 137.725363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:48.598328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.643996ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:59:48.598515Z","caller":"traceutil/trace.go:171","msg":"trace[1981694344] transaction","detail":"{read_only:false; response_revision:5341; number_of_response:1; }","duration":"129.828351ms","start":"2026-05-05T06:59:48.468672Z","end":"2026-05-05T06:59:48.598501Z","steps":["trace[1981694344] 'process raft request' (duration: 129.79094ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:48.598629Z","caller":"traceutil/trace.go:171","msg":"trace[2084288519] transaction","detail":"{read_only:false; response_revision:5339; number_of_response:1; }","duration":"198.489218ms","start":"2026-05-05T06:59:48.400106Z","end":"2026-05-05T06:59:48.598595Z","steps":["trace[2084288519] 'process raft request' (duration: 91.502215ms)","trace[2084288519] 'compare' (duration: 106.525292ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:59:48.598683Z","caller":"traceutil/trace.go:171","msg":"trace[1734511761] transaction","detail":"{read_only:false; response_revision:5340; number_of_response:1; }","duration":"197.866064ms","start":"2026-05-05T06:59:48.400769Z","end":"2026-05-05T06:59:48.598635Z","steps":["trace[1734511761] 'process raft request' (duration: 197.643038ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:49.039262Z","caller":"traceutil/trace.go:171","msg":"trace[1273349323] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"106.260505ms","start":"2026-05-05T06:59:48.932976Z","end":"2026-05-05T06:59:49.039237Z","steps":["trace[1273349323] 'process raft request' (duration: 106.116252ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:57.148375Z","caller":"traceutil/trace.go:171","msg":"trace[2066059461] transaction","detail":"{read_only:false; response_revision:5513; number_of_response:1; }","duration":"115.901349ms","start":"2026-05-05T06:59:57.032446Z","end":"2026-05-05T06:59:57.148347Z","steps":["trace[2066059461] 'process raft request' (duration: 115.742275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:57.420217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.747185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:59:57.42039Z","caller":"traceutil/trace.go:171","msg":"trace[1265564426] transaction","detail":"{read_only:false; response_revision:5514; number_of_response:1; }","duration":"361.415804ms","start":"2026-05-05T06:59:57.058946Z","end":"2026-05-05T06:59:57.420362Z","steps":["trace[1265564426] 'process raft request' (duration: 245.425573ms)","trace[1265564426] 'compare' (duration: 115.639673ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:59:57.420535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:59:57.058923Z","time spent":"361.534516ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:59:57.739953Z","caller":"traceutil/trace.go:171","msg":"trace[1552902781] transaction","detail":"{read_only:false; response_revision:5515; number_of_response:1; }","duration":"309.871193ms","start":"2026-05-05T06:59:57.430042Z","end":"2026-05-05T06:59:57.739913Z","steps":["trace[1552902781] 'process raft request' (duration: 309.675658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:57.740165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:59:57.430018Z","time spent":"310.038146ms","remote":"127.0.0.1:34862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:59:58.234939Z","caller":"traceutil/trace.go:171","msg":"trace[471860010] linearizableReadLoop","detail":"{readStateIndex:5725; appliedIndex:5723; }","duration":"246.757234ms","start":"2026-05-05T06:59:57.988154Z","end":"2026-05-05T06:59:58.234912Z","steps":["trace[471860010] 'read index received' (duration: 25.413118ms)","trace[471860010] 'applied index is now lower than readState.Index' (duration: 221.342566ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:59:58.23544Z","caller":"traceutil/trace.go:171","msg":"trace[2117874661] transaction","detail":"{read_only:false; response_revision:5517; number_of_response:1; }","duration":"247.701265ms","start":"2026-05-05T06:59:57.987704Z","end":"2026-05-05T06:59:58.235405Z","steps":["trace[2117874661] 'process raft request' (duration: 242.931445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:59:58.235594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.406749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1162"} {"level":"warn","ts":"2026-05-05T06:59:58.235707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.559501ms","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-05T06:59:58.235768Z","caller":"traceutil/trace.go:171","msg":"trace[1156240995] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:5518; }","duration":"173.665884ms","start":"2026-05-05T06:59:58.062086Z","end":"2026-05-05T06:59:58.235752Z","steps":["trace[1156240995] 'agreement among raft nodes before linearized reading' (duration: 173.540301ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:59:58.235731Z","caller":"traceutil/trace.go:171","msg":"trace[2129091852] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:5517; }","duration":"247.573252ms","start":"2026-05-05T06:59:57.988127Z","end":"2026-05-05T06:59:58.2357Z","steps":["trace[2129091852] 'agreement among raft nodes before linearized reading' (duration: 246.942598ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:00:10.093825Z","caller":"traceutil/trace.go:171","msg":"trace[630149184] transaction","detail":"{read_only:false; response_revision:5681; number_of_response:1; }","duration":"219.708538ms","start":"2026-05-05T07:00:09.874092Z","end":"2026-05-05T07:00:10.093801Z","steps":["trace[630149184] 'process raft request' (duration: 219.498973ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:00:14.462698Z","caller":"traceutil/trace.go:171","msg":"trace[116123699] transaction","detail":"{read_only:false; response_revision:5718; number_of_response:1; }","duration":"136.666299ms","start":"2026-05-05T07:00:14.326006Z","end":"2026-05-05T07:00:14.462672Z","steps":["trace[116123699] 'process raft request' (duration: 136.609337ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:00:14.462721Z","caller":"traceutil/trace.go:171","msg":"trace[552394325] transaction","detail":"{read_only:false; response_revision:5717; number_of_response:1; }","duration":"136.756941ms","start":"2026-05-05T07:00:14.325932Z","end":"2026-05-05T07:00:14.462689Z","steps":["trace[552394325] 'process raft request' (duration: 136.520846ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:00:14.471058Z","caller":"traceutil/trace.go:171","msg":"trace[207588766] transaction","detail":"{read_only:false; response_revision:5719; number_of_response:1; }","duration":"129.985804ms","start":"2026-05-05T07:00:14.341054Z","end":"2026-05-05T07:00:14.47104Z","steps":["trace[207588766] 'process raft request' (duration: 129.890282ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:00:20.669643Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2828} {"level":"info","ts":"2026-05-05T07:00:20.742289Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2828,"took":"70.497489ms","hash":2324783418,"current-db-size-bytes":55205888,"current-db-size":"55 MB","current-db-size-in-use-bytes":31969280,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-05T07:00:20.742344Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2324783418,"revision":2828,"compact-revision":-1} {"level":"info","ts":"2026-05-05T07:00:48.663618Z","caller":"traceutil/trace.go:171","msg":"trace[1622096809] transaction","detail":"{read_only:false; response_revision:6011; number_of_response:1; }","duration":"167.974338ms","start":"2026-05-05T07:00:48.495617Z","end":"2026-05-05T07:00:48.663592Z","steps":["trace[1622096809] 'process raft request' (duration: 167.800374ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:00:48.664231Z","caller":"traceutil/trace.go:171","msg":"trace[1228906913] transaction","detail":"{read_only:false; response_revision:6012; number_of_response:1; }","duration":"168.519911ms","start":"2026-05-05T07:00:48.495685Z","end":"2026-05-05T07:00:48.664205Z","steps":["trace[1228906913] 'process raft request' (duration: 168.417288ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:00:56.851266Z","caller":"traceutil/trace.go:171","msg":"trace[506331263] transaction","detail":"{read_only:false; response_revision:6066; number_of_response:1; }","duration":"155.006504ms","start":"2026-05-05T07:00:56.696229Z","end":"2026-05-05T07:00:56.851236Z","steps":["trace[506331263] 'process raft request' (duration: 154.80893ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:00:56.907196Z","caller":"traceutil/trace.go:171","msg":"trace[437128470] linearizableReadLoop","detail":"{readStateIndex:6291; appliedIndex:6289; }","duration":"198.004398ms","start":"2026-05-05T07:00:56.709167Z","end":"2026-05-05T07:00:56.907171Z","steps":["trace[437128470] 'read index received' (duration: 141.867466ms)","trace[437128470] 'applied index is now lower than readState.Index' (duration: 56.135812ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T07:00:56.907372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.179712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-05T07:00:56.907414Z","caller":"traceutil/trace.go:171","msg":"trace[1562314174] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6067; }","duration":"198.276605ms","start":"2026-05-05T07:00:56.709125Z","end":"2026-05-05T07:00:56.907401Z","steps":["trace[1562314174] 'agreement among raft nodes before linearized reading' (duration: 198.184843ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:00:56.907381Z","caller":"traceutil/trace.go:171","msg":"trace[2125791670] transaction","detail":"{read_only:false; response_revision:6067; number_of_response:1; }","duration":"210.080302ms","start":"2026-05-05T07:00:56.697218Z","end":"2026-05-05T07:00:56.907299Z","steps":["trace[2125791670] 'process raft request' (duration: 209.808196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:00:56.907575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.147656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-05T07:00:56.907638Z","caller":"traceutil/trace.go:171","msg":"trace[1638275610] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6067; }","duration":"192.213488ms","start":"2026-05-05T07:00:56.715409Z","end":"2026-05-05T07:00:56.907623Z","steps":["trace[1638275610] 'agreement among raft nodes before linearized reading' (duration: 192.028113ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:00:56.907634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.03525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-05T07:00:56.907728Z","caller":"traceutil/trace.go:171","msg":"trace[549859636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6067; }","duration":"198.179583ms","start":"2026-05-05T07:00:56.709526Z","end":"2026-05-05T07:00:56.907705Z","steps":["trace[549859636] 'agreement among raft nodes before linearized reading' (duration: 197.837185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:00:56.909225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.616512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2212891"} {"level":"info","ts":"2026-05-05T07:00:56.909308Z","caller":"traceutil/trace.go:171","msg":"trace[251612936] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:6067; }","duration":"168.730935ms","start":"2026-05-05T07:00:56.740557Z","end":"2026-05-05T07:00:56.909288Z","steps":["trace[251612936] 'agreement among raft nodes before linearized reading' (duration: 166.827282ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:00:58.582654Z","caller":"traceutil/trace.go:171","msg":"trace[1327858001] linearizableReadLoop","detail":"{readStateIndex:6300; appliedIndex:6299; }","duration":"224.014188ms","start":"2026-05-05T07:00:58.358614Z","end":"2026-05-05T07:00:58.582629Z","steps":["trace[1327858001] 'read index received' (duration: 223.932286ms)","trace[1327858001] 'applied index is now lower than readState.Index' (duration: 80.732µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:00:58.582738Z","caller":"traceutil/trace.go:171","msg":"trace[525249208] transaction","detail":"{read_only:false; response_revision:6076; number_of_response:1; }","duration":"227.679182ms","start":"2026-05-05T07:00:58.355022Z","end":"2026-05-05T07:00:58.582701Z","steps":["trace[525249208] 'process raft request' (duration: 227.455887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:00:58.582886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.258424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-b9m2g\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-05-05T07:00:58.582929Z","caller":"traceutil/trace.go:171","msg":"trace[1233688596] range","detail":"{range_begin:/registry/pods/openstack/keepalived-b9m2g; range_end:; response_count:1; response_revision:6076; }","duration":"224.361007ms","start":"2026-05-05T07:00:58.358555Z","end":"2026-05-05T07:00:58.582916Z","steps":["trace[1233688596] 'agreement among raft nodes before linearized reading' (duration: 224.193753ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:05:20.675083Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5760} {"level":"info","ts":"2026-05-05T07:05:20.763451Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5760,"took":"86.277785ms","hash":1742613692,"current-db-size-bytes":55205888,"current-db-size":"55 MB","current-db-size-in-use-bytes":26099712,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-05T07:05:20.76352Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1742613692,"revision":5760,"compact-revision":2828} {"level":"warn","ts":"2026-05-05T07:05:55.205091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.439925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T07:05:55.205242Z","caller":"traceutil/trace.go:171","msg":"trace[1815460333] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:8302; }","duration":"592.626899ms","start":"2026-05-05T07:05:54.612573Z","end":"2026-05-05T07:05:55.2052Z","steps":["trace[1815460333] 'count revisions from in-memory index tree' (duration: 592.336393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:05:55.20522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.193888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T07:05:55.205289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:05:54.612552Z","time spent":"592.724922ms","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "} {"level":"info","ts":"2026-05-05T07:05:55.205307Z","caller":"traceutil/trace.go:171","msg":"trace[1168701788] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:8302; }","duration":"546.324462ms","start":"2026-05-05T07:05:54.658962Z","end":"2026-05-05T07:05:55.205287Z","steps":["trace[1168701788] 'count revisions from in-memory index tree' (duration: 546.117267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:05:55.205366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:05:54.658952Z","time spent":"546.402604ms","remote":"127.0.0.1:35048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-05-05T07:05:55.205208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.134319ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T07:05:55.205415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.835456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-05T07:05:55.205411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.091764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-05T07:05:55.20548Z","caller":"traceutil/trace.go:171","msg":"trace[169504855] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8302; }","duration":"606.929528ms","start":"2026-05-05T07:05:54.598533Z","end":"2026-05-05T07:05:55.205463Z","steps":["trace[169504855] 'range keys from in-memory index tree' (duration: 606.699813ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:05:55.20545Z","caller":"traceutil/trace.go:171","msg":"trace[1732862233] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8302; }","duration":"255.371204ms","start":"2026-05-05T07:05:54.950054Z","end":"2026-05-05T07:05:55.205426Z","steps":["trace[1732862233] 'range keys from in-memory index tree' (duration: 255.122868ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:05:55.205482Z","caller":"traceutil/trace.go:171","msg":"trace[1634395446] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8302; }","duration":"621.212357ms","start":"2026-05-05T07:05:54.584255Z","end":"2026-05-05T07:05:55.205468Z","steps":["trace[1634395446] 'range keys from in-memory index tree' (duration: 620.921931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:05:55.205518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:05:54.598522Z","time spent":"606.9878ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-05T07:05:55.205524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:05:54.584234Z","time spent":"621.282389ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T07:05:55.205505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.57323ms","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-05-05T07:05:55.205603Z","caller":"traceutil/trace.go:171","msg":"trace[1770183041] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8302; }","duration":"598.714934ms","start":"2026-05-05T07:05:54.606865Z","end":"2026-05-05T07:05:55.20558Z","steps":["trace[1770183041] 'range keys from in-memory index tree' (duration: 598.389626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:05:55.205649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:05:54.606854Z","time spent":"598.784045ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-05-05T07:05:55.205625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.025859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-05T07:05:55.205719Z","caller":"traceutil/trace.go:171","msg":"trace[2031235089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8302; }","duration":"620.174793ms","start":"2026-05-05T07:05:54.585523Z","end":"2026-05-05T07:05:55.205698Z","steps":["trace[2031235089] 'range keys from in-memory index tree' (duration: 619.825255ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:05:55.205764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:05:54.585503Z","time spent":"620.251795ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T07:05:55.205893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.755591ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T07:05:55.20596Z","caller":"traceutil/trace.go:171","msg":"trace[1426159440] transaction","detail":"{read_only:false; response_revision:8303; number_of_response:1; }","duration":"490.53768ms","start":"2026-05-05T07:05:54.715409Z","end":"2026-05-05T07:05:55.205947Z","steps":["trace[1426159440] 'process raft request' (duration: 202.652615ms)","trace[1426159440] 'compare' (duration: 287.036894ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T07:05:55.206013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:05:54.715386Z","time spent":"490.5993ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T07:06:06.528031Z","caller":"traceutil/trace.go:171","msg":"trace[719368298] transaction","detail":"{read_only:false; response_revision:8363; number_of_response:1; }","duration":"113.196894ms","start":"2026-05-05T07:06:06.414813Z","end":"2026-05-05T07:06:06.52801Z","steps":["trace[719368298] 'process raft request' (duration: 113.069641ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:08.326894Z","caller":"traceutil/trace.go:171","msg":"trace[781834662] transaction","detail":"{read_only:false; response_revision:8372; number_of_response:1; }","duration":"152.234309ms","start":"2026-05-05T07:06:08.174623Z","end":"2026-05-05T07:06:08.326857Z","steps":["trace[781834662] 'process raft request' (duration: 152.078685ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:09.533773Z","caller":"traceutil/trace.go:171","msg":"trace[1770756859] transaction","detail":"{read_only:false; response_revision:8381; number_of_response:1; }","duration":"111.141345ms","start":"2026-05-05T07:06:09.422606Z","end":"2026-05-05T07:06:09.533748Z","steps":["trace[1770756859] 'process raft request' (duration: 110.90662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:33.690247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.371276ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T07:06:33.690452Z","caller":"traceutil/trace.go:171","msg":"trace[2134471020] linearizableReadLoop","detail":"{readStateIndex:8864; appliedIndex:8862; }","duration":"100.834597ms","start":"2026-05-05T07:06:33.589594Z","end":"2026-05-05T07:06:33.690429Z","steps":["trace[2134471020] 'read index received' (duration: 42.021µs)","trace[2134471020] 'applied index is now lower than readState.Index' (duration: 100.791476ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:06:33.690556Z","caller":"traceutil/trace.go:171","msg":"trace[2113218802] transaction","detail":"{read_only:false; response_revision:8560; number_of_response:1; }","duration":"127.760582ms","start":"2026-05-05T07:06:33.562785Z","end":"2026-05-05T07:06:33.690546Z","steps":["trace[2113218802] 'process raft request' (duration: 127.586228ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:33.690583Z","caller":"traceutil/trace.go:171","msg":"trace[468563882] transaction","detail":"{read_only:false; response_revision:8559; number_of_response:1; }","duration":"133.871406ms","start":"2026-05-05T07:06:33.556678Z","end":"2026-05-05T07:06:33.690549Z","steps":["trace[468563882] 'compare' (duration: 128.203513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:33.690962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.332359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/rook-ceph/rook-ceph-csi-config\" ","response":"range_response_count:1 size:512"} {"level":"info","ts":"2026-05-05T07:06:33.691072Z","caller":"traceutil/trace.go:171","msg":"trace[1285216766] range","detail":"{range_begin:/registry/configmaps/rook-ceph/rook-ceph-csi-config; range_end:; response_count:1; response_revision:8560; }","duration":"101.492903ms","start":"2026-05-05T07:06:33.589551Z","end":"2026-05-05T07:06:33.691044Z","steps":["trace[1285216766] 'agreement among raft nodes before linearized reading' (duration: 101.209956ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:36.472992Z","caller":"traceutil/trace.go:171","msg":"trace[1294943960] transaction","detail":"{read_only:false; response_revision:8578; number_of_response:1; }","duration":"311.022541ms","start":"2026-05-05T07:06:36.161945Z","end":"2026-05-05T07:06:36.472968Z","steps":["trace[1294943960] 'process raft request' (duration: 310.680223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:36.473179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:06:36.161925Z","time spent":"311.152864ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T07:06:36.780567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.931912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-b9m2g\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-05-05T07:06:36.780665Z","caller":"traceutil/trace.go:171","msg":"trace[1411379395] range","detail":"{range_begin:/registry/pods/openstack/keepalived-b9m2g; range_end:; response_count:1; response_revision:8579; }","duration":"253.074995ms","start":"2026-05-05T07:06:36.527567Z","end":"2026-05-05T07:06:36.780642Z","steps":["trace[1411379395] 'range keys from in-memory index tree' (duration: 252.770498ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:36.781096Z","caller":"traceutil/trace.go:171","msg":"trace[480541013] transaction","detail":"{read_only:false; response_revision:8580; number_of_response:1; }","duration":"119.005745ms","start":"2026-05-05T07:06:36.662074Z","end":"2026-05-05T07:06:36.781079Z","steps":["trace[480541013] 'process raft request' (duration: 117.841728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:49.960859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.568484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T07:06:49.961305Z","caller":"traceutil/trace.go:171","msg":"trace[451236290] transaction","detail":"{read_only:false; response_revision:8688; number_of_response:1; }","duration":"291.012499ms","start":"2026-05-05T07:06:49.670273Z","end":"2026-05-05T07:06:49.961285Z","steps":["trace[451236290] 'process raft request' (duration: 290.691932ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:49.961363Z","caller":"traceutil/trace.go:171","msg":"trace[1702019018] linearizableReadLoop","detail":"{readStateIndex:8998; appliedIndex:8997; }","duration":"291.655125ms","start":"2026-05-05T07:06:49.66966Z","end":"2026-05-05T07:06:49.961315Z","steps":["trace[1702019018] 'read index received' (duration: 80.544559ms)","trace[1702019018] 'applied index is now lower than readState.Index' (duration: 211.106946ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:06:49.961497Z","caller":"traceutil/trace.go:171","msg":"trace[1903696316] transaction","detail":"{read_only:false; response_revision:8687; number_of_response:1; }","duration":"323.312851ms","start":"2026-05-05T07:06:49.638137Z","end":"2026-05-05T07:06:49.96145Z","steps":["trace[1903696316] 'process raft request' (duration: 112.053652ms)","trace[1903696316] 'compare' (duration: 210.361298ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T07:06:49.961552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.87619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-jcfwd\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-05-05T07:06:49.961595Z","caller":"traceutil/trace.go:171","msg":"trace[1738358935] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-jcfwd; range_end:; response_count:1; response_revision:8688; }","duration":"291.963172ms","start":"2026-05-05T07:06:49.66962Z","end":"2026-05-05T07:06:49.961583Z","steps":["trace[1738358935] 'agreement among raft nodes before linearized reading' (duration: 291.84367ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:49.961693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:06:49.638104Z","time spent":"323.487956ms","remote":"127.0.0.1:34862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4633,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T07:06:50.142461Z","caller":"traceutil/trace.go:171","msg":"trace[112154630] linearizableReadLoop","detail":"{readStateIndex:9000; appliedIndex:8999; }","duration":"180.980435ms","start":"2026-05-05T07:06:49.961445Z","end":"2026-05-05T07:06:50.142426Z","steps":["trace[112154630] 'read index received' (duration: 144.26294ms)","trace[112154630] 'applied index is now lower than readState.Index' (duration: 36.716395ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:06:50.142644Z","caller":"traceutil/trace.go:171","msg":"trace[605730966] transaction","detail":"{read_only:false; response_revision:8689; number_of_response:1; }","duration":"187.229892ms","start":"2026-05-05T07:06:49.955363Z","end":"2026-05-05T07:06:50.142593Z","steps":["trace[605730966] 'process raft request' (duration: 150.323462ms)","trace[605730966] 'compare' (duration: 36.597183ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T07:06:50.142763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.259327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-05T07:06:50.142846Z","caller":"traceutil/trace.go:171","msg":"trace[144145761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8689; }","duration":"373.40902ms","start":"2026-05-05T07:06:49.769415Z","end":"2026-05-05T07:06:50.142824Z","steps":["trace[144145761] 'agreement among raft nodes before linearized reading' (duration: 373.156354ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:50.14267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.295095ms","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":"warn","ts":"2026-05-05T07:06:50.142903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:06:49.769396Z","time spent":"373.494403ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T07:06:50.142924Z","caller":"traceutil/trace.go:171","msg":"trace[455784332] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8689; }","duration":"347.575882ms","start":"2026-05-05T07:06:49.795319Z","end":"2026-05-05T07:06:50.142895Z","steps":["trace[455784332] 'agreement among raft nodes before linearized reading' (duration: 347.167552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:50.143023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.246771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-05T07:06:50.143088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:06:49.795308Z","time spent":"347.759956ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-05-05T07:06:50.143128Z","caller":"traceutil/trace.go:171","msg":"trace[1675195597] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8689; }","duration":"377.399435ms","start":"2026-05-05T07:06:49.765701Z","end":"2026-05-05T07:06:50.143101Z","steps":["trace[1675195597] 'agreement among raft nodes before linearized reading' (duration: 377.149849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:50.143193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:06:49.765681Z","time spent":"377.498807ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T07:06:50.143507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.595657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-05T07:06:50.143575Z","caller":"traceutil/trace.go:171","msg":"trace[1490366490] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8689; }","duration":"368.68699ms","start":"2026-05-05T07:06:49.774871Z","end":"2026-05-05T07:06:50.143558Z","steps":["trace[1490366490] 'agreement among raft nodes before linearized reading' (duration: 367.672736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:50.143826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:06:49.774856Z","time spent":"368.955296ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-05T07:06:50.147142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.690088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-jcfwd\" ","response":"range_response_count:1 size:4653"} {"level":"info","ts":"2026-05-05T07:06:50.147196Z","caller":"traceutil/trace.go:171","msg":"trace[107878045] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-jcfwd; range_end:; response_count:1; response_revision:8690; }","duration":"180.78542ms","start":"2026-05-05T07:06:49.966398Z","end":"2026-05-05T07:06:50.147184Z","steps":["trace[107878045] 'agreement among raft nodes before linearized reading' (duration: 180.703148ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:50.14743Z","caller":"traceutil/trace.go:171","msg":"trace[673340653] transaction","detail":"{read_only:false; response_revision:8690; number_of_response:1; }","duration":"177.885372ms","start":"2026-05-05T07:06:49.969531Z","end":"2026-05-05T07:06:50.147416Z","steps":["trace[673340653] 'process raft request' (duration: 176.835707ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:51.202686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.142046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T07:06:51.202782Z","caller":"traceutil/trace.go:171","msg":"trace[1774580095] linearizableReadLoop","detail":"{readStateIndex:9011; appliedIndex:9010; }","duration":"315.970208ms","start":"2026-05-05T07:06:50.886797Z","end":"2026-05-05T07:06:51.202767Z","steps":["trace[1774580095] 'read index received' (duration: 9.622967ms)","trace[1774580095] 'applied index is now lower than readState.Index' (duration: 306.346091ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:06:51.20286Z","caller":"traceutil/trace.go:171","msg":"trace[769925567] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"318.19025ms","start":"2026-05-05T07:06:50.88466Z","end":"2026-05-05T07:06:51.20285Z","steps":["trace[769925567] 'process raft request' (duration: 11.86602ms)","trace[769925567] 'compare' (duration: 305.985262ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T07:06:51.202934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:06:50.884636Z","time spent":"318.270793ms","remote":"127.0.0.1:34940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T07:06:51.202996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.633931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-05-05T07:06:51.203079Z","caller":"traceutil/trace.go:171","msg":"trace[1945109474] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:8700; }","duration":"251.745134ms","start":"2026-05-05T07:06:50.951312Z","end":"2026-05-05T07:06:51.203057Z","steps":["trace[1945109474] 'agreement among raft nodes before linearized reading' (duration: 251.55189ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:51.203287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.639086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T07:06:51.203333Z","caller":"traceutil/trace.go:171","msg":"trace[585596058] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:8700; }","duration":"160.705688ms","start":"2026-05-05T07:06:51.042612Z","end":"2026-05-05T07:06:51.203318Z","steps":["trace[585596058] 'agreement among raft nodes before linearized reading' (duration: 160.635017ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:51.203823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.984772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228468"} {"level":"info","ts":"2026-05-05T07:06:51.203906Z","caller":"traceutil/trace.go:171","msg":"trace[425910371] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8700; }","duration":"317.115165ms","start":"2026-05-05T07:06:50.886773Z","end":"2026-05-05T07:06:51.203888Z","steps":["trace[425910371] 'agreement among raft nodes before linearized reading' (duration: 316.51074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:51.203952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T07:06:50.886739Z","time spent":"317.202517ms","remote":"127.0.0.1:34862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":26,"response size":228491,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-05-05T07:06:52.340662Z","caller":"traceutil/trace.go:171","msg":"trace[1073311428] transaction","detail":"{read_only:false; response_revision:8707; number_of_response:1; }","duration":"170.618092ms","start":"2026-05-05T07:06:52.170024Z","end":"2026-05-05T07:06:52.340642Z","steps":["trace[1073311428] 'process raft request' (duration: 170.397817ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:06:52.340838Z","caller":"traceutil/trace.go:171","msg":"trace[1835946892] linearizableReadLoop","detail":"{readStateIndex:9019; appliedIndex:9017; }","duration":"152.212558ms","start":"2026-05-05T07:06:52.188591Z","end":"2026-05-05T07:06:52.340804Z","steps":["trace[1835946892] 'read index received' (duration: 151.800798ms)","trace[1835946892] 'applied index is now lower than readState.Index' (duration: 409.64µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:06:52.340861Z","caller":"traceutil/trace.go:171","msg":"trace[252497321] transaction","detail":"{read_only:false; response_revision:8708; number_of_response:1; }","duration":"170.393016ms","start":"2026-05-05T07:06:52.170429Z","end":"2026-05-05T07:06:52.340822Z","steps":["trace[252497321] 'process raft request' (duration: 170.169501ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:06:52.341031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.441124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-05T07:06:52.341652Z","caller":"traceutil/trace.go:171","msg":"trace[1860234831] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8708; }","duration":"153.061738ms","start":"2026-05-05T07:06:52.18854Z","end":"2026-05-05T07:06:52.341602Z","steps":["trace[1860234831] 'agreement among raft nodes before linearized reading' (duration: 152.357911ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:07:32.862776Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024bd.wal"} {"level":"warn","ts":"2026-05-05T07:07:49.624319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.233768ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T07:07:49.625164Z","caller":"traceutil/trace.go:171","msg":"trace[1390537442] transaction","detail":"{read_only:false; response_revision:9334; number_of_response:1; }","duration":"219.617997ms","start":"2026-05-05T07:07:49.405474Z","end":"2026-05-05T07:07:49.625092Z","steps":["trace[1390537442] 'process raft request' (duration: 219.240478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:07:49.625276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.476712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-05T07:07:49.625331Z","caller":"traceutil/trace.go:171","msg":"trace[1148394221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9334; }","duration":"154.584064ms","start":"2026-05-05T07:07:49.470734Z","end":"2026-05-05T07:07:49.625318Z","steps":["trace[1148394221] 'agreement among raft nodes before linearized reading' (duration: 154.4195ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:07:49.625515Z","caller":"traceutil/trace.go:171","msg":"trace[1549426145] linearizableReadLoop","detail":"{readStateIndex:9661; appliedIndex:9659; }","duration":"154.112443ms","start":"2026-05-05T07:07:49.4708Z","end":"2026-05-05T07:07:49.624912Z","steps":["trace[1549426145] 'read index received' (duration: 54.341µs)","trace[1549426145] 'applied index is now lower than readState.Index' (duration: 154.057062ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:08:01.313802Z","caller":"traceutil/trace.go:171","msg":"trace[771629265] transaction","detail":"{read_only:false; response_revision:9412; number_of_response:1; }","duration":"167.314293ms","start":"2026-05-05T07:08:01.146434Z","end":"2026-05-05T07:08:01.313749Z","steps":["trace[771629265] 'process raft request' (duration: 167.089418ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:08:35.274932Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1c917701ce165bac","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-05T07:08:35.280428Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-05T07:08:35.280494Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-05T07:09:55.301559Z","caller":"traceutil/trace.go:171","msg":"trace[1087445568] transaction","detail":"{read_only:false; response_revision:10223; number_of_response:1; }","duration":"107.567703ms","start":"2026-05-05T07:09:55.193969Z","end":"2026-05-05T07:09:55.301536Z","steps":["trace[1087445568] 'process raft request' (duration: 107.44441ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:09:55.303476Z","caller":"traceutil/trace.go:171","msg":"trace[1976980913] transaction","detail":"{read_only:false; response_revision:10224; number_of_response:1; }","duration":"108.624219ms","start":"2026-05-05T07:09:55.19483Z","end":"2026-05-05T07:09:55.303455Z","steps":["trace[1976980913] 'process raft request' (duration: 108.208469ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:10:20.685645Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7947} {"level":"info","ts":"2026-05-05T07:10:20.753317Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7947,"took":"65.81889ms","hash":3654374780,"current-db-size-bytes":55205888,"current-db-size":"55 MB","current-db-size-in-use-bytes":29274112,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-05T07:10:20.753377Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3654374780,"revision":7947,"compact-revision":5760} {"level":"info","ts":"2026-05-05T07:11:35.400388Z","caller":"traceutil/trace.go:171","msg":"trace[901361075] transaction","detail":"{read_only:false; response_revision:11203; number_of_response:1; }","duration":"112.89521ms","start":"2026-05-05T07:11:35.287452Z","end":"2026-05-05T07:11:35.400347Z","steps":["trace[901361075] 'process raft request' (duration: 112.659284ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:11:35.958507Z","caller":"traceutil/trace.go:171","msg":"trace[856646692] linearizableReadLoop","detail":"{readStateIndex:11586; appliedIndex:11585; }","duration":"122.021069ms","start":"2026-05-05T07:11:35.836465Z","end":"2026-05-05T07:11:35.958486Z","steps":["trace[856646692] 'read index received' (duration: 121.797273ms)","trace[856646692] 'applied index is now lower than readState.Index' (duration: 222.866µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:11:35.958594Z","caller":"traceutil/trace.go:171","msg":"trace[1769887736] transaction","detail":"{read_only:false; response_revision:11204; number_of_response:1; }","duration":"124.792265ms","start":"2026-05-05T07:11:35.833766Z","end":"2026-05-05T07:11:35.958558Z","steps":["trace[1769887736] 'process raft request' (duration: 124.57372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:11:35.958719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.233134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-05T07:11:35.958766Z","caller":"traceutil/trace.go:171","msg":"trace[787975132] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11204; }","duration":"122.312106ms","start":"2026-05-05T07:11:35.836439Z","end":"2026-05-05T07:11:35.958751Z","steps":["trace[787975132] 'agreement among raft nodes before linearized reading' (duration: 122.171023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:11:35.958768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.919053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T07:11:35.958902Z","caller":"traceutil/trace.go:171","msg":"trace[1476624563] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11204; }","duration":"111.082596ms","start":"2026-05-05T07:11:35.847798Z","end":"2026-05-05T07:11:35.958881Z","steps":["trace[1476624563] 'agreement among raft nodes before linearized reading' (duration: 110.905982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:11:35.959138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.42716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T07:11:35.959204Z","caller":"traceutil/trace.go:171","msg":"trace[2006449151] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11204; }","duration":"110.507783ms","start":"2026-05-05T07:11:35.848677Z","end":"2026-05-05T07:11:35.959185Z","steps":["trace[2006449151] 'agreement among raft nodes before linearized reading' (duration: 110.41494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:11:35.95926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.401634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T07:11:35.959312Z","caller":"traceutil/trace.go:171","msg":"trace[247530004] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11204; }","duration":"111.482396ms","start":"2026-05-05T07:11:35.847817Z","end":"2026-05-05T07:11:35.9593Z","steps":["trace[247530004] 'agreement among raft nodes before linearized reading' (duration: 111.380194ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:11:35.959326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.685797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T07:11:35.959426Z","caller":"traceutil/trace.go:171","msg":"trace[889448551] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11204; }","duration":"110.82106ms","start":"2026-05-05T07:11:35.848594Z","end":"2026-05-05T07:11:35.959415Z","steps":["trace[889448551] 'agreement among raft nodes before linearized reading' (duration: 110.706237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:11:35.95946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.857295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5079"} {"level":"info","ts":"2026-05-05T07:11:35.9595Z","caller":"traceutil/trace.go:171","msg":"trace[1230570558] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11204; }","duration":"106.919137ms","start":"2026-05-05T07:11:35.852571Z","end":"2026-05-05T07:11:35.95949Z","steps":["trace[1230570558] 'agreement among raft nodes before linearized reading' (duration: 106.735272ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:11:35.959727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.541587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-05-05T07:11:35.959949Z","caller":"traceutil/trace.go:171","msg":"trace[67030566] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:11204; }","duration":"111.812854ms","start":"2026-05-05T07:11:35.848109Z","end":"2026-05-05T07:11:35.959922Z","steps":["trace[67030566] 'agreement among raft nodes before linearized reading' (duration: 111.279601ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:11:36.092452Z","caller":"traceutil/trace.go:171","msg":"trace[1869491876] transaction","detail":"{read_only:false; response_revision:11205; number_of_response:1; }","duration":"128.812382ms","start":"2026-05-05T07:11:35.963607Z","end":"2026-05-05T07:11:36.092419Z","steps":["trace[1869491876] 'process raft request' (duration: 128.620027ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:11:36.13181Z","caller":"traceutil/trace.go:171","msg":"trace[1816146111] linearizableReadLoop","detail":"{readStateIndex:11589; appliedIndex:11586; }","duration":"157.47976ms","start":"2026-05-05T07:11:35.974305Z","end":"2026-05-05T07:11:36.131785Z","steps":["trace[1816146111] 'read index received' (duration: 118.023183ms)","trace[1816146111] 'applied index is now lower than readState.Index' (duration: 39.455376ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T07:11:36.131867Z","caller":"traceutil/trace.go:171","msg":"trace[1359444994] transaction","detail":"{read_only:false; response_revision:11206; number_of_response:1; }","duration":"167.89999ms","start":"2026-05-05T07:11:35.963932Z","end":"2026-05-05T07:11:36.131832Z","steps":["trace[1359444994] 'process raft request' (duration: 167.603223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T07:11:36.132105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.775817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T07:11:36.132171Z","caller":"traceutil/trace.go:171","msg":"trace[624206826] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:11207; }","duration":"157.89308ms","start":"2026-05-05T07:11:35.974259Z","end":"2026-05-05T07:11:36.132152Z","steps":["trace[624206826] 'agreement among raft nodes before linearized reading' (duration: 157.741527ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:11:36.132281Z","caller":"traceutil/trace.go:171","msg":"trace[970070919] transaction","detail":"{read_only:false; response_revision:11207; number_of_response:1; }","duration":"167.209504ms","start":"2026-05-05T07:11:35.964674Z","end":"2026-05-05T07:11:36.131883Z","steps":["trace[970070919] 'process raft request' (duration: 167.021859ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:11:36.879586Z","caller":"traceutil/trace.go:171","msg":"trace[1161074269] transaction","detail":"{read_only:false; response_revision:11210; number_of_response:1; }","duration":"232.120421ms","start":"2026-05-05T07:11:36.647433Z","end":"2026-05-05T07:11:36.879554Z","steps":["trace[1161074269] 'process raft request' (duration: 231.794173ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T07:15:20.693633Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10473} {"level":"info","ts":"2026-05-05T07:15:20.774137Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10473,"took":"78.039792ms","hash":1107433583,"current-db-size-bytes":55205888,"current-db-size":"55 MB","current-db-size-in-use-bytes":26345472,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-05T07:15:20.774198Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1107433583,"revision":10473,"compact-revision":7947} {"level":"info","ts":"2026-05-05T07:20:20.70074Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12642} {"level":"info","ts":"2026-05-05T07:20:20.779223Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12642,"took":"76.0129ms","hash":3819944496,"current-db-size-bytes":55205888,"current-db-size":"55 MB","current-db-size-in-use-bytes":24846336,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-05-05T07:20:20.779296Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3819944496,"revision":12642,"compact-revision":10473}