{"level":"warn","ts":"2026-04-08T22:52:50.489089Z","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-08T22:52:50.489247Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74: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-08T22:52:50.490827Z","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-08T22:52:50.490878Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-04-08T22:52:50.491137Z","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-08T22:52:50.491882Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]} {"level":"info","ts":"2026-04-08T22:52:50.49197Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74: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-08T22:52:50.497682Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.492483ms"} {"level":"info","ts":"2026-04-08T22:52:50.504062Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"} {"level":"info","ts":"2026-04-08T22:52:50.504141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T22:52:50.504163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"} {"level":"info","ts":"2026-04-08T22:52:50.504176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T22:52:50.504184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"} {"level":"info","ts":"2026-04-08T22:52:50.504223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"warn","ts":"2026-04-08T22:52:50.512492Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T22:52:50.513553Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T22:52:50.515124Z","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-08T22:52:50.518971Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T22:52:50.520252Z","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-08T22:52:50.520227Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T22:52:50.520945Z","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-08T22:52:50.520975Z","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-08T22:52:50.522118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"info","ts":"2026-04-08T22:52:50.525566Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-04-08T22:52:50.526716Z","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-08T22:52:50.526795Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-04-08T22:52:50.526827Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-04-08T22:52:50.526935Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T22:52:50.526976Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T22:52:51.504494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T22:52:51.504787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T22:52:51.504875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"} {"level":"info","ts":"2026-04-08T22:52:51.504919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"} {"level":"info","ts":"2026-04-08T22:52:51.504983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-04-08T22:52:51.505066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"} {"level":"info","ts":"2026-04-08T22:52:51.50511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-04-08T22:52:51.506246Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:52:51.507151Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T22:52:51.507157Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T22:52:51.507215Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T22:52:51.507594Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T22:52:51.507637Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T22:52:51.507859Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:52:51.508066Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:52:51.508149Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:52:51.510394Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T22:52:51.51105Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"} {"level":"warn","ts":"2026-04-08T22:52:53.001323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.461557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T22:52:53.001481Z","caller":"traceutil/trace.go:171","msg":"trace[1170161215] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:4; }","duration":"151.694139ms","start":"2026-04-08T22:52:52.849761Z","end":"2026-04-08T22:52:53.001455Z","steps":["trace[1170161215] 'range keys from in-memory index tree' (duration: 151.355521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.001529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.227535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T22:52:53.00182Z","caller":"traceutil/trace.go:171","msg":"trace[144384269] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:0; response_revision:4; }","duration":"151.53384ms","start":"2026-04-08T22:52:52.850266Z","end":"2026-04-08T22:52:53.0018Z","steps":["trace[144384269] 'range keys from in-memory index tree' (duration: 151.157131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.001779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.365753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T22:52:53.002003Z","caller":"traceutil/trace.go:171","msg":"trace[567070020] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:4; }","duration":"167.616425ms","start":"2026-04-08T22:52:52.834335Z","end":"2026-04-08T22:52:53.001951Z","steps":["trace[567070020] 'range keys from in-memory index tree' (duration: 167.260948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.002504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.579982ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-08T22:52:53.002609Z","caller":"traceutil/trace.go:171","msg":"trace[321091565] linearizableReadLoop","detail":"{readStateIndex:8; appliedIndex:7; }","duration":"149.871938ms","start":"2026-04-08T22:52:52.852722Z","end":"2026-04-08T22:52:53.002594Z","steps":["trace[321091565] 'read index received' (duration: 16.673324ms)","trace[321091565] 'applied index is now lower than readState.Index' (duration: 133.197264ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:52:53.002678Z","caller":"traceutil/trace.go:171","msg":"trace[1499260371] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"151.144711ms","start":"2026-04-08T22:52:52.851481Z","end":"2026-04-08T22:52:53.002625Z","steps":["trace[1499260371] 'process raft request' (duration: 17.923227ms)","trace[1499260371] 'compare' (duration: 131.793123ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:52:53.002832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.095499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T22:52:53.00293Z","caller":"traceutil/trace.go:171","msg":"trace[1132834397] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:5; }","duration":"150.209945ms","start":"2026-04-08T22:52:52.852698Z","end":"2026-04-08T22:52:53.002908Z","steps":["trace[1132834397] 'agreement among raft nodes before linearized reading' (duration: 149.996904ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:52:53.280894Z","caller":"traceutil/trace.go:171","msg":"trace[164163191] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"426.699632ms","start":"2026-04-08T22:52:52.85416Z","end":"2026-04-08T22:52:53.28086Z","steps":["trace[164163191] 'process raft request' (duration: 376.937983ms)","trace[164163191] 'compare' (duration: 49.545978ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:52:53.28104Z","caller":"traceutil/trace.go:171","msg":"trace[1993119504] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"426.794677ms","start":"2026-04-08T22:52:52.854206Z","end":"2026-04-08T22:52:53.281001Z","steps":["trace[1993119504] 'process raft request' (duration: 426.627189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.281038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:52.854146Z","time spent":"426.824449ms","remote":"127.0.0.1:41734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:52:53.281177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:52.854184Z","time spent":"426.933864ms","remote":"127.0.0.1:41734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:52:53.281222Z","caller":"traceutil/trace.go:171","msg":"trace[1759790051] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"427.002728ms","start":"2026-04-08T22:52:52.854205Z","end":"2026-04-08T22:52:53.281208Z","steps":["trace[1759790051] 'process raft request' (duration: 426.668651ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:52:53.281215Z","caller":"traceutil/trace.go:171","msg":"trace[57348617] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"275.00188ms","start":"2026-04-08T22:52:53.006188Z","end":"2026-04-08T22:52:53.28119Z","steps":["trace[57348617] 'process raft request' (duration: 274.940757ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:52:53.281286Z","caller":"traceutil/trace.go:171","msg":"trace[1967363524] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"415.234399ms","start":"2026-04-08T22:52:52.866045Z","end":"2026-04-08T22:52:53.281279Z","steps":["trace[1967363524] 'process raft request' (duration: 414.962015ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:52:53.28113Z","caller":"traceutil/trace.go:171","msg":"trace[1250491533] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"426.335894ms","start":"2026-04-08T22:52:52.85475Z","end":"2026-04-08T22:52:53.281085Z","steps":["trace[1250491533] 'process raft request' (duration: 426.157875ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.28132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:52.866032Z","time spent":"415.272161ms","remote":"127.0.0.1:41404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:52:53.281363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:52.85418Z","time spent":"427.094322ms","remote":"127.0.0.1:41734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:52:53.281418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:52.854731Z","time spent":"426.594697ms","remote":"127.0.0.1:41734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:52:53.281486Z","caller":"traceutil/trace.go:171","msg":"trace[1325169158] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:8; }","duration":"278.825165ms","start":"2026-04-08T22:52:53.002636Z","end":"2026-04-08T22:52:53.281462Z","steps":["trace[1325169158] 'read index received' (duration: 228.473746ms)","trace[1325169158] 'applied index is now lower than readState.Index' (duration: 50.349609ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:52:53.280935Z","caller":"traceutil/trace.go:171","msg":"trace[171384344] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"426.696242ms","start":"2026-04-08T22:52:52.854198Z","end":"2026-04-08T22:52:53.280895Z","steps":["trace[171384344] 'process raft request' (duration: 426.582606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.281695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.7563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T22:52:53.281693Z","caller":"traceutil/trace.go:171","msg":"trace[1469024320] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"276.938529ms","start":"2026-04-08T22:52:53.004745Z","end":"2026-04-08T22:52:53.281684Z","steps":["trace[1469024320] 'process raft request' (duration: 276.307497ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:52:53.281938Z","caller":"traceutil/trace.go:171","msg":"trace[1831820874] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13; }","duration":"277.904258ms","start":"2026-04-08T22:52:53.003865Z","end":"2026-04-08T22:52:53.28177Z","steps":["trace[1831820874] 'agreement among raft nodes before linearized reading' (duration: 277.74926ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:52:53.281654Z","caller":"traceutil/trace.go:171","msg":"trace[508009703] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12; }","duration":"275.640683ms","start":"2026-04-08T22:52:53.006001Z","end":"2026-04-08T22:52:53.281642Z","steps":["trace[508009703] 'process raft request' (duration: 275.092055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.281667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.819499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T22:52:53.282414Z","caller":"traceutil/trace.go:171","msg":"trace[748281779] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:13; }","duration":"414.570126ms","start":"2026-04-08T22:52:52.86782Z","end":"2026-04-08T22:52:53.28239Z","steps":["trace[748281779] 'agreement among raft nodes before linearized reading' (duration: 413.772196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.282445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:52.867814Z","time spent":"414.62386ms","remote":"127.0.0.1:41620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-04-08T22:52:53.28169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.695282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-08T22:52:53.282525Z","caller":"traceutil/trace.go:171","msg":"trace[1655143111] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:13; }","duration":"418.555496ms","start":"2026-04-08T22:52:52.863959Z","end":"2026-04-08T22:52:53.282515Z","steps":["trace[1655143111] 'agreement among raft nodes before linearized reading' (duration: 417.637119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.282585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:52.86395Z","time spent":"418.62554ms","remote":"127.0.0.1:41328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-08T22:52:53.281707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.978355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-08T22:52:53.282673Z","caller":"traceutil/trace.go:171","msg":"trace[993782493] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:13; }","duration":"376.928944ms","start":"2026-04-08T22:52:52.905711Z","end":"2026-04-08T22:52:53.28264Z","steps":["trace[993782493] 'agreement among raft nodes before linearized reading' (duration: 375.978415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.282709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:52.905702Z","time spent":"376.997507ms","remote":"127.0.0.1:41328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-08T22:52:53.2817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.872691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-08T22:52:53.282779Z","caller":"traceutil/trace.go:171","msg":"trace[998513424] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:13; }","duration":"418.984988ms","start":"2026-04-08T22:52:52.863787Z","end":"2026-04-08T22:52:53.282772Z","steps":["trace[998513424] 'agreement among raft nodes before linearized reading' (duration: 417.814638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.282799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:52.863779Z","time spent":"419.014749ms","remote":"127.0.0.1:41328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-08T22:52:53.28475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:52.854174Z","time spent":"427.64536ms","remote":"127.0.0.1:41734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:52:53.795991Z","caller":"traceutil/trace.go:171","msg":"trace[2125452686] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"509.943307ms","start":"2026-04-08T22:52:53.286019Z","end":"2026-04-08T22:52:53.795963Z","steps":["trace[2125452686] 'process raft request' (duration: 509.683374ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:52:53.796019Z","caller":"traceutil/trace.go:171","msg":"trace[615330551] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"509.41688ms","start":"2026-04-08T22:52:53.286583Z","end":"2026-04-08T22:52:53.796Z","steps":["trace[615330551] 'process raft request' (duration: 509.302654ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:52:53.796095Z","caller":"traceutil/trace.go:171","msg":"trace[1274543064] linearizableReadLoop","detail":"{readStateIndex:19; appliedIndex:17; }","duration":"509.954577ms","start":"2026-04-08T22:52:53.286128Z","end":"2026-04-08T22:52:53.796083Z","steps":["trace[1274543064] 'read index received' (duration: 27.159216ms)","trace[1274543064] 'applied index is now lower than readState.Index' (duration: 482.794401ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:52:53.796166Z","caller":"traceutil/trace.go:171","msg":"trace[1143964115] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"508.727265ms","start":"2026-04-08T22:52:53.287432Z","end":"2026-04-08T22:52:53.79616Z","steps":["trace[1143964115] 'process raft request' (duration: 508.535185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.796118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.286574Z","time spent":"509.484923ms","remote":"127.0.0.1:41734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:52:53.796243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.287424Z","time spent":"508.770377ms","remote":"127.0.0.1:41734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:52:53.796246Z","caller":"traceutil/trace.go:171","msg":"trace[1442275758] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"509.442661ms","start":"2026-04-08T22:52:53.286789Z","end":"2026-04-08T22:52:53.796232Z","steps":["trace[1442275758] 'process raft request' (duration: 509.120504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.796302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.286578Z","time spent":"509.697354ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:52:53.796306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.286007Z","time spent":"510.042482ms","remote":"127.0.0.1:41664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:52:53.796331Z","caller":"traceutil/trace.go:171","msg":"trace[263932987] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"508.027729ms","start":"2026-04-08T22:52:53.288297Z","end":"2026-04-08T22:52:53.796325Z","steps":["trace[263932987] 'process raft request' (duration: 507.687891ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:52:53.796321Z","caller":"traceutil/trace.go:171","msg":"trace[370111587] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"510.047612ms","start":"2026-04-08T22:52:53.286258Z","end":"2026-04-08T22:52:53.796305Z","steps":["trace[370111587] 'process raft request' (duration: 509.565057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.796358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.288285Z","time spent":"508.060171ms","remote":"127.0.0.1:41734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:52:53.796384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.286251Z","time spent":"510.105765ms","remote":"127.0.0.1:41734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:52:53.796053Z","caller":"traceutil/trace.go:171","msg":"trace[514407347] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"508.759967ms","start":"2026-04-08T22:52:53.287273Z","end":"2026-04-08T22:52:53.796033Z","steps":["trace[514407347] 'process raft request' (duration: 508.667492ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:52:53.796538Z","caller":"traceutil/trace.go:171","msg":"trace[1387550424] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"510.148917ms","start":"2026-04-08T22:52:53.286376Z","end":"2026-04-08T22:52:53.796525Z","steps":["trace[1387550424] 'process raft request' (duration: 509.480113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.796554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.287264Z","time spent":"509.271122ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:52:53.79661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.193529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-08T22:52:53.796609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.286371Z","time spent":"510.19269ms","remote":"127.0.0.1:41320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:52:53.796637Z","caller":"traceutil/trace.go:171","msg":"trace[1587125579] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:24; }","duration":"509.237041ms","start":"2026-04-08T22:52:53.287392Z","end":"2026-04-08T22:52:53.796629Z","steps":["trace[1587125579] 'agreement among raft nodes before linearized reading' (duration: 509.186349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.796664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.287387Z","time spent":"509.272303ms","remote":"127.0.0.1:41320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-04-08T22:52:53.796652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.481574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"warn","ts":"2026-04-08T22:52:53.796833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.424169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T22:52:53.796824Z","caller":"traceutil/trace.go:171","msg":"trace[1607391695] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24; }","duration":"510.684815ms","start":"2026-04-08T22:52:53.286115Z","end":"2026-04-08T22:52:53.796799Z","steps":["trace[1607391695] 'agreement among raft nodes before linearized reading' (duration: 510.318726ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:52:53.796855Z","caller":"traceutil/trace.go:171","msg":"trace[1124403877] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:24; }","duration":"508.475792ms","start":"2026-04-08T22:52:53.288372Z","end":"2026-04-08T22:52:53.796848Z","steps":["trace[1124403877] 'agreement among raft nodes before linearized reading' (duration: 508.440661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.79685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.846011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-08T22:52:53.796874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.288312Z","time spent":"508.557296ms","remote":"127.0.0.1:41306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"warn","ts":"2026-04-08T22:52:53.796879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.28611Z","time spent":"510.752408ms","remote":"127.0.0.1:41404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3513,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-08T22:52:53.79688Z","caller":"traceutil/trace.go:171","msg":"trace[1097015621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24; }","duration":"479.896404ms","start":"2026-04-08T22:52:53.316976Z","end":"2026-04-08T22:52:53.796873Z","steps":["trace[1097015621] 'agreement among raft nodes before linearized reading' (duration: 479.838351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.797007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.316964Z","time spent":"480.028401ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-08T22:52:53.797117Z","caller":"traceutil/trace.go:171","msg":"trace[1780633848] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"508.562176ms","start":"2026-04-08T22:52:53.28854Z","end":"2026-04-08T22:52:53.797102Z","steps":["trace[1780633848] 'process raft request' (duration: 507.46594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.797209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.288533Z","time spent":"508.618899ms","remote":"127.0.0.1:41734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:52:53.797245Z","caller":"traceutil/trace.go:171","msg":"trace[1814376212] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"504.768483ms","start":"2026-04-08T22:52:53.292463Z","end":"2026-04-08T22:52:53.797232Z","steps":["trace[1814376212] 'process raft request' (duration: 503.575632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:52:53.798174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:53.292449Z","time spent":"504.814546ms","remote":"127.0.0.1:41404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:53:00.28205Z","caller":"traceutil/trace.go:171","msg":"trace[1957812215] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"302.393846ms","start":"2026-04-08T22:52:59.979634Z","end":"2026-04-08T22:53:00.282028Z","steps":["trace[1957812215] 'process raft request' (duration: 302.215256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:00.282223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:52:59.97961Z","time spent":"302.520364ms","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":180,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:53:01.294222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.208451ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:53:01.294344Z","caller":"traceutil/trace.go:171","msg":"trace[1283503307] linearizableReadLoop","detail":"{readStateIndex:305; appliedIndex:304; }","duration":"341.23359ms","start":"2026-04-08T22:53:00.953089Z","end":"2026-04-08T22:53:01.294323Z","steps":["trace[1283503307] 'read index received' (duration: 165.810457ms)","trace[1283503307] 'applied index is now lower than readState.Index' (duration: 175.421393ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:53:01.294474Z","caller":"traceutil/trace.go:171","msg":"trace[1738072445] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"1.000680176s","start":"2026-04-08T22:53:00.293753Z","end":"2026-04-08T22:53:01.294433Z","steps":["trace[1738072445] 'process raft request' (duration: 825.18691ms)","trace[1738072445] 'compare' (duration: 175.03569ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:53:01.294602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.85978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-08T22:53:01.294696Z","caller":"traceutil/trace.go:171","msg":"trace[1717198677] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:294; }","duration":"174.993568ms","start":"2026-04-08T22:53:01.119683Z","end":"2026-04-08T22:53:01.294676Z","steps":["trace[1717198677] 'agreement among raft nodes before linearized reading' (duration: 174.761534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:01.29476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.612662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-08T22:53:01.29473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:00.293734Z","time spent":"1.000847046s","remote":"127.0.0.1:41434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":209,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:53:01.294792Z","caller":"traceutil/trace.go:171","msg":"trace[649447061] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:294; }","duration":"341.74505ms","start":"2026-04-08T22:53:00.953039Z","end":"2026-04-08T22:53:01.294784Z","steps":["trace[649447061] 'agreement among raft nodes before linearized reading' (duration: 341.419531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:01.294865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:00.953018Z","time spent":"341.841746ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-08T22:53:21.41544Z","caller":"traceutil/trace.go:171","msg":"trace[1590378726] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"393.822881ms","start":"2026-04-08T22:53:21.021583Z","end":"2026-04-08T22:53:21.415406Z","steps":["trace[1590378726] 'process raft request' (duration: 393.561823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:21.415629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:21.021561Z","time spent":"393.979172ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:53:21.431691Z","caller":"traceutil/trace.go:171","msg":"trace[418026279] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"407.515599ms","start":"2026-04-08T22:53:21.024139Z","end":"2026-04-08T22:53:21.431654Z","steps":["trace[418026279] 'process raft request' (duration: 406.916667ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:21.431895Z","caller":"traceutil/trace.go:171","msg":"trace[967872746] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"363.473732ms","start":"2026-04-08T22:53:21.068413Z","end":"2026-04-08T22:53:21.431886Z","steps":["trace[967872746] 'process raft request' (duration: 363.064514ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:21.431728Z","caller":"traceutil/trace.go:171","msg":"trace[1759422921] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"379.024437ms","start":"2026-04-08T22:53:21.052665Z","end":"2026-04-08T22:53:21.431689Z","steps":["trace[1759422921] 'process raft request' (duration: 378.688104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:21.431993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:21.068395Z","time spent":"363.536546ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:53:21.432076Z","caller":"traceutil/trace.go:171","msg":"trace[1270305946] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"348.178114ms","start":"2026-04-08T22:53:21.083881Z","end":"2026-04-08T22:53:21.432059Z","steps":["trace[1270305946] 'process raft request' (duration: 347.649157ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:21.431689Z","caller":"traceutil/trace.go:171","msg":"trace[1485872817] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"380.706554ms","start":"2026-04-08T22:53:21.050905Z","end":"2026-04-08T22:53:21.431611Z","steps":["trace[1485872817] 'process raft request' (duration: 380.336008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:21.432141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:21.083865Z","time spent":"348.240808ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:53:21.431728Z","caller":"traceutil/trace.go:171","msg":"trace[1910596163] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"400.051402ms","start":"2026-04-08T22:53:21.031646Z","end":"2026-04-08T22:53:21.431698Z","steps":["trace[1910596163] 'process raft request' (duration: 399.550057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:21.432379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:21.031618Z","time spent":"400.737719ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:53:21.431778Z","caller":"traceutil/trace.go:171","msg":"trace[1371545981] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"378.937951ms","start":"2026-04-08T22:53:21.052824Z","end":"2026-04-08T22:53:21.431762Z","steps":["trace[1371545981] 'process raft request' (duration: 378.563685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:21.432412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:21.024125Z","time spent":"407.803749ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:53:21.4318Z","caller":"traceutil/trace.go:171","msg":"trace[678608168] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"380.722735ms","start":"2026-04-08T22:53:21.051068Z","end":"2026-04-08T22:53:21.431791Z","steps":["trace[678608168] 'process raft request' (duration: 380.20479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:21.432569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:21.052811Z","time spent":"379.678723ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:53:21.432624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:21.051061Z","time spent":"381.539591ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:53:21.431846Z","caller":"traceutil/trace.go:171","msg":"trace[773496254] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"407.668479ms","start":"2026-04-08T22:53:21.024164Z","end":"2026-04-08T22:53:21.431675Z","steps":["trace[773496254] 'process raft request' (duration: 406.993813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:21.432732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:21.024152Z","time spent":"408.559051ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:53:21.431835Z","caller":"traceutil/trace.go:171","msg":"trace[1518623964] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"372.567521ms","start":"2026-04-08T22:53:21.059249Z","end":"2026-04-08T22:53:21.431816Z","steps":["trace[1518623964] 'process raft request' (duration: 372.178994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:21.432829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:21.059229Z","time spent":"373.576311ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:53:21.432465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:21.050874Z","time spent":"381.252162ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:53:21.432469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:21.052646Z","time spent":"379.354641ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:53:21.433053Z","caller":"traceutil/trace.go:171","msg":"trace[588263012] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"254.002739ms","start":"2026-04-08T22:53:21.179034Z","end":"2026-04-08T22:53:21.433036Z","steps":["trace[588263012] 'process raft request' (duration: 253.508465ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:27.819828Z","caller":"traceutil/trace.go:171","msg":"trace[1793549246] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"187.6266ms","start":"2026-04-08T22:53:27.632053Z","end":"2026-04-08T22:53:27.81968Z","steps":["trace[1793549246] 'process raft request' (duration: 163.998294ms)","trace[1793549246] 'compare' (duration: 23.291582ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:53:29.727933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.676682ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:53:29.728094Z","caller":"traceutil/trace.go:171","msg":"trace[1282068574] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"1.079538049s","start":"2026-04-08T22:53:28.64849Z","end":"2026-04-08T22:53:29.728029Z","steps":["trace[1282068574] 'read index received' (duration: 333.754639ms)","trace[1282068574] 'applied index is now lower than readState.Index' (duration: 745.78206ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:53:29.728185Z","caller":"traceutil/trace.go:171","msg":"trace[369219369] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"1.33493581s","start":"2026-04-08T22:53:28.393185Z","end":"2026-04-08T22:53:29.728121Z","steps":["trace[369219369] 'process raft request' (duration: 588.989828ms)","trace[369219369] 'compare' (duration: 745.23008ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:53:29.728345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:28.393169Z","time spent":"1.335112733s","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:53:29.728491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079995362s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-w9pvx\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-08T22:53:29.728548Z","caller":"traceutil/trace.go:171","msg":"trace[1753097518] range","detail":"{range_begin:/registry/pods/kube-system/cilium-w9pvx; range_end:; response_count:1; response_revision:587; }","duration":"1.080062576s","start":"2026-04-08T22:53:28.648472Z","end":"2026-04-08T22:53:29.728534Z","steps":["trace[1753097518] 'agreement among raft nodes before linearized reading' (duration: 1.079713561s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:29.728584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:28.648402Z","time spent":"1.080172784s","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-w9pvx\" "} {"level":"warn","ts":"2026-04-08T22:53:29.728761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.676981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:29.72883Z","caller":"traceutil/trace.go:171","msg":"trace[195181699] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"980.786509ms","start":"2026-04-08T22:53:28.748031Z","end":"2026-04-08T22:53:29.728817Z","steps":["trace[195181699] 'agreement among raft nodes before linearized reading' (duration: 980.682341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:29.72889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:28.74801Z","time spent":"980.870075ms","remote":"127.0.0.1:41210","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-08T22:53:29.729229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.0679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-08T22:53:29.729441Z","caller":"traceutil/trace.go:171","msg":"trace[600070925] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"132.305057ms","start":"2026-04-08T22:53:29.597116Z","end":"2026-04-08T22:53:29.729421Z","steps":["trace[600070925] 'agreement among raft nodes before linearized reading' (duration: 132.012136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:29.730083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.213613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T22:53:29.730204Z","caller":"traceutil/trace.go:171","msg":"trace[53526778] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:587; }","duration":"153.564559ms","start":"2026-04-08T22:53:29.576611Z","end":"2026-04-08T22:53:29.730175Z","steps":["trace[53526778] 'agreement among raft nodes before linearized reading' (duration: 152.540705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:30.522383Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392561035758815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T22:53:31.023173Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392561035758815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T22:53:31.192157Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.302442534s","expected-duration":"1s"} {"level":"info","ts":"2026-04-08T22:53:31.251077Z","caller":"traceutil/trace.go:171","msg":"trace[448764309] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"1.517461313s","start":"2026-04-08T22:53:29.733581Z","end":"2026-04-08T22:53:31.251043Z","steps":["trace[448764309] 'process raft request' (duration: 1.458772951s)","trace[448764309] 'compare' (duration: 57.981561ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:53:31.251213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:29.733557Z","time spent":"1.517585202s","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:53:31.253838Z","caller":"traceutil/trace.go:171","msg":"trace[1703590619] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"1.519491622s","start":"2026-04-08T22:53:29.734312Z","end":"2026-04-08T22:53:31.253803Z","steps":["trace[1703590619] 'process raft request' (duration: 1.519386174s)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:31.253923Z","caller":"traceutil/trace.go:171","msg":"trace[981745355] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"1.518793782s","start":"2026-04-08T22:53:29.735119Z","end":"2026-04-08T22:53:31.253913Z","steps":["trace[981745355] 'process raft request' (duration: 1.518648941s)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:31.253908Z","caller":"traceutil/trace.go:171","msg":"trace[759550300] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"1.519971646s","start":"2026-04-08T22:53:29.733901Z","end":"2026-04-08T22:53:31.253873Z","steps":["trace[759550300] 'process raft request' (duration: 1.519682895s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:31.253999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:29.734294Z","time spent":"1.519620851s","remote":"127.0.0.1:41304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T22:53:31.254028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:29.73511Z","time spent":"1.518853795s","remote":"127.0.0.1:41452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:53:31.253857Z","caller":"traceutil/trace.go:171","msg":"trace[1458778512] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"1.519401494s","start":"2026-04-08T22:53:29.734425Z","end":"2026-04-08T22:53:31.253827Z","steps":["trace[1458778512] 'process raft request' (duration: 1.519300947s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:31.254211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:29.734416Z","time spent":"1.519769811s","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:53:31.254131Z","caller":"traceutil/trace.go:171","msg":"trace[1070971909] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.518670812s","start":"2026-04-08T22:53:29.735416Z","end":"2026-04-08T22:53:31.254087Z","steps":["trace[1070971909] 'process raft request' (duration: 1.518383341s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:31.254273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:29.733864Z","time spent":"1.520141558s","remote":"127.0.0.1:41304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T22:53:31.254365Z","caller":"traceutil/trace.go:171","msg":"trace[1145811150] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.511515978s","start":"2026-04-08T22:53:29.74284Z","end":"2026-04-08T22:53:31.254356Z","steps":["trace[1145811150] 'process raft request' (duration: 1.51099937s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:31.254405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:29.742822Z","time spent":"1.511561721s","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:53:31.254515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:29.735406Z","time spent":"1.518919251s","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:53:31.308952Z","caller":"traceutil/trace.go:171","msg":"trace[1951957129] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:610; }","duration":"1.287483551s","start":"2026-04-08T22:53:30.02144Z","end":"2026-04-08T22:53:31.308923Z","steps":["trace[1951957129] 'read index received' (duration: 1.170927637s)","trace[1951957129] 'applied index is now lower than readState.Index' (duration: 116.554124ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:53:31.309217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.287751501s","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-08T22:53:31.309321Z","caller":"traceutil/trace.go:171","msg":"trace[1889325406] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:594; }","duration":"1.287906532s","start":"2026-04-08T22:53:30.02139Z","end":"2026-04-08T22:53:31.309297Z","steps":["trace[1889325406] 'agreement among raft nodes before linearized reading' (duration: 1.287637203s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:31.309374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:30.021369Z","time spent":"1.287995068s","remote":"127.0.0.1:41484","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-08T22:53:31.319578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185954752s","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-08T22:53:31.319654Z","caller":"traceutil/trace.go:171","msg":"trace[1685132646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"1.18607219s","start":"2026-04-08T22:53:30.133562Z","end":"2026-04-08T22:53:31.319634Z","steps":["trace[1685132646] 'agreement among raft nodes before linearized reading' (duration: 1.185888577s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:31.31969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:30.133541Z","time spent":"1.186139395s","remote":"127.0.0.1:41484","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-08T22:53:31.319666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.018852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:31.320318Z","caller":"traceutil/trace.go:171","msg":"trace[547150063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"572.719393ms","start":"2026-04-08T22:53:30.747584Z","end":"2026-04-08T22:53:31.320304Z","steps":["trace[547150063] 'agreement among raft nodes before linearized reading' (duration: 572.023992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:31.320369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:30.747567Z","time spent":"572.790608ms","remote":"127.0.0.1:41210","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-08T22:53:31.822273Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392561035758827,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T22:53:32.323389Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530392561035758827,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T22:53:32.343494Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.024595582s","expected-duration":"1s"} {"level":"info","ts":"2026-04-08T22:53:32.344539Z","caller":"traceutil/trace.go:171","msg":"trace[1177192728] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"1.029483398s","start":"2026-04-08T22:53:31.315037Z","end":"2026-04-08T22:53:32.344521Z","steps":["trace[1177192728] 'process raft request' (duration: 1.029363569s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.34466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.315014Z","time spent":"1.029584914s","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:53:32.413765Z","caller":"traceutil/trace.go:171","msg":"trace[131669849] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"1.092705769s","start":"2026-04-08T22:53:31.321028Z","end":"2026-04-08T22:53:32.413734Z","steps":["trace[131669849] 'read index received' (duration: 1.023972418s)","trace[131669849] 'applied index is now lower than readState.Index' (duration: 68.731981ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:53:32.414123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093061374s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.41421Z","caller":"traceutil/trace.go:171","msg":"trace[1737502038] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"1.093181433s","start":"2026-04-08T22:53:31.321011Z","end":"2026-04-08T22:53:32.414192Z","steps":["trace[1737502038] 'agreement among raft nodes before linearized reading' (duration: 1.09299938s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.414209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.35372ms","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-08T22:53:32.414263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.320999Z","time spent":"1.093254889s","remote":"127.0.0.1:41220","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-08T22:53:32.414331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.279338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.414373Z","caller":"traceutil/trace.go:171","msg":"trace[1742198480] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:596; }","duration":"130.412728ms","start":"2026-04-08T22:53:32.283951Z","end":"2026-04-08T22:53:32.414364Z","steps":["trace[1742198480] 'agreement among raft nodes before linearized reading' (duration: 130.332702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.414164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.820974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:53:32.414617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.484809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:53:32.414695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.011141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.414699Z","caller":"traceutil/trace.go:171","msg":"trace[1090100244] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:596; }","duration":"187.569005ms","start":"2026-04-08T22:53:32.227118Z","end":"2026-04-08T22:53:32.414687Z","steps":["trace[1090100244] 'agreement among raft nodes before linearized reading' (duration: 187.460497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.414534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.132343ms","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":"warn","ts":"2026-04-08T22:53:32.414755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.442473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.414786Z","caller":"traceutil/trace.go:171","msg":"trace[508458576] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:596; }","duration":"224.483176ms","start":"2026-04-08T22:53:32.190298Z","end":"2026-04-08T22:53:32.414781Z","steps":["trace[508458576] 'agreement among raft nodes before linearized reading' (duration: 224.443023ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:32.414623Z","caller":"traceutil/trace.go:171","msg":"trace[1351088961] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:596; }","duration":"687.30673ms","start":"2026-04-08T22:53:31.727281Z","end":"2026-04-08T22:53:32.414588Z","steps":["trace[1351088961] 'agreement among raft nodes before linearized reading' (duration: 686.821545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.41488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.120831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:53:32.414947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.497031ms","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-08T22:53:32.414963Z","caller":"traceutil/trace.go:171","msg":"trace[333528203] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:596; }","duration":"152.225288ms","start":"2026-04-08T22:53:32.262719Z","end":"2026-04-08T22:53:32.414945Z","steps":["trace[333528203] 'agreement among raft nodes before linearized reading' (duration: 152.10958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.414983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.3911ms","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-08T22:53:32.414986Z","caller":"traceutil/trace.go:171","msg":"trace[828269196] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:596; }","duration":"387.546134ms","start":"2026-04-08T22:53:32.027428Z","end":"2026-04-08T22:53:32.414974Z","steps":["trace[828269196] 'agreement among raft nodes before linearized reading' (duration: 387.49423ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:32.415004Z","caller":"traceutil/trace.go:171","msg":"trace[740271609] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:596; }","duration":"338.431934ms","start":"2026-04-08T22:53:32.076565Z","end":"2026-04-08T22:53:32.414997Z","steps":["trace[740271609] 'agreement among raft nodes before linearized reading' (duration: 338.405462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.415025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:32.076556Z","time spent":"338.462296ms","remote":"127.0.0.1:50394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-08T22:53:32.415028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:32.02742Z","time spent":"387.594488ms","remote":"127.0.0.1:50376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-08T22:53:32.414924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.727252Z","time spent":"687.649595ms","remote":"127.0.0.1:50298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-08T22:53:32.41519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.166642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:53:32.415208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.371654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.415253Z","caller":"traceutil/trace.go:171","msg":"trace[1637541704] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:596; }","duration":"388.461011ms","start":"2026-04-08T22:53:32.026777Z","end":"2026-04-08T22:53:32.415238Z","steps":["trace[1637541704] 'agreement among raft nodes before linearized reading' (duration: 388.401447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.415291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.69543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:53:32.415299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:32.026754Z","time spent":"388.535987ms","remote":"127.0.0.1:50390","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":"warn","ts":"2026-04-08T22:53:32.4152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.94669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:53:32.414657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.579705ms","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-08T22:53:32.415371Z","caller":"traceutil/trace.go:171","msg":"trace[1323935185] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:596; }","duration":"339.320539ms","start":"2026-04-08T22:53:32.076045Z","end":"2026-04-08T22:53:32.415366Z","steps":["trace[1323935185] 'agreement among raft nodes before linearized reading' (duration: 338.561813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.415406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:32.075971Z","time spent":"339.414585ms","remote":"127.0.0.1:50394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-08T22:53:32.414896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.963992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:53:32.415262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.486268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.415027Z","caller":"traceutil/trace.go:171","msg":"trace[895170369] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:596; }","duration":"187.555114ms","start":"2026-04-08T22:53:32.227309Z","end":"2026-04-08T22:53:32.414864Z","steps":["trace[895170369] 'agreement among raft nodes before linearized reading' (duration: 187.006654ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:32.415513Z","caller":"traceutil/trace.go:171","msg":"trace[2054557607] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:596; }","duration":"152.753447ms","start":"2026-04-08T22:53:32.262754Z","end":"2026-04-08T22:53:32.415507Z","steps":["trace[2054557607] 'agreement among raft nodes before linearized reading' (duration: 152.489468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.41551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.24241ms","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-08T22:53:32.415557Z","caller":"traceutil/trace.go:171","msg":"trace[1332458421] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:596; }","duration":"166.395762ms","start":"2026-04-08T22:53:32.24915Z","end":"2026-04-08T22:53:32.415545Z","steps":["trace[1332458421] 'agreement among raft nodes before linearized reading' (duration: 166.251371ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:32.41525Z","caller":"traceutil/trace.go:171","msg":"trace[15730575] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:596; }","duration":"165.28209ms","start":"2026-04-08T22:53:32.249953Z","end":"2026-04-08T22:53:32.415236Z","steps":["trace[15730575] 'agreement among raft nodes before linearized reading' (duration: 165.14179ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:32.414261Z","caller":"traceutil/trace.go:171","msg":"trace[227633614] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:596; }","duration":"387.449237ms","start":"2026-04-08T22:53:32.026797Z","end":"2026-04-08T22:53:32.414247Z","steps":["trace[227633614] 'agreement among raft nodes before linearized reading' (duration: 387.35048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.415647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:32.026775Z","time spent":"388.864241ms","remote":"127.0.0.1:50390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-08T22:53:32.415259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.027836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.415737Z","caller":"traceutil/trace.go:171","msg":"trace[353389813] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:596; }","duration":"132.523072ms","start":"2026-04-08T22:53:32.283202Z","end":"2026-04-08T22:53:32.415725Z","steps":["trace[353389813] 'agreement among raft nodes before linearized reading' (duration: 132.027336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.415682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.891188ms","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":"info","ts":"2026-04-08T22:53:32.415791Z","caller":"traceutil/trace.go:171","msg":"trace[379734902] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:596; }","duration":"188.04046ms","start":"2026-04-08T22:53:32.227739Z","end":"2026-04-08T22:53:32.41578Z","steps":["trace[379734902] 'agreement among raft nodes before linearized reading' (duration: 187.850966ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:32.415516Z","caller":"traceutil/trace.go:171","msg":"trace[995696659] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:596; }","duration":"132.270674ms","start":"2026-04-08T22:53:32.283205Z","end":"2026-04-08T22:53:32.415476Z","steps":["trace[995696659] 'agreement among raft nodes before linearized reading' (duration: 131.919958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.415933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.487645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.415484Z","caller":"traceutil/trace.go:171","msg":"trace[882128088] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:596; }","duration":"339.583758ms","start":"2026-04-08T22:53:32.07589Z","end":"2026-04-08T22:53:32.415474Z","steps":["trace[882128088] 'agreement among raft nodes before linearized reading' (duration: 338.968383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.416016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:32.07587Z","time spent":"340.136398ms","remote":"127.0.0.1:50394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"info","ts":"2026-04-08T22:53:32.415314Z","caller":"traceutil/trace.go:171","msg":"trace[1277177536] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:596; }","duration":"151.733242ms","start":"2026-04-08T22:53:32.263575Z","end":"2026-04-08T22:53:32.415308Z","steps":["trace[1277177536] 'agreement among raft nodes before linearized reading' (duration: 151.70434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.416132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.136478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.41617Z","caller":"traceutil/trace.go:171","msg":"trace[1918236569] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:596; }","duration":"531.206694ms","start":"2026-04-08T22:53:31.884951Z","end":"2026-04-08T22:53:32.416158Z","steps":["trace[1918236569] 'agreement among raft nodes before linearized reading' (duration: 531.14187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.416208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.884934Z","time spent":"531.260218ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-08T22:53:32.414951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.713043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:53:32.416375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.008243ms","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-08T22:53:32.416426Z","caller":"traceutil/trace.go:171","msg":"trace[1309855328] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:596; }","duration":"414.091279ms","start":"2026-04-08T22:53:32.002322Z","end":"2026-04-08T22:53:32.416413Z","steps":["trace[1309855328] 'agreement among raft nodes before linearized reading' (duration: 414.024674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.416474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:32.002295Z","time spent":"414.167775ms","remote":"127.0.0.1:50376","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-08T22:53:32.415986Z","caller":"traceutil/trace.go:171","msg":"trace[1998685074] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:596; }","duration":"413.595433ms","start":"2026-04-08T22:53:32.002379Z","end":"2026-04-08T22:53:32.415975Z","steps":["trace[1998685074] 'agreement among raft nodes before linearized reading' (duration: 413.518687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.416667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.903296ms","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-08T22:53:32.416707Z","caller":"traceutil/trace.go:171","msg":"trace[560239626] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:596; }","duration":"451.953559ms","start":"2026-04-08T22:53:31.964744Z","end":"2026-04-08T22:53:32.416698Z","steps":["trace[560239626] 'agreement among raft nodes before linearized reading' (duration: 451.897845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.416751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.96474Z","time spent":"452.000783ms","remote":"127.0.0.1:50366","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-08T22:53:32.416925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.185715ms","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-08T22:53:32.416621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.476154ms","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":"info","ts":"2026-04-08T22:53:32.416877Z","caller":"traceutil/trace.go:171","msg":"trace[1358200564] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:596; }","duration":"226.603631ms","start":"2026-04-08T22:53:32.190206Z","end":"2026-04-08T22:53:32.41681Z","steps":["trace[1358200564] 'agreement among raft nodes before linearized reading' (duration: 224.718063ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:32.417071Z","caller":"traceutil/trace.go:171","msg":"trace[451267028] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:596; }","duration":"451.939468ms","start":"2026-04-08T22:53:31.965119Z","end":"2026-04-08T22:53:32.417059Z","steps":["trace[451267028] 'agreement among raft nodes before linearized reading' (duration: 451.474384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.417159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.965114Z","time spent":"452.030824ms","remote":"127.0.0.1:50366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-08T22:53:32.417605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.393787ms","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-08T22:53:32.417652Z","caller":"traceutil/trace.go:171","msg":"trace[2053552287] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:596; }","duration":"168.469102ms","start":"2026-04-08T22:53:32.249172Z","end":"2026-04-08T22:53:32.417641Z","steps":["trace[2053552287] 'agreement among raft nodes before linearized reading' (duration: 168.197923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.418076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.862698ms","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":"info","ts":"2026-04-08T22:53:32.418121Z","caller":"traceutil/trace.go:171","msg":"trace[1017173496] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:596; }","duration":"480.964566ms","start":"2026-04-08T22:53:31.937145Z","end":"2026-04-08T22:53:32.418109Z","steps":["trace[1017173496] 'agreement among raft nodes before linearized reading' (duration: 480.908482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.418159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.937109Z","time spent":"481.038481ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-08T22:53:32.418292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.95006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.418326Z","caller":"traceutil/trace.go:171","msg":"trace[804258914] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:596; }","duration":"502.007915ms","start":"2026-04-08T22:53:31.916311Z","end":"2026-04-08T22:53:32.418319Z","steps":["trace[804258914] 'agreement among raft nodes before linearized reading' (duration: 501.960331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.418349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.916296Z","time spent":"502.047248ms","remote":"127.0.0.1:50340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-08T22:53:32.418452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.477096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.418476Z","caller":"traceutil/trace.go:171","msg":"trace[2102809774] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:596; }","duration":"501.519949ms","start":"2026-04-08T22:53:31.91695Z","end":"2026-04-08T22:53:32.41847Z","steps":["trace[2102809774] 'agreement among raft nodes before linearized reading' (duration: 501.483926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.41869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.916943Z","time spent":"501.741595ms","remote":"127.0.0.1:50340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-08T22:53:32.417893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.93917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.418744Z","caller":"traceutil/trace.go:171","msg":"trace[2012999625] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:596; }","duration":"533.812454ms","start":"2026-04-08T22:53:31.88492Z","end":"2026-04-08T22:53:32.418733Z","steps":["trace[2012999625] 'agreement among raft nodes before linearized reading' (duration: 532.431273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.418775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.387432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.418794Z","caller":"traceutil/trace.go:171","msg":"trace[1625898682] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:596; }","duration":"502.448817ms","start":"2026-04-08T22:53:31.91634Z","end":"2026-04-08T22:53:32.418788Z","steps":["trace[1625898682] 'agreement among raft nodes before linearized reading' (duration: 502.420035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.418792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.884907Z","time spent":"533.870808ms","remote":"127.0.0.1:50328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-08T22:53:32.418818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.916329Z","time spent":"502.483449ms","remote":"127.0.0.1:50340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-08T22:53:32.41882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.412609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.417891Z","caller":"traceutil/trace.go:171","msg":"trace[1845160200] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:596; }","duration":"453.163327ms","start":"2026-04-08T22:53:31.964712Z","end":"2026-04-08T22:53:32.417876Z","steps":["trace[1845160200] 'agreement among raft nodes before linearized reading' (duration: 452.185226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.418916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.964666Z","time spent":"454.238175ms","remote":"127.0.0.1:50366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-08T22:53:32.418993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.929893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:53:32.41799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.118414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.419026Z","caller":"traceutil/trace.go:171","msg":"trace[1015740177] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:596; }","duration":"630.01858ms","start":"2026-04-08T22:53:31.788998Z","end":"2026-04-08T22:53:32.419017Z","steps":["trace[1015740177] 'agreement among raft nodes before linearized reading' (duration: 629.976457ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:32.419043Z","caller":"traceutil/trace.go:171","msg":"trace[2042109311] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:596; }","duration":"481.181992ms","start":"2026-04-08T22:53:31.937852Z","end":"2026-04-08T22:53:32.419034Z","steps":["trace[2042109311] 'agreement among raft nodes before linearized reading' (duration: 480.094293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.419056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.217985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:53:32.419062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.788968Z","time spent":"630.085305ms","remote":"127.0.0.1:50306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-04-08T22:53:32.419082Z","caller":"traceutil/trace.go:171","msg":"trace[126617955] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:596; }","duration":"691.244157ms","start":"2026-04-08T22:53:31.727829Z","end":"2026-04-08T22:53:32.419074Z","steps":["trace[126617955] 'agreement among raft nodes before linearized reading' (duration: 691.206544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.419086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.937813Z","time spent":"481.261968ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-08T22:53:32.419109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.727759Z","time spent":"691.344134ms","remote":"127.0.0.1:50298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-08T22:53:32.418919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.921549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.419194Z","caller":"traceutil/trace.go:171","msg":"trace[120365501] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:596; }","duration":"590.236511ms","start":"2026-04-08T22:53:31.828948Z","end":"2026-04-08T22:53:32.419185Z","steps":["trace[120365501] 'agreement among raft nodes before linearized reading' (duration: 589.95027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.419218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.065654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:53:32.419236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.828922Z","time spent":"590.300376ms","remote":"127.0.0.1:50312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-08T22:53:32.419255Z","caller":"traceutil/trace.go:171","msg":"trace[1817636546] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:596; }","duration":"630.146269ms","start":"2026-04-08T22:53:31.7891Z","end":"2026-04-08T22:53:32.419246Z","steps":["trace[1817636546] 'agreement among raft nodes before linearized reading' (duration: 630.096486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.41929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.789074Z","time spent":"630.206604ms","remote":"127.0.0.1:50306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-08T22:53:32.418035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.779022ms","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-08T22:53:32.419389Z","caller":"traceutil/trace.go:171","msg":"trace[1366370684] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:596; }","duration":"482.151393ms","start":"2026-04-08T22:53:31.937225Z","end":"2026-04-08T22:53:32.419376Z","steps":["trace[1366370684] 'agreement among raft nodes before linearized reading' (duration: 480.787353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.419439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.93721Z","time spent":"482.215897ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-04-08T22:53:32.414728Z","caller":"traceutil/trace.go:171","msg":"trace[1793524365] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:596; }","duration":"224.082077ms","start":"2026-04-08T22:53:32.190635Z","end":"2026-04-08T22:53:32.414717Z","steps":["trace[1793524365] 'agreement among raft nodes before linearized reading' (duration: 224.044735ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:32.414512Z","caller":"traceutil/trace.go:171","msg":"trace[820275204] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.092068832s","start":"2026-04-08T22:53:31.322424Z","end":"2026-04-08T22:53:32.414493Z","steps":["trace[820275204] 'process raft request' (duration: 1.06461763s)","trace[820275204] 'compare' (duration: 26.536605ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:53:32.41956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.322416Z","time spent":"1.097103719s","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:53:32.418878Z","caller":"traceutil/trace.go:171","msg":"trace[511706185] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:596; }","duration":"691.513316ms","start":"2026-04-08T22:53:31.727349Z","end":"2026-04-08T22:53:32.418863Z","steps":["trace[511706185] 'agreement among raft nodes before linearized reading' (duration: 691.42913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.416685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:32.002345Z","time spent":"414.305885ms","remote":"127.0.0.1:50376","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":"warn","ts":"2026-04-08T22:53:32.419612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.727325Z","time spent":"692.271341ms","remote":"127.0.0.1:50298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-08T22:53:32.4198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.917078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.419884Z","caller":"traceutil/trace.go:171","msg":"trace[1416851939] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:596; }","duration":"590.016485ms","start":"2026-04-08T22:53:31.829858Z","end":"2026-04-08T22:53:32.419874Z","steps":["trace[1416851939] 'agreement among raft nodes before linearized reading' (duration: 588.053522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.419935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.829849Z","time spent":"590.07293ms","remote":"127.0.0.1:50306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-04-08T22:53:32.419999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.989984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:32.420053Z","caller":"traceutil/trace.go:171","msg":"trace[618126487] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:596; }","duration":"591.120926ms","start":"2026-04-08T22:53:31.828914Z","end":"2026-04-08T22:53:32.420035Z","steps":["trace[618126487] 'agreement among raft nodes before linearized reading' (duration: 590.022456ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:32.420091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:53:31.828888Z","time spent":"591.192821ms","remote":"127.0.0.1:50312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-08T22:53:34.023477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.881255ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:53:34.023624Z","caller":"traceutil/trace.go:171","msg":"trace[642883512] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:619; }","duration":"172.035857ms","start":"2026-04-08T22:53:33.851566Z","end":"2026-04-08T22:53:34.023602Z","steps":["trace[642883512] 'range keys from in-memory index tree' (duration: 171.866584ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:34.027428Z","caller":"traceutil/trace.go:171","msg":"trace[1192717432] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"190.802091ms","start":"2026-04-08T22:53:33.836603Z","end":"2026-04-08T22:53:34.027405Z","steps":["trace[1192717432] 'process raft request' (duration: 190.65272ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:35.180223Z","caller":"traceutil/trace.go:171","msg":"trace[1970314922] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"140.937859ms","start":"2026-04-08T22:53:35.039256Z","end":"2026-04-08T22:53:35.180194Z","steps":["trace[1970314922] 'process raft request' (duration: 140.699382ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:35.184737Z","caller":"traceutil/trace.go:171","msg":"trace[564026868] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"140.296022ms","start":"2026-04-08T22:53:35.044417Z","end":"2026-04-08T22:53:35.184713Z","steps":["trace[564026868] 'process raft request' (duration: 140.153852ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:37.533911Z","caller":"traceutil/trace.go:171","msg":"trace[1678947912] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:691; }","duration":"258.038971ms","start":"2026-04-08T22:53:37.275849Z","end":"2026-04-08T22:53:37.533888Z","steps":["trace[1678947912] 'read index received' (duration: 257.914851ms)","trace[1678947912] 'applied index is now lower than readState.Index' (duration: 123.17µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:53:37.534036Z","caller":"traceutil/trace.go:171","msg":"trace[644034259] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"264.251221ms","start":"2026-04-08T22:53:37.269741Z","end":"2026-04-08T22:53:37.533992Z","steps":["trace[644034259] 'process raft request' (duration: 263.979701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:37.534093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.226145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-08T22:53:37.534199Z","caller":"traceutil/trace.go:171","msg":"trace[2141194535] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:666; }","duration":"258.288939ms","start":"2026-04-08T22:53:37.275823Z","end":"2026-04-08T22:53:37.534112Z","steps":["trace[2141194535] 'agreement among raft nodes before linearized reading' (duration: 258.152359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:37.559499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.914743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-08T22:53:37.559571Z","caller":"traceutil/trace.go:171","msg":"trace[2112527155] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:667; }","duration":"282.00705ms","start":"2026-04-08T22:53:37.277548Z","end":"2026-04-08T22:53:37.559555Z","steps":["trace[2112527155] 'agreement among raft nodes before linearized reading' (duration: 281.812595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:53:48.673586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.76186ms","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-08T22:53:48.673703Z","caller":"traceutil/trace.go:171","msg":"trace[1082571885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:754; }","duration":"237.942534ms","start":"2026-04-08T22:53:48.435732Z","end":"2026-04-08T22:53:48.673674Z","steps":["trace[1082571885] 'range keys from in-memory index tree' (duration: 237.512371ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:53:48.782105Z","caller":"traceutil/trace.go:171","msg":"trace[1368701941] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"102.487126ms","start":"2026-04-08T22:53:48.679591Z","end":"2026-04-08T22:53:48.782078Z","steps":["trace[1368701941] 'process raft request' (duration: 102.28082ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:54:04.040219Z","caller":"traceutil/trace.go:171","msg":"trace[463743002] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"153.802897ms","start":"2026-04-08T22:54:03.886384Z","end":"2026-04-08T22:54:04.040187Z","steps":["trace[463743002] 'process raft request' (duration: 153.009355ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:54:20.494534Z","caller":"traceutil/trace.go:171","msg":"trace[26208049] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"170.778374ms","start":"2026-04-08T22:54:20.323702Z","end":"2026-04-08T22:54:20.49448Z","steps":["trace[26208049] 'process raft request' (duration: 170.615639ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:54:22.071696Z","caller":"traceutil/trace.go:171","msg":"trace[1702986693] linearizableReadLoop","detail":"{readStateIndex:1209; appliedIndex:1207; }","duration":"115.604102ms","start":"2026-04-08T22:54:21.95607Z","end":"2026-04-08T22:54:22.071675Z","steps":["trace[1702986693] 'read index received' (duration: 86.428402ms)","trace[1702986693] 'applied index is now lower than readState.Index' (duration: 29.17466ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:54:22.071903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.811786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-08T22:54:22.071851Z","caller":"traceutil/trace.go:171","msg":"trace[609542444] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"119.01021ms","start":"2026-04-08T22:54:21.952787Z","end":"2026-04-08T22:54:22.071797Z","steps":["trace[609542444] 'process raft request' (duration: 118.745098ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:54:22.071948Z","caller":"traceutil/trace.go:171","msg":"trace[1133186700] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1172; }","duration":"115.889414ms","start":"2026-04-08T22:54:21.956046Z","end":"2026-04-08T22:54:22.071935Z","steps":["trace[1133186700] 'agreement among raft nodes before linearized reading' (duration: 115.746878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:54:22.072219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.541634ms","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-08T22:54:22.07231Z","caller":"traceutil/trace.go:171","msg":"trace[1402267489] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1172; }","duration":"113.683101ms","start":"2026-04-08T22:54:21.958586Z","end":"2026-04-08T22:54:22.072269Z","steps":["trace[1402267489] 'agreement among raft nodes before linearized reading' (duration: 113.299262ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:54:22.245495Z","caller":"traceutil/trace.go:171","msg":"trace[1880916285] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"168.736696ms","start":"2026-04-08T22:54:22.076726Z","end":"2026-04-08T22:54:22.245463Z","steps":["trace[1880916285] 'process raft request' (duration: 122.652278ms)","trace[1880916285] 'compare' (duration: 44.911742ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:54:22.245752Z","caller":"traceutil/trace.go:171","msg":"trace[707174448] linearizableReadLoop","detail":"{readStateIndex:1211; appliedIndex:1209; }","duration":"163.420088ms","start":"2026-04-08T22:54:22.082299Z","end":"2026-04-08T22:54:22.245719Z","steps":["trace[707174448] 'read index received' (duration: 117.095227ms)","trace[707174448] 'applied index is now lower than readState.Index' (duration: 46.323261ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:54:22.245906Z","caller":"traceutil/trace.go:171","msg":"trace[1543824318] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"168.209782ms","start":"2026-04-08T22:54:22.077683Z","end":"2026-04-08T22:54:22.245892Z","steps":["trace[1543824318] 'process raft request' (duration: 167.621889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:54:22.246018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.69401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2897"} {"level":"info","ts":"2026-04-08T22:54:22.246115Z","caller":"traceutil/trace.go:171","msg":"trace[557163931] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1174; }","duration":"163.799627ms","start":"2026-04-08T22:54:22.082255Z","end":"2026-04-08T22:54:22.246054Z","steps":["trace[557163931] 'agreement among raft nodes before linearized reading' (duration: 163.587543ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:54:41.193091Z","caller":"traceutil/trace.go:171","msg":"trace[932633685] transaction","detail":"{read_only:false; response_revision:1418; number_of_response:1; }","duration":"129.316424ms","start":"2026-04-08T22:54:41.063736Z","end":"2026-04-08T22:54:41.193052Z","steps":["trace[932633685] 'process raft request' (duration: 129.142705ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:54:41.382211Z","caller":"traceutil/trace.go:171","msg":"trace[1416412824] linearizableReadLoop","detail":"{readStateIndex:1465; appliedIndex:1463; }","duration":"296.838886ms","start":"2026-04-08T22:54:41.085333Z","end":"2026-04-08T22:54:41.382171Z","steps":["trace[1416412824] 'read index received' (duration: 107.588553ms)","trace[1416412824] 'applied index is now lower than readState.Index' (duration: 189.248954ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:54:41.382383Z","caller":"traceutil/trace.go:171","msg":"trace[374341575] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"317.946159ms","start":"2026-04-08T22:54:41.064417Z","end":"2026-04-08T22:54:41.382363Z","steps":["trace[374341575] 'process raft request' (duration: 261.194648ms)","trace[374341575] 'compare' (duration: 56.369572ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:54:41.382485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.024909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:54:41.382527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:54:41.064409Z","time spent":"318.013949ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:54:41.382539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.762195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-08T22:54:41.382545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.198495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T22:54:41.382575Z","caller":"traceutil/trace.go:171","msg":"trace[389419199] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1419; }","duration":"171.168599ms","start":"2026-04-08T22:54:41.211385Z","end":"2026-04-08T22:54:41.382553Z","steps":["trace[389419199] 'agreement among raft nodes before linearized reading' (duration: 171.02814ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:54:41.382622Z","caller":"traceutil/trace.go:171","msg":"trace[355743080] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1419; }","duration":"297.316745ms","start":"2026-04-08T22:54:41.085289Z","end":"2026-04-08T22:54:41.382605Z","steps":["trace[355743080] 'agreement among raft nodes before linearized reading' (duration: 297.174055ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:54:41.382635Z","caller":"traceutil/trace.go:171","msg":"trace[943512313] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1419; }","duration":"166.902625ms","start":"2026-04-08T22:54:41.215695Z","end":"2026-04-08T22:54:41.382598Z","steps":["trace[943512313] 'agreement among raft nodes before linearized reading' (duration: 166.744846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:04.692062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.267004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T22:55:04.69218Z","caller":"traceutil/trace.go:171","msg":"trace[1825426887] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1810; }","duration":"632.443398ms","start":"2026-04-08T22:55:04.059712Z","end":"2026-04-08T22:55:04.692155Z","steps":["trace[1825426887] 'count revisions from in-memory index tree' (duration: 632.146972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:04.692233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.05969Z","time spent":"632.530079ms","remote":"127.0.0.1:41664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-08T22:55:04.692278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.000717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-08T22:55:04.692363Z","caller":"traceutil/trace.go:171","msg":"trace[825922875] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1810; }","duration":"419.134459ms","start":"2026-04-08T22:55:04.27321Z","end":"2026-04-08T22:55:04.692344Z","steps":["trace[825922875] 'range keys from in-memory index tree' (duration: 418.782383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:04.692411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.27319Z","time spent":"419.21179ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-08T22:55:04.692701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.626005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-04-08T22:55:04.69274Z","caller":"traceutil/trace.go:171","msg":"trace[1225688946] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1810; }","duration":"540.700636ms","start":"2026-04-08T22:55:04.152028Z","end":"2026-04-08T22:55:04.692729Z","steps":["trace[1225688946] 'range keys from in-memory index tree' (duration: 540.506483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:04.692769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.152008Z","time spent":"540.754117ms","remote":"127.0.0.1:53354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4614,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-08T22:55:04.692766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.644258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:523"} {"level":"info","ts":"2026-04-08T22:55:04.692801Z","caller":"traceutil/trace.go:171","msg":"trace[1243404664] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:1810; }","duration":"558.718828ms","start":"2026-04-08T22:55:04.134074Z","end":"2026-04-08T22:55:04.692793Z","steps":["trace[1243404664] 'range keys from in-memory index tree' (duration: 558.524705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:04.692774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.03572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-08T22:55:04.692853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.996395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69612756-c662-477d-b8ce-985e92fa0148\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-08T22:55:04.692914Z","caller":"traceutil/trace.go:171","msg":"trace[364124601] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1810; }","duration":"230.225755ms","start":"2026-04-08T22:55:04.462628Z","end":"2026-04-08T22:55:04.692854Z","steps":["trace[364124601] 'range keys from in-memory index tree' (duration: 229.724305ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:04.692969Z","caller":"traceutil/trace.go:171","msg":"trace[746911570] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-69612756-c662-477d-b8ce-985e92fa0148; range_end:; response_count:1; response_revision:1810; }","duration":"525.103187ms","start":"2026-04-08T22:55:04.167842Z","end":"2026-04-08T22:55:04.692945Z","steps":["trace[746911570] 'range keys from in-memory index tree' (duration: 524.874362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:04.693016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.167781Z","time spent":"525.223079ms","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69612756-c662-477d-b8ce-985e92fa0148\" "} {"level":"warn","ts":"2026-04-08T22:55:04.692822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.13405Z","time spent":"558.76729ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":546,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"warn","ts":"2026-04-08T22:55:04.693206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.244105ms","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-08T22:55:04.693248Z","caller":"traceutil/trace.go:171","msg":"trace[514316993] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1810; }","duration":"225.325937ms","start":"2026-04-08T22:55:04.467914Z","end":"2026-04-08T22:55:04.69324Z","steps":["trace[514316993] 'range keys from in-memory index tree' (duration: 225.108633ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:05.017816Z","caller":"traceutil/trace.go:171","msg":"trace[99068291] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"322.167138ms","start":"2026-04-08T22:55:04.69562Z","end":"2026-04-08T22:55:05.017787Z","steps":["trace[99068291] 'process raft request' (duration: 321.908144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:05.018054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.695601Z","time spent":"322.376922ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:05.018295Z","caller":"traceutil/trace.go:171","msg":"trace[424084980] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"320.705612ms","start":"2026-04-08T22:55:04.697556Z","end":"2026-04-08T22:55:05.018262Z","steps":["trace[424084980] 'process raft request' (duration: 320.134212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:05.018461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.697541Z","time spent":"320.882495ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:05.01849Z","caller":"traceutil/trace.go:171","msg":"trace[1948146149] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"319.216016ms","start":"2026-04-08T22:55:04.699262Z","end":"2026-04-08T22:55:05.018478Z","steps":["trace[1948146149] 'process raft request' (duration: 318.997032ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:05.018563Z","caller":"traceutil/trace.go:171","msg":"trace[1872235617] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"318.748927ms","start":"2026-04-08T22:55:04.699791Z","end":"2026-04-08T22:55:05.01854Z","steps":["trace[1872235617] 'process raft request' (duration: 318.689786ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:05.018601Z","caller":"traceutil/trace.go:171","msg":"trace[403216217] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"319.043672ms","start":"2026-04-08T22:55:04.699504Z","end":"2026-04-08T22:55:05.018548Z","steps":["trace[403216217] 'process raft request' (duration: 318.89083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:05.018796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.69924Z","time spent":"319.326248ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:05.01833Z","caller":"traceutil/trace.go:171","msg":"trace[228818878] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"319.355328ms","start":"2026-04-08T22:55:04.698951Z","end":"2026-04-08T22:55:05.018306Z","steps":["trace[228818878] 'process raft request' (duration: 319.143294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:05.019154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.699493Z","time spent":"319.323227ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:05.019355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.698924Z","time spent":"320.330087ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:05.018733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.69978Z","time spent":"318.859229ms","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:05.275973Z","caller":"traceutil/trace.go:171","msg":"trace[353478956] linearizableReadLoop","detail":"{readStateIndex:1876; appliedIndex:1869; }","duration":"529.601512ms","start":"2026-04-08T22:55:04.746341Z","end":"2026-04-08T22:55:05.275943Z","steps":["trace[353478956] 'read index received' (duration: 271.203095ms)","trace[353478956] 'applied index is now lower than readState.Index' (duration: 258.396917ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:05.276039Z","caller":"traceutil/trace.go:171","msg":"trace[1300749481] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"547.351731ms","start":"2026-04-08T22:55:04.72864Z","end":"2026-04-08T22:55:05.275992Z","steps":["trace[1300749481] 'process raft request' (duration: 517.437782ms)","trace[1300749481] 'compare' (duration: 29.711775ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:55:05.276366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.998009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T22:55:05.276399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.44265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69612756-c662-477d-b8ce-985e92fa0148\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-04-08T22:55:05.276423Z","caller":"traceutil/trace.go:171","msg":"trace[1121609054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1817; }","duration":"530.106291ms","start":"2026-04-08T22:55:04.746304Z","end":"2026-04-08T22:55:05.27641Z","steps":["trace[1121609054] 'agreement among raft nodes before linearized reading' (duration: 529.802736ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:05.276459Z","caller":"traceutil/trace.go:171","msg":"trace[270195065] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-69612756-c662-477d-b8ce-985e92fa0148; range_end:; response_count:1; response_revision:1817; }","duration":"481.546272ms","start":"2026-04-08T22:55:04.794896Z","end":"2026-04-08T22:55:05.276443Z","steps":["trace[270195065] 'agreement among raft nodes before linearized reading' (duration: 481.245586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:05.276554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.794877Z","time spent":"481.619193ms","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3769,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69612756-c662-477d-b8ce-985e92fa0148\" "} {"level":"warn","ts":"2026-04-08T22:55:05.276566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.728619Z","time spent":"547.557744ms","remote":"127.0.0.1:41252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:05.276695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:04.746288Z","time spent":"530.293185ms","remote":"127.0.0.1:41210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T22:55:13.362998Z","caller":"traceutil/trace.go:171","msg":"trace[1464892584] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1965; }","duration":"311.116725ms","start":"2026-04-08T22:55:13.051861Z","end":"2026-04-08T22:55:13.362978Z","steps":["trace[1464892584] 'read index received' (duration: 310.91107ms)","trace[1464892584] 'applied index is now lower than readState.Index' (duration: 204.765µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:13.36304Z","caller":"traceutil/trace.go:171","msg":"trace[1339540949] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"319.276355ms","start":"2026-04-08T22:55:13.043742Z","end":"2026-04-08T22:55:13.363018Z","steps":["trace[1339540949] 'process raft request' (duration: 319.113501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:13.363158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:13.043725Z","time spent":"319.368447ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:13.363198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.320131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:523"} {"level":"info","ts":"2026-04-08T22:55:13.363236Z","caller":"traceutil/trace.go:171","msg":"trace[616484928] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:1905; }","duration":"311.388662ms","start":"2026-04-08T22:55:13.051838Z","end":"2026-04-08T22:55:13.363227Z","steps":["trace[616484928] 'agreement among raft nodes before linearized reading' (duration: 311.253529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:13.363262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:13.05183Z","time spent":"311.425593ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":546,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"warn","ts":"2026-04-08T22:55:13.363318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.815396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-08T22:55:13.363356Z","caller":"traceutil/trace.go:171","msg":"trace[1004686589] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1905; }","duration":"296.873547ms","start":"2026-04-08T22:55:13.066477Z","end":"2026-04-08T22:55:13.36335Z","steps":["trace[1004686589] 'agreement among raft nodes before linearized reading' (duration: 296.763055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:13.363382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.454392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-08T22:55:13.363432Z","caller":"traceutil/trace.go:171","msg":"trace[1803610275] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1905; }","duration":"297.525993ms","start":"2026-04-08T22:55:13.065891Z","end":"2026-04-08T22:55:13.363417Z","steps":["trace[1803610275] 'agreement among raft nodes before linearized reading' (duration: 297.4047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:13.363448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.742587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11269"} {"level":"info","ts":"2026-04-08T22:55:13.36351Z","caller":"traceutil/trace.go:171","msg":"trace[173343661] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1905; }","duration":"254.804239ms","start":"2026-04-08T22:55:13.108687Z","end":"2026-04-08T22:55:13.363491Z","steps":["trace[173343661] 'agreement among raft nodes before linearized reading' (duration: 254.632805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:13.363879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.800402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-08T22:55:13.363927Z","caller":"traceutil/trace.go:171","msg":"trace[1820182476] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1905; }","duration":"302.880234ms","start":"2026-04-08T22:55:13.061034Z","end":"2026-04-08T22:55:13.363914Z","steps":["trace[1820182476] 'agreement among raft nodes before linearized reading' (duration: 302.201028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:13.363957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:13.061013Z","time spent":"302.936585ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-08T22:55:42.050067Z","caller":"traceutil/trace.go:171","msg":"trace[864457095] linearizableReadLoop","detail":"{readStateIndex:2190; appliedIndex:2189; }","duration":"121.194188ms","start":"2026-04-08T22:55:41.928854Z","end":"2026-04-08T22:55:42.050048Z","steps":["trace[864457095] 'read index received' (duration: 121.087284ms)","trace[864457095] 'applied index is now lower than readState.Index' (duration: 105.784µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:42.05012Z","caller":"traceutil/trace.go:171","msg":"trace[1101112598] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"131.928546ms","start":"2026-04-08T22:55:41.918159Z","end":"2026-04-08T22:55:42.050087Z","steps":["trace[1101112598] 'process raft request' (duration: 131.78153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:42.050338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.340295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:55:42.050375Z","caller":"traceutil/trace.go:171","msg":"trace[1220844622] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:2117; }","duration":"121.536982ms","start":"2026-04-08T22:55:41.92883Z","end":"2026-04-08T22:55:42.050367Z","steps":["trace[1220844622] 'agreement among raft nodes before linearized reading' (duration: 121.334144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:42.050394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.864458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-04-08T22:55:42.050465Z","caller":"traceutil/trace.go:171","msg":"trace[1738590476] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2117; }","duration":"112.986102ms","start":"2026-04-08T22:55:41.937456Z","end":"2026-04-08T22:55:42.050442Z","steps":["trace[1738590476] 'agreement among raft nodes before linearized reading' (duration: 112.764193ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:47.650194Z","caller":"traceutil/trace.go:171","msg":"trace[964571381] linearizableReadLoop","detail":"{readStateIndex:2225; appliedIndex:2224; }","duration":"127.816339ms","start":"2026-04-08T22:55:47.522358Z","end":"2026-04-08T22:55:47.650175Z","steps":["trace[964571381] 'read index received' (duration: 127.659482ms)","trace[964571381] 'applied index is now lower than readState.Index' (duration: 155.787µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:47.650363Z","caller":"traceutil/trace.go:171","msg":"trace[348714867] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"173.392025ms","start":"2026-04-08T22:55:47.476961Z","end":"2026-04-08T22:55:47.650353Z","steps":["trace[348714867] 'process raft request' (duration: 173.082431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:47.650537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.677031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-08T22:55:47.650635Z","caller":"traceutil/trace.go:171","msg":"trace[1000422142] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2150; }","duration":"117.781185ms","start":"2026-04-08T22:55:47.532829Z","end":"2026-04-08T22:55:47.65061Z","steps":["trace[1000422142] 'agreement among raft nodes before linearized reading' (duration: 117.559886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:47.650777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.403914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-08T22:55:47.650787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.814184ms","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-08T22:55:47.65083Z","caller":"traceutil/trace.go:171","msg":"trace[893573728] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2150; }","duration":"128.508268ms","start":"2026-04-08T22:55:47.522314Z","end":"2026-04-08T22:55:47.650822Z","steps":["trace[893573728] 'agreement among raft nodes before linearized reading' (duration: 128.359152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:47.650899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.024149ms","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-08T22:55:47.650858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.22681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T22:55:47.651008Z","caller":"traceutil/trace.go:171","msg":"trace[243586954] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2150; }","duration":"112.45229ms","start":"2026-04-08T22:55:47.538536Z","end":"2026-04-08T22:55:47.650988Z","steps":["trace[243586954] 'agreement among raft nodes before linearized reading' (duration: 112.170598ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:47.650851Z","caller":"traceutil/trace.go:171","msg":"trace[940916233] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2150; }","duration":"116.897778ms","start":"2026-04-08T22:55:47.533941Z","end":"2026-04-08T22:55:47.650839Z","steps":["trace[940916233] 'agreement among raft nodes before linearized reading' (duration: 116.782883ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:47.651119Z","caller":"traceutil/trace.go:171","msg":"trace[1637530542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2150; }","duration":"115.28884ms","start":"2026-04-08T22:55:47.535642Z","end":"2026-04-08T22:55:47.650931Z","steps":["trace[1637530542] 'agreement among raft nodes before linearized reading' (duration: 114.944055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:47.650778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.621746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-04-08T22:55:47.651236Z","caller":"traceutil/trace.go:171","msg":"trace[1714539923] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2150; }","duration":"117.093436ms","start":"2026-04-08T22:55:47.534118Z","end":"2026-04-08T22:55:47.651211Z","steps":["trace[1714539923] 'agreement among raft nodes before linearized reading' (duration: 116.508281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:48.024072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.830154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:55:48.024177Z","caller":"traceutil/trace.go:171","msg":"trace[578598878] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"367.632498ms","start":"2026-04-08T22:55:47.656526Z","end":"2026-04-08T22:55:48.024158Z","steps":["trace[578598878] 'process raft request' (duration: 214.631556ms)","trace[578598878] 'compare' (duration: 152.694298ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:55:48.024237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:47.656511Z","time spent":"367.695491ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:48.031317Z","caller":"traceutil/trace.go:171","msg":"trace[1023537717] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"374.585864ms","start":"2026-04-08T22:55:47.656702Z","end":"2026-04-08T22:55:48.031288Z","steps":["trace[1023537717] 'process raft request' (duration: 374.375515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:48.031539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:47.656657Z","time spent":"374.7136ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:48.031626Z","caller":"traceutil/trace.go:171","msg":"trace[919629972] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"374.785273ms","start":"2026-04-08T22:55:47.656803Z","end":"2026-04-08T22:55:48.031588Z","steps":["trace[919629972] 'process raft request' (duration: 374.434718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:48.031773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:47.656791Z","time spent":"374.903388ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:48.031912Z","caller":"traceutil/trace.go:171","msg":"trace[440297534] linearizableReadLoop","detail":"{readStateIndex:2230; appliedIndex:2225; }","duration":"336.721065ms","start":"2026-04-08T22:55:47.695178Z","end":"2026-04-08T22:55:48.031899Z","steps":["trace[440297534] 'read index received' (duration: 175.939192ms)","trace[440297534] 'applied index is now lower than readState.Index' (duration: 160.781213ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:55:48.032053Z","caller":"traceutil/trace.go:171","msg":"trace[6559685] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"375.144519ms","start":"2026-04-08T22:55:47.6569Z","end":"2026-04-08T22:55:48.032044Z","steps":["trace[6559685] 'process raft request' (duration: 374.557264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:48.032223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:47.656893Z","time spent":"375.242022ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:55:48.032292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.939963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:55:48.032395Z","caller":"traceutil/trace.go:171","msg":"trace[2005744230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2155; }","duration":"287.09201ms","start":"2026-04-08T22:55:47.74528Z","end":"2026-04-08T22:55:48.032372Z","steps":["trace[2005744230] 'agreement among raft nodes before linearized reading' (duration: 286.921982ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:55:48.031336Z","caller":"traceutil/trace.go:171","msg":"trace[2013619462] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"374.521821ms","start":"2026-04-08T22:55:47.656791Z","end":"2026-04-08T22:55:48.031313Z","steps":["trace[2013619462] 'process raft request' (duration: 374.408877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:48.032675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.484768ms","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-08T22:55:48.032743Z","caller":"traceutil/trace.go:171","msg":"trace[1702291048] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2155; }","duration":"337.584092ms","start":"2026-04-08T22:55:47.695142Z","end":"2026-04-08T22:55:48.032726Z","steps":["trace[1702291048] 'agreement among raft nodes before linearized reading' (duration: 337.342861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:48.032789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:47.695124Z","time spent":"337.656475ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T22:55:48.032916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:47.656768Z","time spent":"375.932062ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:48.554493Z","caller":"traceutil/trace.go:171","msg":"trace[2022892397] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"326.062861ms","start":"2026-04-08T22:55:48.228401Z","end":"2026-04-08T22:55:48.554464Z","steps":["trace[2022892397] 'process raft request' (duration: 314.049549ms)","trace[2022892397] 'compare' (duration: 11.507201ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:55:48.55463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:48.228384Z","time spent":"326.175016ms","remote":"127.0.0.1:41320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":629,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:55:48.555166Z","caller":"traceutil/trace.go:171","msg":"trace[62262319] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"326.04037ms","start":"2026-04-08T22:55:48.229112Z","end":"2026-04-08T22:55:48.555153Z","steps":["trace[62262319] 'process raft request' (duration: 325.971357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:55:48.555232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:55:48.229098Z","time spent":"326.100263ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":551,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:57:04.780858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.415137ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:57:04.780995Z","caller":"traceutil/trace.go:171","msg":"trace[821659650] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"308.169118ms","start":"2026-04-08T22:57:04.472802Z","end":"2026-04-08T22:57:04.780971Z","steps":["trace[821659650] 'process raft request' (duration: 133.548209ms)","trace[821659650] 'compare' (duration: 174.269238ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:57:04.781081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:04.472775Z","time spent":"308.261454ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T22:57:04.854375Z","caller":"traceutil/trace.go:171","msg":"trace[1966506116] linearizableReadLoop","detail":"{readStateIndex:2893; appliedIndex:2890; }","duration":"342.219928ms","start":"2026-04-08T22:57:04.512136Z","end":"2026-04-08T22:57:04.854356Z","steps":["trace[1966506116] 'read index received' (duration: 94.181712ms)","trace[1966506116] 'applied index is now lower than readState.Index' (duration: 248.037586ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:57:04.854437Z","caller":"traceutil/trace.go:171","msg":"trace[626455226] transaction","detail":"{read_only:false; response_revision:2783; number_of_response:1; }","duration":"381.285457ms","start":"2026-04-08T22:57:04.473137Z","end":"2026-04-08T22:57:04.854423Z","steps":["trace[626455226] 'process raft request' (duration: 381.187572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:04.854535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:04.47312Z","time spent":"381.358502ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:57:04.854559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.663679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:57:04.854626Z","caller":"traceutil/trace.go:171","msg":"trace[1891298349] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2783; }","duration":"106.766185ms","start":"2026-04-08T22:57:04.747847Z","end":"2026-04-08T22:57:04.854613Z","steps":["trace[1891298349] 'agreement among raft nodes before linearized reading' (duration: 106.67871ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:57:04.854669Z","caller":"traceutil/trace.go:171","msg":"trace[1095294214] transaction","detail":"{read_only:false; response_revision:2782; number_of_response:1; }","duration":"381.709023ms","start":"2026-04-08T22:57:04.472927Z","end":"2026-04-08T22:57:04.854636Z","steps":["trace[1095294214] 'process raft request' (duration: 381.281328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:04.854728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:04.472898Z","time spent":"381.795759ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:57:04.854744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.838584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-08T22:57:04.854958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.825264ms","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-08T22:57:04.854989Z","caller":"traceutil/trace.go:171","msg":"trace[1039977362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2783; }","duration":"342.91135ms","start":"2026-04-08T22:57:04.51207Z","end":"2026-04-08T22:57:04.854981Z","steps":["trace[1039977362] 'agreement among raft nodes before linearized reading' (duration: 342.381568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:04.85501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:04.512045Z","time spent":"342.959642ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-08T22:57:04.855372Z","caller":"traceutil/trace.go:171","msg":"trace[955670216] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:2783; }","duration":"254.008345ms","start":"2026-04-08T22:57:04.600836Z","end":"2026-04-08T22:57:04.854844Z","steps":["trace[955670216] 'agreement among raft nodes before linearized reading' (duration: 253.640633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:10.519325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.592872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:57:10.519411Z","caller":"traceutil/trace.go:171","msg":"trace[682551739] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2817; }","duration":"308.760472ms","start":"2026-04-08T22:57:10.210625Z","end":"2026-04-08T22:57:10.519386Z","steps":["trace[682551739] 'count revisions from in-memory index tree' (duration: 308.479685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:57:10.51953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:57:10.210556Z","time spent":"308.947243ms","remote":"127.0.0.1:60918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "} {"level":"warn","ts":"2026-04-08T22:57:10.519271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.033148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a483bcdc33e09b\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-04-08T22:57:10.520133Z","caller":"traceutil/trace.go:171","msg":"trace[1430450325] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a483bcdc33e09b; range_end:; response_count:1; response_revision:2817; }","duration":"255.914381ms","start":"2026-04-08T22:57:10.264197Z","end":"2026-04-08T22:57:10.520111Z","steps":["trace[1430450325] 'range keys from in-memory index tree' (duration: 254.821414ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:32.413905Z","caller":"traceutil/trace.go:171","msg":"trace[1724538262] transaction","detail":"{read_only:false; response_revision:3514; number_of_response:1; }","duration":"113.091601ms","start":"2026-04-08T22:58:32.300772Z","end":"2026-04-08T22:58:32.413863Z","steps":["trace[1724538262] 'process raft request' (duration: 30.446082ms)","trace[1724538262] 'compare' (duration: 82.066726ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:59:20.687492Z","caller":"traceutil/trace.go:171","msg":"trace[228816998] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4239; }","duration":"134.407654ms","start":"2026-04-08T22:59:20.552809Z","end":"2026-04-08T22:59:20.687217Z","steps":["trace[228816998] 'process raft request' (duration: 134.232255ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:20.932891Z","caller":"traceutil/trace.go:171","msg":"trace[1544451556] transaction","detail":"{read_only:false; response_revision:4242; number_of_response:1; }","duration":"126.915798ms","start":"2026-04-08T22:59:20.805956Z","end":"2026-04-08T22:59:20.932872Z","steps":["trace[1544451556] 'process raft request' (duration: 93.67719ms)","trace[1544451556] 'compare' (duration: 32.877739ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:59:20.93529Z","caller":"traceutil/trace.go:171","msg":"trace[400862297] linearizableReadLoop","detail":"{readStateIndex:4432; appliedIndex:4431; }","duration":"101.873925ms","start":"2026-04-08T22:59:20.832369Z","end":"2026-04-08T22:59:20.934243Z","steps":["trace[400862297] 'read index received' (duration: 66.837713ms)","trace[400862297] 'applied index is now lower than readState.Index' (duration: 35.033132ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:59:20.938092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.752796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-04-08T22:59:20.938387Z","caller":"traceutil/trace.go:171","msg":"trace[1705105136] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4243; }","duration":"130.857265ms","start":"2026-04-08T22:59:20.807298Z","end":"2026-04-08T22:59:20.938156Z","steps":["trace[1705105136] 'agreement among raft nodes before linearized reading' (duration: 127.300016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:20.939026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.403984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-04-08T22:59:20.940218Z","caller":"traceutil/trace.go:171","msg":"trace[949083920] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4243; }","duration":"135.135372ms","start":"2026-04-08T22:59:20.803934Z","end":"2026-04-08T22:59:20.939069Z","steps":["trace[949083920] 'agreement among raft nodes before linearized reading' (duration: 130.315427ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:21.506334Z","caller":"traceutil/trace.go:171","msg":"trace[285903062] transaction","detail":"{read_only:false; response_revision:4270; number_of_response:1; }","duration":"100.004717ms","start":"2026-04-08T22:59:21.406298Z","end":"2026-04-08T22:59:21.506302Z","steps":["trace[285903062] 'process raft request' (duration: 99.691988ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:22.538403Z","caller":"traceutil/trace.go:171","msg":"trace[1540240103] transaction","detail":"{read_only:false; response_revision:4324; number_of_response:1; }","duration":"101.36918ms","start":"2026-04-08T22:59:22.437005Z","end":"2026-04-08T22:59:22.538374Z","steps":["trace[1540240103] 'process raft request' (duration: 44.681203ms)","trace[1540240103] 'compare' (duration: 56.455677ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:59:22.801814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.736314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-04-08T22:59:22.801879Z","caller":"traceutil/trace.go:171","msg":"trace[891658427] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4324; }","duration":"154.846364ms","start":"2026-04-08T22:59:22.647018Z","end":"2026-04-08T22:59:22.801865Z","steps":["trace[891658427] 'range keys from in-memory index tree' (duration: 154.550904ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:22.814371Z","caller":"traceutil/trace.go:171","msg":"trace[934730648] transaction","detail":"{read_only:false; response_revision:4325; number_of_response:1; }","duration":"103.899504ms","start":"2026-04-08T22:59:22.710445Z","end":"2026-04-08T22:59:22.814345Z","steps":["trace[934730648] 'process raft request' (duration: 103.753175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:30.54752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.961284ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-08T22:59:30.547758Z","caller":"traceutil/trace.go:171","msg":"trace[781710646] linearizableReadLoop","detail":"{readStateIndex:4712; appliedIndex:4711; }","duration":"398.034176ms","start":"2026-04-08T22:59:30.149706Z","end":"2026-04-08T22:59:30.54774Z","steps":["trace[781710646] 'read index received' (duration: 81.747062ms)","trace[781710646] 'applied index is now lower than readState.Index' (duration: 316.285534ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:59:30.547882Z","caller":"traceutil/trace.go:171","msg":"trace[675942474] transaction","detail":"{read_only:false; response_revision:4514; number_of_response:1; }","duration":"154.502662ms","start":"2026-04-08T22:59:30.393356Z","end":"2026-04-08T22:59:30.547858Z","steps":["trace[675942474] 'process raft request' (duration: 154.285602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:30.547949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.240186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f32991b4-ccfa-4452-bdb8-5c6e3ada59a7\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-08T22:59:30.548111Z","caller":"traceutil/trace.go:171","msg":"trace[1235120237] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f32991b4-ccfa-4452-bdb8-5c6e3ada59a7; range_end:; response_count:1; response_revision:4514; }","duration":"398.427517ms","start":"2026-04-08T22:59:30.149652Z","end":"2026-04-08T22:59:30.548079Z","steps":["trace[1235120237] 'agreement among raft nodes before linearized reading' (duration: 398.167576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:30.548203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:59:30.149632Z","time spent":"398.538247ms","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f32991b4-ccfa-4452-bdb8-5c6e3ada59a7\" "} {"level":"info","ts":"2026-04-08T22:59:30.692551Z","caller":"traceutil/trace.go:171","msg":"trace[1012411858] linearizableReadLoop","detail":"{readStateIndex:4714; appliedIndex:4713; }","duration":"144.730949ms","start":"2026-04-08T22:59:30.547791Z","end":"2026-04-08T22:59:30.692522Z","steps":["trace[1012411858] 'read index received' (duration: 97.441254ms)","trace[1012411858] 'applied index is now lower than readState.Index' (duration: 47.288735ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:59:30.692602Z","caller":"traceutil/trace.go:171","msg":"trace[1902809019] transaction","detail":"{read_only:false; response_revision:4515; number_of_response:1; }","duration":"251.815356ms","start":"2026-04-08T22:59:30.440748Z","end":"2026-04-08T22:59:30.692564Z","steps":["trace[1902809019] 'process raft request' (duration: 204.545821ms)","trace[1902809019] 'compare' (duration: 47.097145ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:59:30.692843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.317338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:59:30.69289Z","caller":"traceutil/trace.go:171","msg":"trace[296509905] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:4515; }","duration":"363.490878ms","start":"2026-04-08T22:59:30.329388Z","end":"2026-04-08T22:59:30.692879Z","steps":["trace[296509905] 'agreement among raft nodes before linearized reading' (duration: 363.237778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:30.692957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:59:30.329367Z","time spent":"363.576758ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-04-08T22:59:30.693124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.912479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f32991b4-ccfa-4452-bdb8-5c6e3ada59a7\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-08T22:59:30.693268Z","caller":"traceutil/trace.go:171","msg":"trace[426053747] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f32991b4-ccfa-4452-bdb8-5c6e3ada59a7; range_end:; response_count:1; response_revision:4515; }","duration":"306.12899ms","start":"2026-04-08T22:59:30.387113Z","end":"2026-04-08T22:59:30.693242Z","steps":["trace[426053747] 'agreement among raft nodes before linearized reading' (duration: 305.491639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:30.693377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:59:30.387092Z","time spent":"306.2647ms","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f32991b4-ccfa-4452-bdb8-5c6e3ada59a7\" "} {"level":"info","ts":"2026-04-08T22:59:31.282564Z","caller":"traceutil/trace.go:171","msg":"trace[839278286] transaction","detail":"{read_only:false; response_revision:4522; number_of_response:1; }","duration":"100.2272ms","start":"2026-04-08T22:59:31.182313Z","end":"2026-04-08T22:59:31.28254Z","steps":["trace[839278286] 'process raft request' (duration: 100.09221ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:31.284327Z","caller":"traceutil/trace.go:171","msg":"trace[772807467] transaction","detail":"{read_only:false; response_revision:4523; number_of_response:1; }","duration":"100.62462ms","start":"2026-04-08T22:59:31.183677Z","end":"2026-04-08T22:59:31.284302Z","steps":["trace[772807467] 'process raft request' (duration: 100.37082ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:31.598142Z","caller":"traceutil/trace.go:171","msg":"trace[646249360] linearizableReadLoop","detail":"{readStateIndex:4735; appliedIndex:4734; }","duration":"108.120574ms","start":"2026-04-08T22:59:31.490003Z","end":"2026-04-08T22:59:31.598124Z","steps":["trace[646249360] 'read index received' (duration: 98.938458ms)","trace[646249360] 'applied index is now lower than readState.Index' (duration: 9.181036ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:59:31.598247Z","caller":"traceutil/trace.go:171","msg":"trace[526544022] transaction","detail":"{read_only:false; response_revision:4535; number_of_response:1; }","duration":"108.957146ms","start":"2026-04-08T22:59:31.48928Z","end":"2026-04-08T22:59:31.598237Z","steps":["trace[526544022] 'process raft request' (duration: 99.721849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:31.598503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.484025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18a483e42cc48157\" ","response":"range_response_count:1 size:1012"} {"level":"info","ts":"2026-04-08T22:59:31.598537Z","caller":"traceutil/trace.go:171","msg":"trace[82815189] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18a483e42cc48157; range_end:; response_count:1; response_revision:4535; }","duration":"108.562555ms","start":"2026-04-08T22:59:31.489963Z","end":"2026-04-08T22:59:31.598526Z","steps":["trace[82815189] 'agreement among raft nodes before linearized reading' (duration: 108.419085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:33.30025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.134231ms","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":"info","ts":"2026-04-08T22:59:33.300304Z","caller":"traceutil/trace.go:171","msg":"trace[2137544748] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:4555; }","duration":"231.234671ms","start":"2026-04-08T22:59:33.069057Z","end":"2026-04-08T22:59:33.300291Z","steps":["trace[2137544748] 'count revisions from in-memory index tree' (duration: 231.06769ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:35.660823Z","caller":"traceutil/trace.go:171","msg":"trace[19002677] linearizableReadLoop","detail":"{readStateIndex:4803; appliedIndex:4802; }","duration":"144.632172ms","start":"2026-04-08T22:59:35.516168Z","end":"2026-04-08T22:59:35.6608Z","steps":["trace[19002677] 'read index received' (duration: 144.441941ms)","trace[19002677] 'applied index is now lower than readState.Index' (duration: 189.281µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:59:35.660969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.783153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:59:35.661011Z","caller":"traceutil/trace.go:171","msg":"trace[32892063] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:4601; }","duration":"144.874054ms","start":"2026-04-08T22:59:35.516125Z","end":"2026-04-08T22:59:35.660999Z","steps":["trace[32892063] 'agreement among raft nodes before linearized reading' (duration: 144.789363ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:35.66093Z","caller":"traceutil/trace.go:171","msg":"trace[1678943163] transaction","detail":"{read_only:false; response_revision:4601; number_of_response:1; }","duration":"209.250677ms","start":"2026-04-08T22:59:35.451648Z","end":"2026-04-08T22:59:35.660899Z","steps":["trace[1678943163] 'process raft request' (duration: 209.033207ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:41.069593Z","caller":"traceutil/trace.go:171","msg":"trace[1272032402] linearizableReadLoop","detail":"{readStateIndex:4889; appliedIndex:4888; }","duration":"119.909555ms","start":"2026-04-08T22:59:40.949655Z","end":"2026-04-08T22:59:41.069564Z","steps":["trace[1272032402] 'read index received' (duration: 119.180161ms)","trace[1272032402] 'applied index is now lower than readState.Index' (duration: 728.094µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:59:41.06972Z","caller":"traceutil/trace.go:171","msg":"trace[1217734404] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"131.474309ms","start":"2026-04-08T22:59:40.938213Z","end":"2026-04-08T22:59:41.069687Z","steps":["trace[1217734404] 'process raft request' (duration: 130.609334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:41.069908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.227847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:59:41.070562Z","caller":"traceutil/trace.go:171","msg":"trace[106531008] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:4683; }","duration":"120.943851ms","start":"2026-04-08T22:59:40.949601Z","end":"2026-04-08T22:59:41.070545Z","steps":["trace[106531008] 'agreement among raft nodes before linearized reading' (duration: 120.196067ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:41.591824Z","caller":"traceutil/trace.go:171","msg":"trace[1238788737] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"199.568236ms","start":"2026-04-08T22:59:41.392231Z","end":"2026-04-08T22:59:41.591799Z","steps":["trace[1238788737] 'process raft request' (duration: 199.424955ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:41.625588Z","caller":"traceutil/trace.go:171","msg":"trace[1515038932] linearizableReadLoop","detail":"{readStateIndex:4892; appliedIndex:4890; }","duration":"194.468056ms","start":"2026-04-08T22:59:41.431101Z","end":"2026-04-08T22:59:41.625569Z","steps":["trace[1515038932] 'read index received' (duration: 160.551376ms)","trace[1515038932] 'applied index is now lower than readState.Index' (duration: 33.91553ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:59:41.625715Z","caller":"traceutil/trace.go:171","msg":"trace[496452062] transaction","detail":"{read_only:false; response_revision:4686; number_of_response:1; }","duration":"232.705881ms","start":"2026-04-08T22:59:41.392998Z","end":"2026-04-08T22:59:41.625704Z","steps":["trace[496452062] 'process raft request' (duration: 232.454929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:41.625838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.434015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-04-08T22:59:41.625878Z","caller":"traceutil/trace.go:171","msg":"trace[211366343] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4686; }","duration":"194.498355ms","start":"2026-04-08T22:59:41.431365Z","end":"2026-04-08T22:59:41.625863Z","steps":["trace[211366343] 'agreement among raft nodes before linearized reading' (duration: 194.371935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:41.626071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.973829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-04-08T22:59:41.626109Z","caller":"traceutil/trace.go:171","msg":"trace[266919985] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4686; }","duration":"195.047219ms","start":"2026-04-08T22:59:41.431051Z","end":"2026-04-08T22:59:41.626098Z","steps":["trace[266919985] 'agreement among raft nodes before linearized reading' (duration: 194.894218ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:41.746131Z","caller":"traceutil/trace.go:171","msg":"trace[49267365] transaction","detail":"{read_only:false; response_revision:4688; number_of_response:1; }","duration":"112.216801ms","start":"2026-04-08T22:59:41.633899Z","end":"2026-04-08T22:59:41.746116Z","steps":["trace[49267365] 'process raft request' (duration: 112.04977ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:41.746316Z","caller":"traceutil/trace.go:171","msg":"trace[1244609333] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"112.367082ms","start":"2026-04-08T22:59:41.633943Z","end":"2026-04-08T22:59:41.74631Z","steps":["trace[1244609333] 'process raft request' (duration: 112.106001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:45.839024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.991327ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:59:45.83914Z","caller":"traceutil/trace.go:171","msg":"trace[50086125] linearizableReadLoop","detail":"{readStateIndex:4937; appliedIndex:4936; }","duration":"330.718362ms","start":"2026-04-08T22:59:45.508402Z","end":"2026-04-08T22:59:45.83912Z","steps":["trace[50086125] 'read index received' (duration: 35.761µs)","trace[50086125] 'applied index is now lower than readState.Index' (duration: 330.680871ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:59:45.839394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.975504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10515"} {"level":"info","ts":"2026-04-08T22:59:45.839456Z","caller":"traceutil/trace.go:171","msg":"trace[107200338] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"758.243893ms","start":"2026-04-08T22:59:45.081188Z","end":"2026-04-08T22:59:45.839432Z","steps":["trace[107200338] 'process raft request' (duration: 173.747513ms)","trace[107200338] 'compare' (duration: 583.616744ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:59:45.839472Z","caller":"traceutil/trace.go:171","msg":"trace[2092118552] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4729; }","duration":"331.105884ms","start":"2026-04-08T22:59:45.508348Z","end":"2026-04-08T22:59:45.839454Z","steps":["trace[2092118552] 'agreement among raft nodes before linearized reading' (duration: 330.890693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:45.839513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:59:45.508327Z","time spent":"331.177355ms","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10538,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-08T22:59:45.839553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T22:59:45.08116Z","time spent":"758.341905ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T22:59:45.839405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.174418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-04-08T22:59:45.839618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.885239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T22:59:45.839699Z","caller":"traceutil/trace.go:171","msg":"trace[374100618] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4729; }","duration":"271.506121ms","start":"2026-04-08T22:59:45.568179Z","end":"2026-04-08T22:59:45.839685Z","steps":["trace[374100618] 'agreement among raft nodes before linearized reading' (duration: 271.077128ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:59:45.839721Z","caller":"traceutil/trace.go:171","msg":"trace[606149053] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4729; }","duration":"121.025391ms","start":"2026-04-08T22:59:45.718676Z","end":"2026-04-08T22:59:45.839702Z","steps":["trace[606149053] 'agreement among raft nodes before linearized reading' (duration: 120.86935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:45.839801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.218853ms","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-08T22:59:45.839847Z","caller":"traceutil/trace.go:171","msg":"trace[774930779] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4729; }","duration":"203.263943ms","start":"2026-04-08T22:59:45.63657Z","end":"2026-04-08T22:59:45.839834Z","steps":["trace[774930779] 'agreement among raft nodes before linearized reading' (duration: 203.162152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:59:45.840009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.212548ms","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-08T22:59:45.840045Z","caller":"traceutil/trace.go:171","msg":"trace[1430060172] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4729; }","duration":"236.283539ms","start":"2026-04-08T22:59:45.603753Z","end":"2026-04-08T22:59:45.840036Z","steps":["trace[1430060172] 'agreement among raft nodes before linearized reading' (duration: 236.166708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.324338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.675042ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-08T23:00:30.324567Z","caller":"traceutil/trace.go:171","msg":"trace[1787272569] transaction","detail":"{read_only:false; response_revision:5155; number_of_response:1; }","duration":"405.592492ms","start":"2026-04-08T23:00:29.918959Z","end":"2026-04-08T23:00:30.324552Z","steps":["trace[1787272569] 'process raft request' (duration: 405.477399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.324666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:00:29.918936Z","time spent":"405.668204ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T23:00:30.324572Z","caller":"traceutil/trace.go:171","msg":"trace[906150387] linearizableReadLoop","detail":"{readStateIndex:5381; appliedIndex:5380; }","duration":"668.978089ms","start":"2026-04-08T23:00:29.655569Z","end":"2026-04-08T23:00:30.324547Z","steps":["trace[906150387] 'read index received' (duration: 42.001µs)","trace[906150387] 'applied index is now lower than readState.Index' (duration: 668.933558ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:00:30.326526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.949703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2348456"} {"level":"info","ts":"2026-04-08T23:00:30.326692Z","caller":"traceutil/trace.go:171","msg":"trace[38480861] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5155; }","duration":"671.110676ms","start":"2026-04-08T23:00:29.655527Z","end":"2026-04-08T23:00:30.326637Z","steps":["trace[38480861] 'agreement among raft nodes before linearized reading' (duration: 669.314377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.326798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:00:29.655509Z","time spent":"671.27195ms","remote":"127.0.0.1:41320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2348479,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-04-08T23:00:30.341458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.202978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:00:30.341521Z","caller":"traceutil/trace.go:171","msg":"trace[2122111721] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5156; }","duration":"238.30464ms","start":"2026-04-08T23:00:30.103202Z","end":"2026-04-08T23:00:30.341507Z","steps":["trace[2122111721] 'agreement among raft nodes before linearized reading' (duration: 238.206368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.341705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.681038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:00:30.34173Z","caller":"traceutil/trace.go:171","msg":"trace[2137286156] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5156; }","duration":"238.7524ms","start":"2026-04-08T23:00:30.102971Z","end":"2026-04-08T23:00:30.341724Z","steps":["trace[2137286156] 'agreement among raft nodes before linearized reading' (duration: 238.715909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.341902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.19743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6156"} {"level":"info","ts":"2026-04-08T23:00:30.341937Z","caller":"traceutil/trace.go:171","msg":"trace[577034595] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5156; }","duration":"239.292432ms","start":"2026-04-08T23:00:30.102636Z","end":"2026-04-08T23:00:30.341928Z","steps":["trace[577034595] 'agreement among raft nodes before linearized reading' (duration: 239.17794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.342074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.052476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T23:00:30.342095Z","caller":"traceutil/trace.go:171","msg":"trace[7465903] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5156; }","duration":"286.103737ms","start":"2026-04-08T23:00:30.055986Z","end":"2026-04-08T23:00:30.34209Z","steps":["trace[7465903] 'agreement among raft nodes before linearized reading' (duration: 286.044636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.342191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.169018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:00:30.342208Z","caller":"traceutil/trace.go:171","msg":"trace[2069032398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5156; }","duration":"595.220238ms","start":"2026-04-08T23:00:29.746982Z","end":"2026-04-08T23:00:30.342202Z","steps":["trace[2069032398] 'agreement among raft nodes before linearized reading' (duration: 595.192258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.342226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:00:29.746961Z","time spent":"595.25931ms","remote":"127.0.0.1:41220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T23:00:30.342256Z","caller":"traceutil/trace.go:171","msg":"trace[1758499375] transaction","detail":"{read_only:false; response_revision:5156; number_of_response:1; }","duration":"342.627635ms","start":"2026-04-08T23:00:29.999608Z","end":"2026-04-08T23:00:30.342236Z","steps":["trace[1758499375] 'process raft request' (duration: 341.408878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.342281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.504079ms","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-08T23:00:30.342377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:00:29.999587Z","time spent":"342.716957ms","remote":"127.0.0.1:41484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T23:00:30.342435Z","caller":"traceutil/trace.go:171","msg":"trace[1747525644] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5156; }","duration":"219.640321ms","start":"2026-04-08T23:00:30.122745Z","end":"2026-04-08T23:00:30.342385Z","steps":["trace[1747525644] 'agreement among raft nodes before linearized reading' (duration: 218.862034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.342604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.443292ms","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-08T23:00:30.342634Z","caller":"traceutil/trace.go:171","msg":"trace[1809324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5156; }","duration":"232.489523ms","start":"2026-04-08T23:00:30.110138Z","end":"2026-04-08T23:00:30.342627Z","steps":["trace[1809324] 'agreement among raft nodes before linearized reading' (duration: 232.420291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.342641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.491774ms","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-08T23:00:30.342702Z","caller":"traceutil/trace.go:171","msg":"trace[1804181767] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5156; }","duration":"227.557245ms","start":"2026-04-08T23:00:30.115134Z","end":"2026-04-08T23:00:30.342691Z","steps":["trace[1804181767] 'agreement among raft nodes before linearized reading' (duration: 227.466923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.342732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.657491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-08T23:00:30.342752Z","caller":"traceutil/trace.go:171","msg":"trace[1233338815] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5156; }","duration":"234.692141ms","start":"2026-04-08T23:00:30.108054Z","end":"2026-04-08T23:00:30.342746Z","steps":["trace[1233338815] 'agreement among raft nodes before linearized reading' (duration: 234.64011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.341529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.300845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-04-08T23:00:30.342956Z","caller":"traceutil/trace.go:171","msg":"trace[280898149] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:5156; }","duration":"236.707955ms","start":"2026-04-08T23:00:30.106167Z","end":"2026-04-08T23:00:30.342875Z","steps":["trace[280898149] 'agreement among raft nodes before linearized reading' (duration: 235.12418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.847786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.140139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T23:00:30.847895Z","caller":"traceutil/trace.go:171","msg":"trace[584086588] linearizableReadLoop","detail":"{readStateIndex:5392; appliedIndex:5390; }","duration":"194.051041ms","start":"2026-04-08T23:00:30.653828Z","end":"2026-04-08T23:00:30.847879Z","steps":["trace[584086588] 'read index received' (duration: 2.308831ms)","trace[584086588] 'applied index is now lower than readState.Index' (duration: 191.74086ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:00:30.847987Z","caller":"traceutil/trace.go:171","msg":"trace[1279313281] transaction","detail":"{read_only:false; response_revision:5165; number_of_response:1; }","duration":"219.864077ms","start":"2026-04-08T23:00:30.628112Z","end":"2026-04-08T23:00:30.847976Z","steps":["trace[1279313281] 'process raft request' (duration: 111.436271ms)","trace[1279313281] 'compare' (duration: 107.859483ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:00:30.848321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.971658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:568"} {"level":"info","ts":"2026-04-08T23:00:30.84849Z","caller":"traceutil/trace.go:171","msg":"trace[1245643225] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5165; }","duration":"188.137881ms","start":"2026-04-08T23:00:30.660332Z","end":"2026-04-08T23:00:30.84847Z","steps":["trace[1245643225] 'agreement among raft nodes before linearized reading' (duration: 187.856055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.848322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.468421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:00:30.84925Z","caller":"traceutil/trace.go:171","msg":"trace[79128796] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:5165; }","duration":"195.415751ms","start":"2026-04-08T23:00:30.653801Z","end":"2026-04-08T23:00:30.849217Z","steps":["trace[79128796] 'agreement among raft nodes before linearized reading' (duration: 194.45063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:30.848469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.767417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:00:30.850055Z","caller":"traceutil/trace.go:171","msg":"trace[2146215462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5165; }","duration":"101.947903ms","start":"2026-04-08T23:00:30.74755Z","end":"2026-04-08T23:00:30.849498Z","steps":["trace[2146215462] 'agreement among raft nodes before linearized reading' (duration: 100.741837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:43.880161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.133181ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T23:00:43.88038Z","caller":"traceutil/trace.go:171","msg":"trace[1149363759] transaction","detail":"{read_only:false; response_revision:5275; number_of_response:1; }","duration":"198.786523ms","start":"2026-04-08T23:00:43.681576Z","end":"2026-04-08T23:00:43.880363Z","steps":["trace[1149363759] 'process raft request' (duration: 198.688451ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:00:43.880635Z","caller":"traceutil/trace.go:171","msg":"trace[1024038873] transaction","detail":"{read_only:false; response_revision:5274; number_of_response:1; }","duration":"201.061091ms","start":"2026-04-08T23:00:43.67951Z","end":"2026-04-08T23:00:43.880571Z","steps":["trace[1024038873] 'process raft request' (duration: 74.432157ms)","trace[1024038873] 'compare' (duration: 125.824253ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:02:51.536439Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3187} {"level":"info","ts":"2026-04-08T23:02:51.634634Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3187,"took":"96.912278ms","hash":221579257,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":31105024,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-08T23:02:51.634739Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":221579257,"revision":3187,"compact-revision":-1} {"level":"info","ts":"2026-04-08T23:07:51.543091Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6248} {"level":"info","ts":"2026-04-08T23:07:51.63355Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6248,"took":"89.188136ms","hash":2534703485,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":18305024,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-08T23:07:51.633606Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2534703485,"revision":6248,"compact-revision":3187}