{"level":"warn","ts":"2026-04-20T08:11:09.142025Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T08:11:09.142174Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.175:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.175:2380","--initial-cluster=instance=https://199.19.213.175:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.175:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.175:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-20T08:11:09.142248Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T08:11:09.142255Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.175:2380"]} {"level":"info","ts":"2026-04-20T08:11:09.142272Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T08:11:09.142926Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"]} {"level":"info","ts":"2026-04-20T08:11:09.143009Z","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.19.213.175:2380"],"listen-peer-urls":["https://199.19.213.175:2380"],"advertise-client-urls":["https://199.19.213.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.175:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-20T08:11:09.146624Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.397189ms"} {"level":"info","ts":"2026-04-20T08:11:09.156949Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"223c7693b78843e1","cluster-id":"b697af90308fdc01"} {"level":"info","ts":"2026-04-20T08:11:09.157094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T08:11:09.157126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became follower at term 0"} {"level":"info","ts":"2026-04-20T08:11:09.157148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 223c7693b78843e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T08:11:09.157167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became follower at term 1"} {"level":"info","ts":"2026-04-20T08:11:09.157219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=(2466977072703620065)"} {"level":"warn","ts":"2026-04-20T08:11:09.16419Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T08:11:09.165633Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T08:11:09.167475Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-20T08:11:09.170056Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"223c7693b78843e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T08:11:09.170288Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"223c7693b78843e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T08:11:09.170463Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:11:09.170559Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:11:09.170575Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:11:09.171513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=(2466977072703620065)"} {"level":"info","ts":"2026-04-20T08:11:09.171873Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b697af90308fdc01","local-member-id":"223c7693b78843e1","added-peer-id":"223c7693b78843e1","added-peer-peer-urls":["https://199.19.213.175:2380"]} {"level":"info","ts":"2026-04-20T08:11:09.175075Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T08:11:09.175198Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.175:2380"} {"level":"info","ts":"2026-04-20T08:11:09.175239Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.175:2380"} {"level":"info","ts":"2026-04-20T08:11:09.175788Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"223c7693b78843e1","initial-advertise-peer-urls":["https://199.19.213.175:2380"],"listen-peer-urls":["https://199.19.213.175:2380"],"advertise-client-urls":["https://199.19.213.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T08:11:09.175827Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T08:11:09.357482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T08:11:09.357549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T08:11:09.357592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 received MsgPreVoteResp from 223c7693b78843e1 at term 1"} {"level":"info","ts":"2026-04-20T08:11:09.357664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became candidate at term 2"} {"level":"info","ts":"2026-04-20T08:11:09.357683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 received MsgVoteResp from 223c7693b78843e1 at term 2"} {"level":"info","ts":"2026-04-20T08:11:09.357732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became leader at term 2"} {"level":"info","ts":"2026-04-20T08:11:09.357771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 223c7693b78843e1 elected leader 223c7693b78843e1 at term 2"} {"level":"info","ts":"2026-04-20T08:11:09.358932Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"223c7693b78843e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.175:2379]}","request-path":"/0/members/223c7693b78843e1/attributes","cluster-id":"b697af90308fdc01","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T08:11:09.358987Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:11:09.359292Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:11:09.359518Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:11:09.359867Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T08:11:09.359925Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T08:11:09.360833Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b697af90308fdc01","local-member-id":"223c7693b78843e1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:11:09.360931Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:11:09.360981Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:11:09.362978Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.175:2379"} {"level":"info","ts":"2026-04-20T08:11:09.364023Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T08:11:39.693696Z","caller":"traceutil/trace.go:171","msg":"trace[336454889] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"111.250223ms","start":"2026-04-20T08:11:39.582423Z","end":"2026-04-20T08:11:39.693674Z","steps":["trace[336454889] 'process raft request' (duration: 109.089382ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:39.693929Z","caller":"traceutil/trace.go:171","msg":"trace[1316537038] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"111.464869ms","start":"2026-04-20T08:11:39.582434Z","end":"2026-04-20T08:11:39.693899Z","steps":["trace[1316537038] 'process raft request' (duration: 111.204213ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:41.837013Z","caller":"traceutil/trace.go:171","msg":"trace[519685431] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"133.138747ms","start":"2026-04-20T08:11:41.703847Z","end":"2026-04-20T08:11:41.836986Z","steps":["trace[519685431] 'process raft request' (duration: 75.951404ms)","trace[519685431] 'compare' (duration: 57.08095ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:11:41.847363Z","caller":"traceutil/trace.go:171","msg":"trace[354878243] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"111.178442ms","start":"2026-04-20T08:11:41.73613Z","end":"2026-04-20T08:11:41.847308Z","steps":["trace[354878243] 'process raft request' (duration: 110.998248ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:41.847419Z","caller":"traceutil/trace.go:171","msg":"trace[1329349877] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"114.032619ms","start":"2026-04-20T08:11:41.733327Z","end":"2026-04-20T08:11:41.84736Z","steps":["trace[1329349877] 'process raft request' (duration: 113.700271ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:41.847475Z","caller":"traceutil/trace.go:171","msg":"trace[491527679] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"107.756961ms","start":"2026-04-20T08:11:41.739695Z","end":"2026-04-20T08:11:41.847452Z","steps":["trace[491527679] 'process raft request' (duration: 107.460044ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:41.848086Z","caller":"traceutil/trace.go:171","msg":"trace[1615579735] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"143.94077ms","start":"2026-04-20T08:11:41.704115Z","end":"2026-04-20T08:11:41.848056Z","steps":["trace[1615579735] 'process raft request' (duration: 142.826034ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:48.44628Z","caller":"traceutil/trace.go:171","msg":"trace[1479053675] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"377.957017ms","start":"2026-04-20T08:11:48.068285Z","end":"2026-04-20T08:11:48.446243Z","steps":["trace[1479053675] 'process raft request' (duration: 377.779502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.449312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:11:48.068258Z","time spent":"379.039343ms","remote":"127.0.0.1:52920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:11:48.495225Z","caller":"traceutil/trace.go:171","msg":"trace[879726644] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"357.940428ms","start":"2026-04-20T08:11:48.137231Z","end":"2026-04-20T08:11:48.495171Z","steps":["trace[879726644] 'process raft request' (duration: 357.18219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.495443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:11:48.137185Z","time spent":"358.142432ms","remote":"127.0.0.1:52848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:11:48.509107Z","caller":"traceutil/trace.go:171","msg":"trace[1950551948] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:643; }","duration":"369.922259ms","start":"2026-04-20T08:11:48.139147Z","end":"2026-04-20T08:11:48.509069Z","steps":["trace[1950551948] 'read index received' (duration: 306.94045ms)","trace[1950551948] 'applied index is now lower than readState.Index' (duration: 62.979829ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:11:48.509402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.163745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:11:48.509474Z","caller":"traceutil/trace.go:171","msg":"trace[1073497812] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"370.336988ms","start":"2026-04-20T08:11:48.139123Z","end":"2026-04-20T08:11:48.50946Z","steps":["trace[1073497812] 'agreement among raft nodes before linearized reading' (duration: 370.139584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.50954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:11:48.139111Z","time spent":"370.41494ms","remote":"127.0.0.1:46588","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-04-20T08:11:48.509526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.926162ms","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-04-20T08:11:48.50958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.456357ms","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":"info","ts":"2026-04-20T08:11:48.50963Z","caller":"traceutil/trace.go:171","msg":"trace[2103655265] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"305.134688ms","start":"2026-04-20T08:11:48.204468Z","end":"2026-04-20T08:11:48.509603Z","steps":["trace[2103655265] 'agreement among raft nodes before linearized reading' (duration: 304.861551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.50961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.66444ms","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-04-20T08:11:48.509673Z","caller":"traceutil/trace.go:171","msg":"trace[734748447] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"274.57207ms","start":"2026-04-20T08:11:48.23508Z","end":"2026-04-20T08:11:48.509652Z","steps":["trace[734748447] 'agreement among raft nodes before linearized reading' (duration: 274.401936ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:48.509712Z","caller":"traceutil/trace.go:171","msg":"trace[1645083765] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:625; }","duration":"208.862966ms","start":"2026-04-20T08:11:48.300828Z","end":"2026-04-20T08:11:48.509691Z","steps":["trace[1645083765] 'agreement among raft nodes before linearized reading' (duration: 208.63777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.509733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.927487ms","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-04-20T08:11:48.509762Z","caller":"traceutil/trace.go:171","msg":"trace[820010424] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"275.03206ms","start":"2026-04-20T08:11:48.234722Z","end":"2026-04-20T08:11:48.509754Z","steps":["trace[820010424] 'agreement among raft nodes before linearized reading' (duration: 274.982339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.509962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.99937ms","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-04-20T08:11:48.509994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.852691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:11:48.509999Z","caller":"traceutil/trace.go:171","msg":"trace[1602136835] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:625; }","duration":"235.076352ms","start":"2026-04-20T08:11:48.274915Z","end":"2026-04-20T08:11:48.509991Z","steps":["trace[1602136835] 'agreement among raft nodes before linearized reading' (duration: 235.01176ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:48.510025Z","caller":"traceutil/trace.go:171","msg":"trace[1327485165] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"370.920492ms","start":"2026-04-20T08:11:48.139097Z","end":"2026-04-20T08:11:48.510017Z","steps":["trace[1327485165] 'agreement among raft nodes before linearized reading' (duration: 370.869301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.510049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.43915ms","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-04-20T08:11:48.510058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:11:48.139079Z","time spent":"370.969663ms","remote":"127.0.0.1:46588","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":"info","ts":"2026-04-20T08:11:48.510082Z","caller":"traceutil/trace.go:171","msg":"trace[825756963] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"275.489891ms","start":"2026-04-20T08:11:48.234584Z","end":"2026-04-20T08:11:48.510074Z","steps":["trace[825756963] 'agreement among raft nodes before linearized reading' (duration: 275.438689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.510102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.526096ms","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-04-20T08:11:48.510167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.066125ms","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":"info","ts":"2026-04-20T08:11:48.51017Z","caller":"traceutil/trace.go:171","msg":"trace[2107833156] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"305.590807ms","start":"2026-04-20T08:11:48.204561Z","end":"2026-04-20T08:11:48.510151Z","steps":["trace[2107833156] 'agreement among raft nodes before linearized reading' (duration: 305.501595ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:48.510205Z","caller":"traceutil/trace.go:171","msg":"trace[1401079623] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:625; }","duration":"236.160836ms","start":"2026-04-20T08:11:48.274035Z","end":"2026-04-20T08:11:48.510195Z","steps":["trace[1401079623] 'agreement among raft nodes before linearized reading' (duration: 236.105645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.510219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.768376ms","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-04-20T08:11:48.510221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:11:48.204449Z","time spent":"305.757902ms","remote":"127.0.0.1:46598","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-04-20T08:11:48.510245Z","caller":"traceutil/trace.go:171","msg":"trace[1338980397] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:625; }","duration":"114.807566ms","start":"2026-04-20T08:11:48.39543Z","end":"2026-04-20T08:11:48.510237Z","steps":["trace[1338980397] 'agreement among raft nodes before linearized reading' (duration: 114.762165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.510335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.537545ms","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-04-20T08:11:48.510364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.438259ms","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-04-20T08:11:48.510399Z","caller":"traceutil/trace.go:171","msg":"trace[224009199] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:625; }","duration":"209.544831ms","start":"2026-04-20T08:11:48.300847Z","end":"2026-04-20T08:11:48.510391Z","steps":["trace[224009199] 'agreement among raft nodes before linearized reading' (duration: 209.48784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.510528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.115424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:11:48.510556Z","caller":"traceutil/trace.go:171","msg":"trace[1990953993] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:625; }","duration":"115.204616ms","start":"2026-04-20T08:11:48.395344Z","end":"2026-04-20T08:11:48.510549Z","steps":["trace[1990953993] 'agreement among raft nodes before linearized reading' (duration: 115.162175ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:48.51037Z","caller":"traceutil/trace.go:171","msg":"trace[472679451] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:625; }","duration":"236.609857ms","start":"2026-04-20T08:11:48.273752Z","end":"2026-04-20T08:11:48.510362Z","steps":["trace[472679451] 'agreement among raft nodes before linearized reading' (duration: 236.552916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.510647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.170394ms","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":"warn","ts":"2026-04-20T08:11:48.51065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.042827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:11:48.510697Z","caller":"traceutil/trace.go:171","msg":"trace[1000209706] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:625; }","duration":"116.136349ms","start":"2026-04-20T08:11:48.39455Z","end":"2026-04-20T08:11:48.510687Z","steps":["trace[1000209706] 'agreement among raft nodes before linearized reading' (duration: 116.055097ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:48.510714Z","caller":"traceutil/trace.go:171","msg":"trace[131007805] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:625; }","duration":"209.235745ms","start":"2026-04-20T08:11:48.301443Z","end":"2026-04-20T08:11:48.510679Z","steps":["trace[131007805] 'agreement among raft nodes before linearized reading' (duration: 209.109131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.509682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:11:48.204445Z","time spent":"305.225629ms","remote":"127.0.0.1:46598","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-04-20T08:11:48.794112Z","caller":"traceutil/trace.go:171","msg":"trace[487861233] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"216.252859ms","start":"2026-04-20T08:11:48.577829Z","end":"2026-04-20T08:11:48.794082Z","steps":["trace[487861233] 'read index received' (duration: 215.946882ms)","trace[487861233] 'applied index is now lower than readState.Index' (duration: 304.867µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:11:48.794182Z","caller":"traceutil/trace.go:171","msg":"trace[967100666] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"241.37865ms","start":"2026-04-20T08:11:48.552762Z","end":"2026-04-20T08:11:48.794141Z","steps":["trace[967100666] 'process raft request' (duration: 241.083793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.794351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.496525ms","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-04-20T08:11:48.794373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.26281ms","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-04-20T08:11:48.794409Z","caller":"traceutil/trace.go:171","msg":"trace[1823733916] 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:626; }","duration":"216.602278ms","start":"2026-04-20T08:11:48.577787Z","end":"2026-04-20T08:11:48.79439Z","steps":["trace[1823733916] 'agreement among raft nodes before linearized reading' (duration: 216.437595ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:48.794422Z","caller":"traceutil/trace.go:171","msg":"trace[1184608871] 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:626; }","duration":"216.405613ms","start":"2026-04-20T08:11:48.578Z","end":"2026-04-20T08:11:48.794406Z","steps":["trace[1184608871] 'agreement among raft nodes before linearized reading' (duration: 216.256989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.794513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.594757ms","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-04-20T08:11:48.794611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.553459ms","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":"info","ts":"2026-04-20T08:11:48.794679Z","caller":"traceutil/trace.go:171","msg":"trace[1736618494] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:626; }","duration":"121.801412ms","start":"2026-04-20T08:11:48.672815Z","end":"2026-04-20T08:11:48.794616Z","steps":["trace[1736618494] 'agreement among raft nodes before linearized reading' (duration: 121.491944ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:48.79473Z","caller":"traceutil/trace.go:171","msg":"trace[1705546633] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:626; }","duration":"122.714463ms","start":"2026-04-20T08:11:48.672Z","end":"2026-04-20T08:11:48.794714Z","steps":["trace[1705546633] 'agreement among raft nodes before linearized reading' (duration: 122.58113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.794752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.587737ms","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-04-20T08:11:48.794781Z","caller":"traceutil/trace.go:171","msg":"trace[1143347168] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"170.644348ms","start":"2026-04-20T08:11:48.624128Z","end":"2026-04-20T08:11:48.794772Z","steps":["trace[1143347168] 'agreement among raft nodes before linearized reading' (duration: 170.595177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.794905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.576867ms","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":"warn","ts":"2026-04-20T08:11:48.794927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.926478ms","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-04-20T08:11:48.794943Z","caller":"traceutil/trace.go:171","msg":"trace[1857228344] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"196.657839ms","start":"2026-04-20T08:11:48.598276Z","end":"2026-04-20T08:11:48.794934Z","steps":["trace[1857228344] 'agreement among raft nodes before linearized reading' (duration: 196.599478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.794945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.669559ms","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-04-20T08:11:48.794981Z","caller":"traceutil/trace.go:171","msg":"trace[916070480] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"170.745141ms","start":"2026-04-20T08:11:48.624226Z","end":"2026-04-20T08:11:48.794972Z","steps":["trace[916070480] 'agreement among raft nodes before linearized reading' (duration: 170.684129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.795007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.592584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:11:48.794957Z","caller":"traceutil/trace.go:171","msg":"trace[555933516] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:626; }","duration":"122.993059ms","start":"2026-04-20T08:11:48.671953Z","end":"2026-04-20T08:11:48.794946Z","steps":["trace[555933516] 'agreement among raft nodes before linearized reading' (duration: 122.943948ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:48.795042Z","caller":"traceutil/trace.go:171","msg":"trace[564064412] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"169.643865ms","start":"2026-04-20T08:11:48.625389Z","end":"2026-04-20T08:11:48.795033Z","steps":["trace[564064412] 'agreement among raft nodes before linearized reading' (duration: 169.587304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.795072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.032362ms","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-04-20T08:11:48.795103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.92274ms","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-04-20T08:11:48.795121Z","caller":"traceutil/trace.go:171","msg":"trace[755322134] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"198.103964ms","start":"2026-04-20T08:11:48.597002Z","end":"2026-04-20T08:11:48.795106Z","steps":["trace[755322134] 'agreement among raft nodes before linearized reading' (duration: 198.035312ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:11:48.795161Z","caller":"traceutil/trace.go:171","msg":"trace[206131635] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"197.94851ms","start":"2026-04-20T08:11:48.59717Z","end":"2026-04-20T08:11:48.795119Z","steps":["trace[206131635] 'agreement among raft nodes before linearized reading' (duration: 197.910399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.795251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.931275ms","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-04-20T08:11:48.795288Z","caller":"traceutil/trace.go:171","msg":"trace[525263768] 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:626; }","duration":"216.977166ms","start":"2026-04-20T08:11:48.5783Z","end":"2026-04-20T08:11:48.795277Z","steps":["trace[525263768] 'agreement among raft nodes before linearized reading' (duration: 216.922985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.97867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.840746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:11:48.978746Z","caller":"traceutil/trace.go:171","msg":"trace[1725790682] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:626; }","duration":"102.975109ms","start":"2026-04-20T08:11:48.875753Z","end":"2026-04-20T08:11:48.978728Z","steps":["trace[1725790682] 'count revisions from in-memory index tree' (duration: 102.753694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.978955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.107612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:11:48.979009Z","caller":"traceutil/trace.go:171","msg":"trace[1304196966] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:626; }","duration":"103.204325ms","start":"2026-04-20T08:11:48.875793Z","end":"2026-04-20T08:11:48.978997Z","steps":["trace[1304196966] 'range keys from in-memory index tree' (duration: 103.01634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:11:48.979199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.288313ms","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":"info","ts":"2026-04-20T08:11:48.979241Z","caller":"traceutil/trace.go:171","msg":"trace[2041332029] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:626; }","duration":"102.335534ms","start":"2026-04-20T08:11:48.876896Z","end":"2026-04-20T08:11:48.979232Z","steps":["trace[2041332029] 'range keys from in-memory index tree' (duration: 102.15462ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.069529Z","caller":"traceutil/trace.go:171","msg":"trace[765452689] linearizableReadLoop","detail":"{readStateIndex:1910; appliedIndex:1909; }","duration":"132.586862ms","start":"2026-04-20T08:13:16.936915Z","end":"2026-04-20T08:13:17.069502Z","steps":["trace[765452689] 'read index received' (duration: 132.306205ms)","trace[765452689] 'applied index is now lower than readState.Index' (duration: 279.567µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:13:17.069743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.803326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-04-20T08:13:17.069711Z","caller":"traceutil/trace.go:171","msg":"trace[1069711660] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"238.362442ms","start":"2026-04-20T08:13:16.831287Z","end":"2026-04-20T08:13:17.069649Z","steps":["trace[1069711660] 'process raft request' (duration: 238.051575ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:17.069789Z","caller":"traceutil/trace.go:171","msg":"trace[306207527] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1844; }","duration":"132.915769ms","start":"2026-04-20T08:13:16.936857Z","end":"2026-04-20T08:13:17.069773Z","steps":["trace[306207527] 'agreement among raft nodes before linearized reading' (duration: 132.752675ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:06.218842Z","caller":"traceutil/trace.go:171","msg":"trace[829621696] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"117.024797ms","start":"2026-04-20T08:14:06.101788Z","end":"2026-04-20T08:14:06.218813Z","steps":["trace[829621696] 'process raft request' (duration: 116.870773ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:05.845847Z","caller":"traceutil/trace.go:171","msg":"trace[879844063] linearizableReadLoop","detail":"{readStateIndex:2614; appliedIndex:2612; }","duration":"170.175163ms","start":"2026-04-20T08:15:05.675645Z","end":"2026-04-20T08:15:05.84582Z","steps":["trace[879844063] 'read index received' (duration: 46.853015ms)","trace[879844063] 'applied index is now lower than readState.Index' (duration: 123.321048ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:15:05.845959Z","caller":"traceutil/trace.go:171","msg":"trace[561963996] transaction","detail":"{read_only:false; response_revision:2525; number_of_response:1; }","duration":"171.934085ms","start":"2026-04-20T08:15:05.67401Z","end":"2026-04-20T08:15:05.845945Z","steps":["trace[561963996] 'process raft request' (duration: 171.635288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:15:05.846108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.447019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"} {"level":"info","ts":"2026-04-20T08:15:05.846157Z","caller":"traceutil/trace.go:171","msg":"trace[1752094090] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2525; }","duration":"170.537731ms","start":"2026-04-20T08:15:05.675603Z","end":"2026-04-20T08:15:05.846141Z","steps":["trace[1752094090] 'agreement among raft nodes before linearized reading' (duration: 170.333207ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:35.228301Z","caller":"traceutil/trace.go:171","msg":"trace[1033446767] transaction","detail":"{read_only:false; response_revision:2687; number_of_response:1; }","duration":"128.016288ms","start":"2026-04-20T08:15:35.100262Z","end":"2026-04-20T08:15:35.228278Z","steps":["trace[1033446767] 'process raft request' (duration: 127.867254ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:35.242895Z","caller":"traceutil/trace.go:171","msg":"trace[1029651173] transaction","detail":"{read_only:false; response_revision:2688; number_of_response:1; }","duration":"142.0957ms","start":"2026-04-20T08:15:35.100777Z","end":"2026-04-20T08:15:35.242872Z","steps":["trace[1029651173] 'process raft request' (duration: 141.936207ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:40.832289Z","caller":"traceutil/trace.go:171","msg":"trace[1417052108] transaction","detail":"{read_only:false; response_revision:2717; number_of_response:1; }","duration":"132.184187ms","start":"2026-04-20T08:15:40.700061Z","end":"2026-04-20T08:15:40.832246Z","steps":["trace[1417052108] 'process raft request' (duration: 131.995142ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:18:20.860935Z","caller":"traceutil/trace.go:171","msg":"trace[463219391] transaction","detail":"{read_only:false; response_revision:3746; number_of_response:1; }","duration":"144.940328ms","start":"2026-04-20T08:18:20.715945Z","end":"2026-04-20T08:18:20.860885Z","steps":["trace[463219391] 'process raft request' (duration: 144.5876ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:19:42.629508Z","caller":"traceutil/trace.go:171","msg":"trace[1037152475] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"104.151124ms","start":"2026-04-20T08:19:42.525332Z","end":"2026-04-20T08:19:42.629484Z","steps":["trace[1037152475] 'process raft request' (duration: 66.444895ms)","trace[1037152475] 'compare' (duration: 37.436222ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:19:42.69749Z","caller":"traceutil/trace.go:171","msg":"trace[928955197] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"101.89189ms","start":"2026-04-20T08:19:42.595578Z","end":"2026-04-20T08:19:42.69747Z","steps":["trace[928955197] 'process raft request' (duration: 101.763277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:19:45.780049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.361871ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:19:45.780199Z","caller":"traceutil/trace.go:171","msg":"trace[22332120] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"208.172103ms","start":"2026-04-20T08:19:45.572007Z","end":"2026-04-20T08:19:45.780179Z","steps":["trace[22332120] 'process raft request' (duration: 59.976853ms)","trace[22332120] 'compare' (duration: 147.125946ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:19:45.800254Z","caller":"traceutil/trace.go:171","msg":"trace[1409621427] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"103.681573ms","start":"2026-04-20T08:19:45.696548Z","end":"2026-04-20T08:19:45.80023Z","steps":["trace[1409621427] 'process raft request' (duration: 103.439777ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:19:57.786695Z","caller":"traceutil/trace.go:171","msg":"trace[1894036109] transaction","detail":"{read_only:false; response_revision:5138; number_of_response:1; }","duration":"106.884008ms","start":"2026-04-20T08:19:57.679784Z","end":"2026-04-20T08:19:57.786668Z","steps":["trace[1894036109] 'process raft request' (duration: 68.938184ms)","trace[1894036109] 'compare' (duration: 37.723198ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:19:57.787143Z","caller":"traceutil/trace.go:171","msg":"trace[1875119637] transaction","detail":"{read_only:false; response_revision:5139; number_of_response:1; }","duration":"107.172914ms","start":"2026-04-20T08:19:57.679944Z","end":"2026-04-20T08:19:57.787117Z","steps":["trace[1875119637] 'process raft request' (duration: 106.663522ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:19:57.787117Z","caller":"traceutil/trace.go:171","msg":"trace[1303943109] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"106.931119ms","start":"2026-04-20T08:19:57.680148Z","end":"2026-04-20T08:19:57.787079Z","steps":["trace[1303943109] 'process raft request' (duration: 106.734485ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:03.199677Z","caller":"traceutil/trace.go:171","msg":"trace[1557991599] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"114.018725ms","start":"2026-04-20T08:20:03.085623Z","end":"2026-04-20T08:20:03.199642Z","steps":["trace[1557991599] 'process raft request' (duration: 113.829881ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:05.661145Z","caller":"traceutil/trace.go:171","msg":"trace[1631698933] transaction","detail":"{read_only:false; response_revision:5276; number_of_response:1; }","duration":"122.897215ms","start":"2026-04-20T08:20:05.538194Z","end":"2026-04-20T08:20:05.661092Z","steps":["trace[1631698933] 'process raft request' (duration: 122.535676ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:21:10.04309Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2871} {"level":"info","ts":"2026-04-20T08:21:10.113461Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2871,"took":"69.118758ms","hash":529258731,"current-db-size-bytes":56242176,"current-db-size":"56 MB","current-db-size-in-use-bytes":32784384,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-20T08:21:10.113518Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":529258731,"revision":2871,"compact-revision":-1} {"level":"warn","ts":"2026-04-20T08:26:04.460534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.258055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-04-20T08:26:04.460605Z","caller":"traceutil/trace.go:171","msg":"trace[369232395] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8107; }","duration":"440.341127ms","start":"2026-04-20T08:26:04.02025Z","end":"2026-04-20T08:26:04.460591Z","steps":["trace[369232395] 'range keys from in-memory index tree' (duration: 440.066141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:04.460563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.599683ms","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-04-20T08:26:04.460681Z","caller":"traceutil/trace.go:171","msg":"trace[1444674181] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8107; }","duration":"450.741656ms","start":"2026-04-20T08:26:04.009917Z","end":"2026-04-20T08:26:04.460659Z","steps":["trace[1444674181] 'range keys from in-memory index tree' (duration: 450.358407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:04.460742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:04.009839Z","time spent":"450.89244ms","remote":"127.0.0.1:52996","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-04-20T08:26:04.460633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:04.020176Z","time spent":"440.45004ms","remote":"127.0.0.1:52884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-20T08:26:10.057581Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5918} {"level":"info","ts":"2026-04-20T08:26:10.142268Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5918,"took":"82.899745ms","hash":529311424,"current-db-size-bytes":56242176,"current-db-size":"56 MB","current-db-size-in-use-bytes":26574848,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-04-20T08:26:10.142339Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":529311424,"revision":5918,"compact-revision":2871} {"level":"info","ts":"2026-04-20T08:26:15.364113Z","caller":"traceutil/trace.go:171","msg":"trace[763595095] transaction","detail":"{read_only:false; response_revision:8167; number_of_response:1; }","duration":"103.852563ms","start":"2026-04-20T08:26:15.260228Z","end":"2026-04-20T08:26:15.36408Z","steps":["trace[763595095] 'process raft request' (duration: 67.251932ms)","trace[763595095] 'compare' (duration: 36.074599ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:26:17.628349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.773165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6c6m9\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-20T08:26:17.628438Z","caller":"traceutil/trace.go:171","msg":"trace[986038536] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6c6m9; range_end:; response_count:1; response_revision:8174; }","duration":"447.906568ms","start":"2026-04-20T08:26:17.18051Z","end":"2026-04-20T08:26:17.628416Z","steps":["trace[986038536] 'range keys from in-memory index tree' (duration: 447.610941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:17.628474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:17.180493Z","time spent":"447.97345ms","remote":"127.0.0.1:52920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-6c6m9\" "} {"level":"info","ts":"2026-04-20T08:26:17.817878Z","caller":"traceutil/trace.go:171","msg":"trace[1190451451] transaction","detail":"{read_only:false; response_revision:8175; number_of_response:1; }","duration":"503.922622ms","start":"2026-04-20T08:26:17.313923Z","end":"2026-04-20T08:26:17.817846Z","steps":["trace[1190451451] 'process raft request' (duration: 503.676936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:17.818066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:17.313899Z","time spent":"504.074106ms","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:26:17.958133Z","caller":"traceutil/trace.go:171","msg":"trace[1271784] linearizableReadLoop","detail":"{readStateIndex:8459; appliedIndex:8457; }","duration":"470.418394ms","start":"2026-04-20T08:26:17.487675Z","end":"2026-04-20T08:26:17.958093Z","steps":["trace[1271784] 'read index received' (duration: 329.917198ms)","trace[1271784] 'applied index is now lower than readState.Index' (duration: 140.499866ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:26:17.958186Z","caller":"traceutil/trace.go:171","msg":"trace[654808722] transaction","detail":"{read_only:false; response_revision:8176; number_of_response:1; }","duration":"587.403171ms","start":"2026-04-20T08:26:17.370762Z","end":"2026-04-20T08:26:17.958165Z","steps":["trace[654808722] 'process raft request' (duration: 515.002796ms)","trace[654808722] 'compare' (duration: 72.164129ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:26:17.958321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:17.370731Z","time spent":"587.511903ms","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:26:17.95831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.612838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:26:17.958393Z","caller":"traceutil/trace.go:171","msg":"trace[1325402191] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8176; }","duration":"470.758943ms","start":"2026-04-20T08:26:17.487613Z","end":"2026-04-20T08:26:17.958371Z","steps":["trace[1325402191] 'agreement among raft nodes before linearized reading' (duration: 470.609069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:17.958442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:17.487589Z","time spent":"470.844374ms","remote":"127.0.0.1:52768","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-04-20T08:26:17.958518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.403935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-04-20T08:26:17.958603Z","caller":"traceutil/trace.go:171","msg":"trace[1908333654] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8176; }","duration":"177.528438ms","start":"2026-04-20T08:26:17.781048Z","end":"2026-04-20T08:26:17.958577Z","steps":["trace[1908333654] 'agreement among raft nodes before linearized reading' (duration: 177.247961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:17.958435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.638664ms","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-04-20T08:26:17.95866Z","caller":"traceutil/trace.go:171","msg":"trace[1873872423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8176; }","duration":"403.873019ms","start":"2026-04-20T08:26:17.554775Z","end":"2026-04-20T08:26:17.958648Z","steps":["trace[1873872423] 'agreement among raft nodes before linearized reading' (duration: 403.503411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:17.958774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:17.554708Z","time spent":"403.976281ms","remote":"127.0.0.1:52996","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-04-20T08:26:17.958888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.234746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:24 size:207034"} {"level":"info","ts":"2026-04-20T08:26:17.95896Z","caller":"traceutil/trace.go:171","msg":"trace[567011715] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:24; response_revision:8176; }","duration":"325.337438ms","start":"2026-04-20T08:26:17.633605Z","end":"2026-04-20T08:26:17.958943Z","steps":["trace[567011715] 'agreement among raft nodes before linearized reading' (duration: 324.860767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:17.959007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:17.63359Z","time spent":"325.40382ms","remote":"127.0.0.1:52920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":24,"response size":207057,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-04-20T08:26:18.353661Z","caller":"traceutil/trace.go:171","msg":"trace[1558723101] transaction","detail":"{read_only:false; response_revision:8179; number_of_response:1; }","duration":"102.218844ms","start":"2026-04-20T08:26:18.251414Z","end":"2026-04-20T08:26:18.353633Z","steps":["trace[1558723101] 'process raft request' (duration: 101.971948ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:18.740018Z","caller":"traceutil/trace.go:171","msg":"trace[1655606435] transaction","detail":"{read_only:false; response_revision:8180; number_of_response:1; }","duration":"173.239066ms","start":"2026-04-20T08:26:18.566755Z","end":"2026-04-20T08:26:18.739994Z","steps":["trace[1655606435] 'process raft request' (duration: 173.065922ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:18.883991Z","caller":"traceutil/trace.go:171","msg":"trace[1210777496] linearizableReadLoop","detail":"{readStateIndex:8465; appliedIndex:8463; }","duration":"226.778192ms","start":"2026-04-20T08:26:18.657169Z","end":"2026-04-20T08:26:18.883947Z","steps":["trace[1210777496] 'read index received' (duration: 82.658198ms)","trace[1210777496] 'applied index is now lower than readState.Index' (duration: 144.117743ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:26:18.884044Z","caller":"traceutil/trace.go:171","msg":"trace[2128482073] transaction","detail":"{read_only:false; response_revision:8181; number_of_response:1; }","duration":"274.58784ms","start":"2026-04-20T08:26:18.60942Z","end":"2026-04-20T08:26:18.884008Z","steps":["trace[2128482073] 'process raft request' (duration: 187.431783ms)","trace[2128482073] 'compare' (duration: 86.674695ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:26:18.884437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.765129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T08:26:18.884497Z","caller":"traceutil/trace.go:171","msg":"trace[1093649804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8181; }","duration":"215.866741ms","start":"2026-04-20T08:26:18.668617Z","end":"2026-04-20T08:26:18.884483Z","steps":["trace[1093649804] 'agreement among raft nodes before linearized reading' (duration: 215.736888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:18.884284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.11572ms","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-04-20T08:26:18.884873Z","caller":"traceutil/trace.go:171","msg":"trace[105273732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8181; }","duration":"227.702143ms","start":"2026-04-20T08:26:18.657093Z","end":"2026-04-20T08:26:18.884795Z","steps":["trace[105273732] 'agreement among raft nodes before linearized reading' (duration: 227.030378ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:19.098373Z","caller":"traceutil/trace.go:171","msg":"trace[812766446] transaction","detail":"{read_only:false; response_revision:8183; number_of_response:1; }","duration":"209.564381ms","start":"2026-04-20T08:26:18.888785Z","end":"2026-04-20T08:26:19.098349Z","steps":["trace[812766446] 'process raft request' (duration: 181.878492ms)","trace[812766446] 'compare' (duration: 27.342411ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:26:19.098579Z","caller":"traceutil/trace.go:171","msg":"trace[1900108707] linearizableReadLoop","detail":"{readStateIndex:8468; appliedIndex:8466; }","duration":"118.599894ms","start":"2026-04-20T08:26:18.979957Z","end":"2026-04-20T08:26:19.098557Z","steps":["trace[1900108707] 'read index received' (duration: 90.640188ms)","trace[1900108707] 'applied index is now lower than readState.Index' (duration: 27.958546ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:26:19.098892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.932762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-20T08:26:19.099002Z","caller":"traceutil/trace.go:171","msg":"trace[973681282] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8184; }","duration":"119.069165ms","start":"2026-04-20T08:26:18.979882Z","end":"2026-04-20T08:26:19.098951Z","steps":["trace[973681282] 'agreement among raft nodes before linearized reading' (duration: 118.798869ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:19.099025Z","caller":"traceutil/trace.go:171","msg":"trace[1289950217] transaction","detail":"{read_only:false; response_revision:8184; number_of_response:1; }","duration":"210.198066ms","start":"2026-04-20T08:26:18.888812Z","end":"2026-04-20T08:26:19.09901Z","steps":["trace[1289950217] 'process raft request' (duration: 209.464289ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:28.315104Z","caller":"traceutil/trace.go:171","msg":"trace[1922451331] transaction","detail":"{read_only:false; response_revision:8235; number_of_response:1; }","duration":"467.538396ms","start":"2026-04-20T08:26:27.847539Z","end":"2026-04-20T08:26:28.315078Z","steps":["trace[1922451331] 'process raft request' (duration: 467.379662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:28.315242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:27.847516Z","time spent":"467.650098ms","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:26:30.897469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:29.738667Z","time spent":"1.1587894s","remote":"127.0.0.1:34966","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-20T08:26:30.902063Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.58711472s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T08:26:30.902555Z","caller":"traceutil/trace.go:171","msg":"trace[1621434986] linearizableReadLoop","detail":"{readStateIndex:8521; appliedIndex:8519; }","duration":"2.886269775s","start":"2026-04-20T08:26:28.016253Z","end":"2026-04-20T08:26:30.902522Z","steps":["trace[1621434986] 'read index received' (duration: 298.665264ms)","trace[1621434986] 'applied index is now lower than readState.Index' (duration: 2.587603001s)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:26:30.902755Z","caller":"traceutil/trace.go:171","msg":"trace[555781534] transaction","detail":"{read_only:false; response_revision:8236; number_of_response:1; }","duration":"2.910726006s","start":"2026-04-20T08:26:27.991911Z","end":"2026-04-20T08:26:30.902637Z","steps":["trace[555781534] 'process raft request' (duration: 2.91043563s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.902958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:27.991884Z","time spent":"2.910949762s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:26:30.90303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.886762746s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6c6m9\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-20T08:26:30.903076Z","caller":"traceutil/trace.go:171","msg":"trace[1562412793] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6c6m9; range_end:; response_count:1; response_revision:8236; }","duration":"2.886865518s","start":"2026-04-20T08:26:28.016198Z","end":"2026-04-20T08:26:30.903064Z","steps":["trace[1562412793] 'agreement among raft nodes before linearized reading' (duration: 2.886464939s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.903112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:28.016176Z","time spent":"2.88693006s","remote":"127.0.0.1:52920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-6c6m9\" "} {"level":"info","ts":"2026-04-20T08:26:30.913702Z","caller":"traceutil/trace.go:171","msg":"trace[882764906] transaction","detail":"{read_only:false; response_revision:8237; number_of_response:1; }","duration":"988.964004ms","start":"2026-04-20T08:26:29.924707Z","end":"2026-04-20T08:26:30.913671Z","steps":["trace[882764906] 'process raft request' (duration: 988.732669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.913911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:29.92469Z","time spent":"989.102027ms","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:26:30.91403Z","caller":"traceutil/trace.go:171","msg":"trace[659112192] transaction","detail":"{read_only:false; response_revision:8238; number_of_response:1; }","duration":"593.194939ms","start":"2026-04-20T08:26:30.320773Z","end":"2026-04-20T08:26:30.913968Z","steps":["trace[659112192] 'process raft request' (duration: 592.847441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.914118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.077844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T08:26:30.914158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.511423929s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:26:30.914235Z","caller":"traceutil/trace.go:171","msg":"trace[2122316366] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:8238; }","duration":"354.262188ms","start":"2026-04-20T08:26:30.559946Z","end":"2026-04-20T08:26:30.914209Z","steps":["trace[2122316366] 'agreement among raft nodes before linearized reading' (duration: 353.90591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.914252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:30.320747Z","time spent":"593.401544ms","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:26:30.914139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.912299717s","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-04-20T08:26:30.914279Z","caller":"traceutil/trace.go:171","msg":"trace[973711965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8238; }","duration":"1.511574912s","start":"2026-04-20T08:26:29.402677Z","end":"2026-04-20T08:26:30.914252Z","steps":["trace[973711965] 'agreement among raft nodes before linearized reading' (duration: 1.511404838s)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:30.914315Z","caller":"traceutil/trace.go:171","msg":"trace[2053975331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8238; }","duration":"1.912531032s","start":"2026-04-20T08:26:29.001767Z","end":"2026-04-20T08:26:30.914298Z","steps":["trace[2053975331] 'agreement among raft nodes before linearized reading' (duration: 1.912137643s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.91435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.771284117s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-20T08:26:30.914373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:29.001745Z","time spent":"1.912612525s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T08:26:30.914395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.4300853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:26:30.914413Z","caller":"traceutil/trace.go:171","msg":"trace[936238805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8238; }","duration":"1.771345149s","start":"2026-04-20T08:26:29.143043Z","end":"2026-04-20T08:26:30.914388Z","steps":["trace[936238805] 'agreement among raft nodes before linearized reading' (duration: 1.771271458s)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:30.91443Z","caller":"traceutil/trace.go:171","msg":"trace[393395096] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8238; }","duration":"1.430157943s","start":"2026-04-20T08:26:29.484263Z","end":"2026-04-20T08:26:30.914421Z","steps":["trace[393395096] 'agreement among raft nodes before linearized reading' (duration: 1.430106792s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.914444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.811968915s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"warn","ts":"2026-04-20T08:26:30.914449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:29.143025Z","time spent":"1.771415411s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-20T08:26:30.914471Z","caller":"traceutil/trace.go:171","msg":"trace[1472747129] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8238; }","duration":"2.812032956s","start":"2026-04-20T08:26:28.102431Z","end":"2026-04-20T08:26:30.914464Z","steps":["trace[1472747129] 'agreement among raft nodes before linearized reading' (duration: 2.811949144s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.914498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:28.102408Z","time spent":"2.812085478s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":594,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-04-20T08:26:30.914506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:29.484245Z","time spent":"1.430207635s","remote":"127.0.0.1:52780","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-04-20T08:26:30.914249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.763676997s","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-04-20T08:26:30.914596Z","caller":"traceutil/trace.go:171","msg":"trace[731674924] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8238; }","duration":"1.764030575s","start":"2026-04-20T08:26:29.150553Z","end":"2026-04-20T08:26:30.914583Z","steps":["trace[731674924] 'agreement among raft nodes before linearized reading' (duration: 1.763644106s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.914629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:29.150547Z","time spent":"1.764068977s","remote":"127.0.0.1:52996","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-04-20T08:26:30.914646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.597318282s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-20T08:26:30.914733Z","caller":"traceutil/trace.go:171","msg":"trace[1479642077] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8238; }","duration":"2.597437605s","start":"2026-04-20T08:26:28.317286Z","end":"2026-04-20T08:26:30.914724Z","steps":["trace[1479642077] 'agreement among raft nodes before linearized reading' (duration: 2.59720143s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.91476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:28.317265Z","time spent":"2.597485056s","remote":"127.0.0.1:52920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-20T08:26:30.914783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.666007928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-5fd448d7ff-b62rn.18a80330212b0517\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-04-20T08:26:30.914816Z","caller":"traceutil/trace.go:171","msg":"trace[1097659197] range","detail":"{range_begin:/registry/events/openstack/barbican-api-5fd448d7ff-b62rn.18a80330212b0517; range_end:; response_count:1; response_revision:8238; }","duration":"2.66606867s","start":"2026-04-20T08:26:28.248738Z","end":"2026-04-20T08:26:30.914806Z","steps":["trace[1097659197] 'agreement among raft nodes before linearized reading' (duration: 2.665995128s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.914836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:28.248719Z","time spent":"2.666113061s","remote":"127.0.0.1:52836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1158,"request content":"key:\"/registry/events/openstack/barbican-api-5fd448d7ff-b62rn.18a80330212b0517\" "} {"level":"warn","ts":"2026-04-20T08:26:30.91484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.866069113s","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-04-20T08:26:30.914877Z","caller":"traceutil/trace.go:171","msg":"trace[1218628159] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8238; }","duration":"2.866152745s","start":"2026-04-20T08:26:28.048715Z","end":"2026-04-20T08:26:30.914868Z","steps":["trace[1218628159] 'agreement among raft nodes before linearized reading' (duration: 2.8659755s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.914342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:29.402661Z","time spent":"1.511668815s","remote":"127.0.0.1:52768","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-04-20T08:26:30.914904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:28.04869Z","time spent":"2.866208436s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T08:26:30.914442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.126346834s","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-04-20T08:26:30.91429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:30.559924Z","time spent":"354.355771ms","remote":"127.0.0.1:52848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":80,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-04-20T08:26:30.914345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.157882297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T08:26:30.9151Z","caller":"traceutil/trace.go:171","msg":"trace[187833207] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8238; }","duration":"1.158649816s","start":"2026-04-20T08:26:29.756435Z","end":"2026-04-20T08:26:30.915085Z","steps":["trace[187833207] 'agreement among raft nodes before linearized reading' (duration: 1.157875818s)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:30.914981Z","caller":"traceutil/trace.go:171","msg":"trace[1863407442] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8238; }","duration":"2.126914658s","start":"2026-04-20T08:26:28.788057Z","end":"2026-04-20T08:26:30.914971Z","steps":["trace[1863407442] 'agreement among raft nodes before linearized reading' (duration: 2.125839033s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.915142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:28.788038Z","time spent":"2.127096732s","remote":"127.0.0.1:52996","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-04-20T08:26:30.915149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:29.756425Z","time spent":"1.158705277s","remote":"127.0.0.1:44394","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-04-20T08:26:30.914301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.769779672s","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-04-20T08:26:30.915253Z","caller":"traceutil/trace.go:171","msg":"trace[1172921703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8238; }","duration":"1.770712564s","start":"2026-04-20T08:26:29.144513Z","end":"2026-04-20T08:26:30.915226Z","steps":["trace[1172921703] 'agreement among raft nodes before linearized reading' (duration: 1.769751411s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:30.915294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:29.144492Z","time spent":"1.770790666s","remote":"127.0.0.1:52996","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-04-20T08:26:33.426523Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364023527683381,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T08:26:33.92711Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364023527683381,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T08:26:34.427975Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364023527683381,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T08:26:34.928896Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364023527683381,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T08:26:35.429931Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891364023527683381,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T08:26:35.487002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000482637s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-20T08:26:35.487059Z","caller":"traceutil/trace.go:171","msg":"trace[60394577] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00058443s","start":"2026-04-20T08:26:33.486458Z","end":"2026-04-20T08:26:35.487042Z","steps":["trace[60394577] 'agreement among raft nodes before linearized reading' (duration: 2.000514728s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.487093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:33.486433Z","time spent":"2.000653211s","remote":"127.0.0.1:52768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/20 08:26:35 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T08:26:35.558694Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.712362512s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T08:26:35.559199Z","caller":"traceutil/trace.go:171","msg":"trace[1219503241] transaction","detail":"{read_only:false; response_revision:8247; number_of_response:1; }","duration":"2.712949106s","start":"2026-04-20T08:26:32.846226Z","end":"2026-04-20T08:26:35.559175Z","steps":["trace[1219503241] 'process raft request' (duration: 2.712793802s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.55934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:32.846205Z","time spent":"2.713061858s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:26:35.614891Z","caller":"traceutil/trace.go:171","msg":"trace[539250525] linearizableReadLoop","detail":"{readStateIndex:8536; appliedIndex:8532; }","duration":"2.689257342s","start":"2026-04-20T08:26:32.925605Z","end":"2026-04-20T08:26:35.614862Z","steps":["trace[539250525] 'read index received' (duration: 2.633444432s)","trace[539250525] 'applied index is now lower than readState.Index' (duration: 55.81153ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:26:35.615051Z","caller":"traceutil/trace.go:171","msg":"trace[21615383] transaction","detail":"{read_only:false; response_revision:8250; number_of_response:1; }","duration":"1.664805962s","start":"2026-04-20T08:26:33.950212Z","end":"2026-04-20T08:26:35.615018Z","steps":["trace[21615383] 'process raft request' (duration: 1.664605108s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.615194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:33.950192Z","time spent":"1.664927115s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:26:35.615201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.689552299s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6c6m9\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-20T08:26:35.615324Z","caller":"traceutil/trace.go:171","msg":"trace[688526437] transaction","detail":"{read_only:false; response_revision:8249; number_of_response:1; }","duration":"2.693325218s","start":"2026-04-20T08:26:32.92198Z","end":"2026-04-20T08:26:35.615306Z","steps":["trace[688526437] 'process raft request' (duration: 2.692764005s)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:35.61539Z","caller":"traceutil/trace.go:171","msg":"trace[1229422687] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6c6m9; range_end:; response_count:1; response_revision:8250; }","duration":"2.689748274s","start":"2026-04-20T08:26:32.925592Z","end":"2026-04-20T08:26:35.61534Z","steps":["trace[1229422687] 'agreement among raft nodes before linearized reading' (duration: 2.689403586s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.615531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.965988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:26:35.615556Z","caller":"traceutil/trace.go:171","msg":"trace[1085713865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8250; }","duration":"128.02754ms","start":"2026-04-20T08:26:35.487522Z","end":"2026-04-20T08:26:35.61555Z","steps":["trace[1085713865] 'agreement among raft nodes before linearized reading' (duration: 127.990909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.615546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:32.925546Z","time spent":"2.689980559s","remote":"127.0.0.1:52920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-6c6m9\" "} {"level":"warn","ts":"2026-04-20T08:26:35.615688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.675195317s","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-04-20T08:26:35.615936Z","caller":"traceutil/trace.go:171","msg":"trace[142455897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8250; }","duration":"2.675452674s","start":"2026-04-20T08:26:32.940467Z","end":"2026-04-20T08:26:35.615919Z","steps":["trace[142455897] 'agreement among raft nodes before linearized reading' (duration: 2.675120586s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.615966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:32.940457Z","time spent":"2.675502974s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T08:26:35.615923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.675571627s","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-04-20T08:26:35.616007Z","caller":"traceutil/trace.go:171","msg":"trace[227557183] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8250; }","duration":"2.675667808s","start":"2026-04-20T08:26:32.940329Z","end":"2026-04-20T08:26:35.615997Z","steps":["trace[227557183] 'agreement among raft nodes before linearized reading' (duration: 2.675251849s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.616068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:32.940323Z","time spent":"2.67573882s","remote":"127.0.0.1:52996","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-04-20T08:26:35.615685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.675476084s","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-04-20T08:26:35.61612Z","caller":"traceutil/trace.go:171","msg":"trace[40252029] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8250; }","duration":"2.675948605s","start":"2026-04-20T08:26:32.940163Z","end":"2026-04-20T08:26:35.616112Z","steps":["trace[40252029] 'agreement among raft nodes before linearized reading' (duration: 2.675445743s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.616149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:32.940142Z","time spent":"2.675999806s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-20T08:26:35.615485Z","caller":"traceutil/trace.go:171","msg":"trace[962563089] transaction","detail":"{read_only:false; response_revision:8248; number_of_response:1; }","duration":"2.704999527s","start":"2026-04-20T08:26:32.910467Z","end":"2026-04-20T08:26:35.615467Z","steps":["trace[962563089] 'process raft request' (duration: 2.704099636s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.616233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:32.910446Z","time spent":"2.705756854s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:26:35.615498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.459140992s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.175\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T08:26:35.616298Z","caller":"traceutil/trace.go:171","msg":"trace[1129521271] range","detail":"{range_begin:/registry/masterleases/199.19.213.175; range_end:; response_count:1; response_revision:8250; }","duration":"2.459975131s","start":"2026-04-20T08:26:33.156316Z","end":"2026-04-20T08:26:35.616291Z","steps":["trace[1129521271] 'agreement among raft nodes before linearized reading' (duration: 2.459132281s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.616324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:33.156296Z","time spent":"2.460020142s","remote":"127.0.0.1:52784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.175\" "} {"level":"warn","ts":"2026-04-20T08:26:35.615701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.579852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T08:26:35.615784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.920363ms","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":"info","ts":"2026-04-20T08:26:35.616377Z","caller":"traceutil/trace.go:171","msg":"trace[1049641849] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:8250; }","duration":"815.271108ms","start":"2026-04-20T08:26:34.801083Z","end":"2026-04-20T08:26:35.616354Z","steps":["trace[1049641849] 'agreement among raft nodes before linearized reading' (duration: 814.563691ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:35.616479Z","caller":"traceutil/trace.go:171","msg":"trace[963001345] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:8250; }","duration":"884.64276ms","start":"2026-04-20T08:26:34.731812Z","end":"2026-04-20T08:26:35.616455Z","steps":["trace[963001345] 'agreement among raft nodes before linearized reading' (duration: 883.935234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.616537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:34.731772Z","time spent":"884.745143ms","remote":"127.0.0.1:46624","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":"warn","ts":"2026-04-20T08:26:35.615778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.014438ms","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-04-20T08:26:35.616526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:34.801071Z","time spent":"815.395021ms","remote":"127.0.0.1:57260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true "} {"level":"warn","ts":"2026-04-20T08:26:35.615818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.675272939s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-20T08:26:35.616668Z","caller":"traceutil/trace.go:171","msg":"trace[286394678] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:8250; }","duration":"264.89481ms","start":"2026-04-20T08:26:35.351674Z","end":"2026-04-20T08:26:35.616569Z","steps":["trace[286394678] 'agreement among raft nodes before linearized reading' (duration: 264.072479ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:35.616719Z","caller":"traceutil/trace.go:171","msg":"trace[4171948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8250; }","duration":"2.676204162s","start":"2026-04-20T08:26:32.940501Z","end":"2026-04-20T08:26:35.616705Z","steps":["trace[4171948] 'agreement among raft nodes before linearized reading' (duration: 2.675009823s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.616763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:32.940483Z","time spent":"2.676267933s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T08:26:35.615833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.674226873s","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-04-20T08:26:35.616837Z","caller":"traceutil/trace.go:171","msg":"trace[310361316] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8250; }","duration":"2.675240818s","start":"2026-04-20T08:26:32.941586Z","end":"2026-04-20T08:26:35.616827Z","steps":["trace[310361316] 'agreement among raft nodes before linearized reading' (duration: 2.674162222s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.615821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.298060367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T08:26:35.61687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:32.941582Z","time spent":"2.67527854s","remote":"127.0.0.1:52996","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-04-20T08:26:35.615414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:32.921957Z","time spent":"2.69340349s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:26:35.616908Z","caller":"traceutil/trace.go:171","msg":"trace[1071890038] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:8250; }","duration":"1.299174824s","start":"2026-04-20T08:26:34.317708Z","end":"2026-04-20T08:26:35.616883Z","steps":["trace[1071890038] 'agreement among raft nodes before linearized reading' (duration: 1.298092388s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.615873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.118197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-04-20T08:26:35.616964Z","caller":"traceutil/trace.go:171","msg":"trace[1523428844] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:8250; }","duration":"615.242104ms","start":"2026-04-20T08:26:35.001714Z","end":"2026-04-20T08:26:35.616956Z","steps":["trace[1523428844] 'agreement among raft nodes before linearized reading' (duration: 614.091536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.616984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:35.001695Z","time spent":"615.284225ms","remote":"127.0.0.1:52884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1804,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" "} {"level":"warn","ts":"2026-04-20T08:26:35.616989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:34.317684Z","time spent":"1.299282507s","remote":"127.0.0.1:54110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T08:26:35.615887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.674728567s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"warn","ts":"2026-04-20T08:26:35.615812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.675609367s","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-04-20T08:26:35.617086Z","caller":"traceutil/trace.go:171","msg":"trace[383537309] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8250; }","duration":"2.675950236s","start":"2026-04-20T08:26:32.941129Z","end":"2026-04-20T08:26:35.617079Z","steps":["trace[383537309] 'agreement among raft nodes before linearized reading' (duration: 2.674709866s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.617108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:32.941118Z","time spent":"2.675983786s","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":594,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"info","ts":"2026-04-20T08:26:35.617114Z","caller":"traceutil/trace.go:171","msg":"trace[1987065887] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8250; }","duration":"2.676959099s","start":"2026-04-20T08:26:32.940142Z","end":"2026-04-20T08:26:35.617101Z","steps":["trace[1987065887] 'agreement among raft nodes before linearized reading' (duration: 2.675281429s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:35.617203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:32.940125Z","time spent":"2.677065162s","remote":"127.0.0.1:52996","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":"info","ts":"2026-04-20T08:26:47.818972Z","caller":"traceutil/trace.go:171","msg":"trace[2085356332] transaction","detail":"{read_only:false; response_revision:8364; number_of_response:1; }","duration":"153.496475ms","start":"2026-04-20T08:26:47.665433Z","end":"2026-04-20T08:26:47.81893Z","steps":["trace[2085356332] 'process raft request' (duration: 153.254229ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:47.844599Z","caller":"traceutil/trace.go:171","msg":"trace[1926483801] transaction","detail":"{read_only:false; response_revision:8365; number_of_response:1; }","duration":"175.857399ms","start":"2026-04-20T08:26:47.668714Z","end":"2026-04-20T08:26:47.844571Z","steps":["trace[1926483801] 'process raft request' (duration: 175.683534ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:02.034135Z","caller":"traceutil/trace.go:171","msg":"trace[993134404] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"145.70447ms","start":"2026-04-20T08:27:01.8884Z","end":"2026-04-20T08:27:02.034104Z","steps":["trace[993134404] 'process raft request' (duration: 145.529406ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:02.156205Z","caller":"traceutil/trace.go:171","msg":"trace[1240381425] linearizableReadLoop","detail":"{readStateIndex:8781; appliedIndex:8779; }","duration":"219.939349ms","start":"2026-04-20T08:27:01.936248Z","end":"2026-04-20T08:27:02.156187Z","steps":["trace[1240381425] 'read index received' (duration: 97.734189ms)","trace[1240381425] 'applied index is now lower than readState.Index' (duration: 122.204349ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:02.156315Z","caller":"traceutil/trace.go:171","msg":"trace[1822332553] transaction","detail":"{read_only:false; response_revision:8487; number_of_response:1; }","duration":"142.75251ms","start":"2026-04-20T08:27:02.013555Z","end":"2026-04-20T08:27:02.156307Z","steps":["trace[1822332553] 'process raft request' (duration: 142.592147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:02.156502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.248845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6c6m9\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-20T08:27:02.156533Z","caller":"traceutil/trace.go:171","msg":"trace[252594283] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6c6m9; range_end:; response_count:1; response_revision:8487; }","duration":"220.330017ms","start":"2026-04-20T08:27:01.936196Z","end":"2026-04-20T08:27:02.156526Z","steps":["trace[252594283] 'agreement among raft nodes before linearized reading' (duration: 220.216825ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:02.156696Z","caller":"traceutil/trace.go:171","msg":"trace[1983707217] transaction","detail":"{read_only:false; response_revision:8486; number_of_response:1; }","duration":"254.538072ms","start":"2026-04-20T08:27:01.902144Z","end":"2026-04-20T08:27:02.156682Z","steps":["trace[1983707217] 'process raft request' (duration: 232.553589ms)","trace[1983707217] 'compare' (duration: 21.333388ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:27:02.156707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.230175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-20T08:27:02.15688Z","caller":"traceutil/trace.go:171","msg":"trace[726386428] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8487; }","duration":"178.43256ms","start":"2026-04-20T08:27:01.978435Z","end":"2026-04-20T08:27:02.156867Z","steps":["trace[726386428] 'agreement among raft nodes before linearized reading' (duration: 178.227965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:02.157009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.624703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-20T08:27:02.157039Z","caller":"traceutil/trace.go:171","msg":"trace[1133630859] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8487; }","duration":"146.656393ms","start":"2026-04-20T08:27:02.010376Z","end":"2026-04-20T08:27:02.157033Z","steps":["trace[1133630859] 'agreement among raft nodes before linearized reading' (duration: 146.583142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:02.157164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.443673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T08:27:02.157187Z","caller":"traceutil/trace.go:171","msg":"trace[583238624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8487; }","duration":"163.510305ms","start":"2026-04-20T08:27:01.993672Z","end":"2026-04-20T08:27:02.157182Z","steps":["trace[583238624] 'agreement among raft nodes before linearized reading' (duration: 163.412163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:02.15728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.695035ms","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-04-20T08:27:02.157314Z","caller":"traceutil/trace.go:171","msg":"trace[2052895537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8487; }","duration":"146.751296ms","start":"2026-04-20T08:27:02.010555Z","end":"2026-04-20T08:27:02.157307Z","steps":["trace[2052895537] 'agreement among raft nodes before linearized reading' (duration: 146.662054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:02.157493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.017222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-20T08:27:02.15751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.882089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-04-20T08:27:02.157526Z","caller":"traceutil/trace.go:171","msg":"trace[1292133869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8487; }","duration":"147.063623ms","start":"2026-04-20T08:27:02.010455Z","end":"2026-04-20T08:27:02.157519Z","steps":["trace[1292133869] 'agreement among raft nodes before linearized reading' (duration: 146.980371ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:02.157536Z","caller":"traceutil/trace.go:171","msg":"trace[1132438627] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8487; }","duration":"146.93705ms","start":"2026-04-20T08:27:02.010589Z","end":"2026-04-20T08:27:02.157526Z","steps":["trace[1132438627] 'agreement among raft nodes before linearized reading' (duration: 146.794077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:02.157511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.029013ms","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-04-20T08:27:02.15769Z","caller":"traceutil/trace.go:171","msg":"trace[1076321453] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8487; }","duration":"147.243967ms","start":"2026-04-20T08:27:02.010427Z","end":"2026-04-20T08:27:02.157671Z","steps":["trace[1076321453] 'agreement among raft nodes before linearized reading' (duration: 146.529141ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:02.278673Z","caller":"traceutil/trace.go:171","msg":"trace[1885826460] transaction","detail":"{read_only:false; response_revision:8489; number_of_response:1; }","duration":"113.292819ms","start":"2026-04-20T08:27:02.165353Z","end":"2026-04-20T08:27:02.278646Z","steps":["trace[1885826460] 'process raft request' (duration: 95.835713ms)","trace[1885826460] 'compare' (duration: 17.247311ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:02.279059Z","caller":"traceutil/trace.go:171","msg":"trace[840029104] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"113.456133ms","start":"2026-04-20T08:27:02.165574Z","end":"2026-04-20T08:27:02.27903Z","steps":["trace[840029104] 'process raft request' (duration: 113.007162ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:02.27947Z","caller":"traceutil/trace.go:171","msg":"trace[1814289831] transaction","detail":"{read_only:false; response_revision:8492; number_of_response:1; }","duration":"112.597992ms","start":"2026-04-20T08:27:02.166854Z","end":"2026-04-20T08:27:02.279452Z","steps":["trace[1814289831] 'process raft request' (duration: 112.288855ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:02.279437Z","caller":"traceutil/trace.go:171","msg":"trace[2130655009] linearizableReadLoop","detail":"{readStateIndex:8789; appliedIndex:8782; }","duration":"110.361809ms","start":"2026-04-20T08:27:02.169035Z","end":"2026-04-20T08:27:02.279396Z","steps":["trace[2130655009] 'read index received' (duration: 42.536353ms)","trace[2130655009] 'applied index is now lower than readState.Index' (duration: 67.823435ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:02.279945Z","caller":"traceutil/trace.go:171","msg":"trace[1506932276] transaction","detail":"{read_only:false; response_revision:8493; number_of_response:1; }","duration":"112.362837ms","start":"2026-04-20T08:27:02.167562Z","end":"2026-04-20T08:27:02.279924Z","steps":["trace[1506932276] 'process raft request' (duration: 111.677791ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:02.280118Z","caller":"traceutil/trace.go:171","msg":"trace[904879291] transaction","detail":"{read_only:false; response_revision:8491; number_of_response:1; }","duration":"113.172067ms","start":"2026-04-20T08:27:02.166849Z","end":"2026-04-20T08:27:02.280021Z","steps":["trace[904879291] 'process raft request' (duration: 112.07328ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:02.280291Z","caller":"traceutil/trace.go:171","msg":"trace[1445071606] transaction","detail":"{read_only:false; response_revision:8494; number_of_response:1; }","duration":"112.561573ms","start":"2026-04-20T08:27:02.167695Z","end":"2026-04-20T08:27:02.280256Z","steps":["trace[1445071606] 'process raft request' (duration: 111.614069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:02.280297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.22034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:211680"} {"level":"info","ts":"2026-04-20T08:27:02.280544Z","caller":"traceutil/trace.go:171","msg":"trace[584132253] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8494; }","duration":"111.532347ms","start":"2026-04-20T08:27:02.168991Z","end":"2026-04-20T08:27:02.280523Z","steps":["trace[584132253] 'agreement among raft nodes before linearized reading' (duration: 110.555433ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:03.108981Z","caller":"traceutil/trace.go:171","msg":"trace[1796774913] transaction","detail":"{read_only:false; response_revision:8496; number_of_response:1; }","duration":"220.628935ms","start":"2026-04-20T08:27:02.888306Z","end":"2026-04-20T08:27:03.108935Z","steps":["trace[1796774913] 'process raft request' (duration: 183.992902ms)","trace[1796774913] 'compare' (duration: 36.290194ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:03.669714Z","caller":"traceutil/trace.go:171","msg":"trace[758438334] linearizableReadLoop","detail":"{readStateIndex:8794; appliedIndex:8793; }","duration":"137.873366ms","start":"2026-04-20T08:27:03.531819Z","end":"2026-04-20T08:27:03.669692Z","steps":["trace[758438334] 'read index received' (duration: 137.645139ms)","trace[758438334] 'applied index is now lower than readState.Index' (duration: 226.537µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:03.669806Z","caller":"traceutil/trace.go:171","msg":"trace[1367084566] transaction","detail":"{read_only:false; response_revision:8498; number_of_response:1; }","duration":"155.73634ms","start":"2026-04-20T08:27:03.514026Z","end":"2026-04-20T08:27:03.669763Z","steps":["trace[1367084566] 'process raft request' (duration: 155.515835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:03.66997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.142942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/openstack/ceph\" ","response":"range_response_count:1 size:3173"} {"level":"info","ts":"2026-04-20T08:27:03.670032Z","caller":"traceutil/trace.go:171","msg":"trace[113595250] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/openstack/ceph; range_end:; response_count:1; response_revision:8498; }","duration":"138.237434ms","start":"2026-04-20T08:27:03.531759Z","end":"2026-04-20T08:27:03.669997Z","steps":["trace[113595250] 'agreement among raft nodes before linearized reading' (duration: 138.019519ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:03.786753Z","caller":"traceutil/trace.go:171","msg":"trace[129763687] transaction","detail":"{read_only:false; response_revision:8499; number_of_response:1; }","duration":"107.197773ms","start":"2026-04-20T08:27:03.67953Z","end":"2026-04-20T08:27:03.786728Z","steps":["trace[129763687] 'process raft request' (duration: 101.361584ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:28:11.356422Z","caller":"traceutil/trace.go:171","msg":"trace[689890615] transaction","detail":"{read_only:false; response_revision:9135; number_of_response:1; }","duration":"196.11812ms","start":"2026-04-20T08:28:11.160278Z","end":"2026-04-20T08:28:11.356396Z","steps":["trace[689890615] 'process raft request' (duration: 195.970806ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:28:12.28281Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024eb.wal"} {"level":"info","ts":"2026-04-20T08:29:13.169763Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"223c7693b78843e1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T08:29:13.175652Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T08:29:13.175754Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T08:29:41.309993Z","caller":"traceutil/trace.go:171","msg":"trace[1659409622] linearizableReadLoop","detail":"{readStateIndex:10188; appliedIndex:10187; }","duration":"500.155821ms","start":"2026-04-20T08:29:40.809811Z","end":"2026-04-20T08:29:41.309967Z","steps":["trace[1659409622] 'read index received' (duration: 499.668859ms)","trace[1659409622] 'applied index is now lower than readState.Index' (duration: 485.662µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:29:41.310104Z","caller":"traceutil/trace.go:171","msg":"trace[1753756095] transaction","detail":"{read_only:false; response_revision:9852; number_of_response:1; }","duration":"520.895405ms","start":"2026-04-20T08:29:40.789178Z","end":"2026-04-20T08:29:41.310074Z","steps":["trace[1753756095] 'process raft request' (duration: 520.395403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:29:41.310195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.366726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:29:41.310243Z","caller":"traceutil/trace.go:171","msg":"trace[289184331] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:9852; }","duration":"500.476329ms","start":"2026-04-20T08:29:40.809752Z","end":"2026-04-20T08:29:41.310229Z","steps":["trace[289184331] 'agreement among raft nodes before linearized reading' (duration: 500.357906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:29:41.310236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:29:40.789154Z","time spent":"521.017257ms","remote":"127.0.0.1:52970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T08:29:41.310277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:29:40.809727Z","time spent":"500.54243ms","remote":"127.0.0.1:49224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "} {"level":"warn","ts":"2026-04-20T08:29:41.310292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.269754ms","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-04-20T08:29:41.310325Z","caller":"traceutil/trace.go:171","msg":"trace[508635936] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9852; }","duration":"327.343276ms","start":"2026-04-20T08:29:40.982972Z","end":"2026-04-20T08:29:41.310315Z","steps":["trace[508635936] 'agreement among raft nodes before linearized reading' (duration: 327.160741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:29:41.310359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:29:40.98294Z","time spent":"327.411898ms","remote":"127.0.0.1:52996","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-04-20T08:29:41.310404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.088835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-04-20T08:29:41.310505Z","caller":"traceutil/trace.go:171","msg":"trace[2035233759] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:9852; }","duration":"166.221918ms","start":"2026-04-20T08:29:41.144245Z","end":"2026-04-20T08:29:41.310467Z","steps":["trace[2035233759] 'agreement among raft nodes before linearized reading' (duration: 165.951592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:29:41.310546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.478796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:29:41.310583Z","caller":"traceutil/trace.go:171","msg":"trace[181010897] 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:9852; }","duration":"232.553548ms","start":"2026-04-20T08:29:41.078019Z","end":"2026-04-20T08:29:41.310573Z","steps":["trace[181010897] 'agreement among raft nodes before linearized reading' (duration: 232.493826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:29:41.3106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.936693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-20T08:29:41.310629Z","caller":"traceutil/trace.go:171","msg":"trace[76511492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9852; }","duration":"164.000795ms","start":"2026-04-20T08:29:41.146621Z","end":"2026-04-20T08:29:41.310622Z","steps":["trace[76511492] 'agreement among raft nodes before linearized reading' (duration: 163.925863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:29:41.310582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.958712ms","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-04-20T08:29:41.310693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.084001ms","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":"warn","ts":"2026-04-20T08:29:41.310742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.379296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-20T08:29:41.310741Z","caller":"traceutil/trace.go:171","msg":"trace[834689847] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9852; }","duration":"165.169314ms","start":"2026-04-20T08:29:41.145561Z","end":"2026-04-20T08:29:41.31073Z","steps":["trace[834689847] 'agreement among raft nodes before linearized reading' (duration: 165.01049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:29:41.310753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.934726ms","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-04-20T08:29:41.310764Z","caller":"traceutil/trace.go:171","msg":"trace[178845757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9852; }","duration":"167.440697ms","start":"2026-04-20T08:29:41.143318Z","end":"2026-04-20T08:29:41.310758Z","steps":["trace[178845757] 'agreement among raft nodes before linearized reading' (duration: 167.383536ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:29:41.310776Z","caller":"traceutil/trace.go:171","msg":"trace[1160633461] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9852; }","duration":"266.984247ms","start":"2026-04-20T08:29:41.043785Z","end":"2026-04-20T08:29:41.310769Z","steps":["trace[1160633461] 'agreement among raft nodes before linearized reading' (duration: 266.914736ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:29:41.310748Z","caller":"traceutil/trace.go:171","msg":"trace[278966074] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9852; }","duration":"174.205808ms","start":"2026-04-20T08:29:41.136521Z","end":"2026-04-20T08:29:41.310726Z","steps":["trace[278966074] 'agreement among raft nodes before linearized reading' (duration: 173.780768ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:31:10.065413Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8139} {"level":"info","ts":"2026-04-20T08:31:10.140207Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8139,"took":"72.442065ms","hash":405520027,"current-db-size-bytes":56242176,"current-db-size":"56 MB","current-db-size-in-use-bytes":24772608,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-20T08:31:10.140309Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":405520027,"revision":8139,"compact-revision":5918} {"level":"info","ts":"2026-04-20T08:36:10.074172Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10547} {"level":"info","ts":"2026-04-20T08:36:10.153025Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10547,"took":"76.036174ms","hash":4160811615,"current-db-size-bytes":56242176,"current-db-size":"56 MB","current-db-size-in-use-bytes":20025344,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-20T08:36:10.153093Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4160811615,"revision":10547,"compact-revision":8139}