{"level":"warn","ts":"2026-06-03T21:49:13.402432Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-03T21:49:13.402535Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-03T21:49:13.402612Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-03T21:49:13.402625Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-06-03T21:49:13.402642Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-03T21:49:13.403269Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-06-03T21:49:13.40334Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-03T21:49:13.406075Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.497332ms"} {"level":"info","ts":"2026-06-03T21:49:13.41151Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-06-03T21:49:13.411585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-06-03T21:49:13.41161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-06-03T21:49:13.411619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-03T21:49:13.411625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-06-03T21:49:13.411666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-06-03T21:49:13.416899Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-03T21:49:13.419031Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-03T21:49:13.420512Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-03T21:49:13.4233Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-03T21:49:13.423408Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-03T21:49:13.423611Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-03T21:49:13.423799Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-03T21:49:13.423827Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-03T21:49:13.424849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-06-03T21:49:13.425194Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-06-03T21:49:13.428137Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-03T21:49:13.428248Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-06-03T21:49:13.428293Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-06-03T21:49:13.428467Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-03T21:49:13.428522Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-03T21:49:13.512334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-06-03T21:49:13.512414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-03T21:49:13.512435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-06-03T21:49:13.512452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-06-03T21:49:13.512459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-06-03T21:49:13.51247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-06-03T21:49:13.512481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-06-03T21:49:13.513356Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T21:49:13.51414Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-06-03T21:49:13.514199Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-03T21:49:13.514328Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-03T21:49:13.514542Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T21:49:13.514514Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-03T21:49:13.514639Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-03T21:49:13.514757Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T21:49:13.514805Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-03T21:49:13.517171Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-03T21:49:13.520164Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-06-03T21:49:19.262932Z","caller":"traceutil/trace.go:171","msg":"trace[875143827] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"109.548357ms","start":"2026-06-03T21:49:19.153362Z","end":"2026-06-03T21:49:19.262911Z","steps":["trace[875143827] 'process raft request' (duration: 36.412103ms)","trace[875143827] 'compare' (duration: 73.044801ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:49:19.267436Z","caller":"traceutil/trace.go:171","msg":"trace[448134493] transaction","detail":"{read_only:false; number_of_response:0; response_revision:288; }","duration":"113.147424ms","start":"2026-06-03T21:49:19.154256Z","end":"2026-06-03T21:49:19.267404Z","steps":["trace[448134493] 'process raft request' (duration: 112.878608ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:19.327498Z","caller":"traceutil/trace.go:171","msg":"trace[190799699] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"122.102785ms","start":"2026-06-03T21:49:19.20536Z","end":"2026-06-03T21:49:19.327462Z","steps":["trace[190799699] 'process raft request' (duration: 121.89232ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:19.449398Z","caller":"traceutil/trace.go:171","msg":"trace[205955186] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"112.55886ms","start":"2026-06-03T21:49:19.336791Z","end":"2026-06-03T21:49:19.44935Z","steps":["trace[205955186] 'process raft request' (duration: 112.496739ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:19.449442Z","caller":"traceutil/trace.go:171","msg":"trace[1135296154] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"116.341663ms","start":"2026-06-03T21:49:19.333082Z","end":"2026-06-03T21:49:19.449424Z","steps":["trace[1135296154] 'process raft request' (duration: 113.058842ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:25.963159Z","caller":"traceutil/trace.go:171","msg":"trace[61004928] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"209.107109ms","start":"2026-06-03T21:49:25.754009Z","end":"2026-06-03T21:49:25.963116Z","steps":["trace[61004928] 'process raft request' (duration: 208.741489ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:31.63479Z","caller":"traceutil/trace.go:171","msg":"trace[1972630693] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"554.177292ms","start":"2026-06-03T21:49:31.080578Z","end":"2026-06-03T21:49:31.634755Z","steps":["trace[1972630693] 'process raft request' (duration: 554.000318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:49:31.63593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:49:31.080547Z","time spent":"554.349087ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:49:32.096384Z","caller":"traceutil/trace.go:171","msg":"trace[990226642] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"433.174594ms","start":"2026-06-03T21:49:31.663164Z","end":"2026-06-03T21:49:32.096338Z","steps":["trace[990226642] 'process raft request' (duration: 432.794015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:49:32.096603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:49:31.663137Z","time spent":"433.357829ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4119,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:49:37.544534Z","caller":"traceutil/trace.go:171","msg":"trace[1657523645] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"151.761563ms","start":"2026-06-03T21:49:37.392738Z","end":"2026-06-03T21:49:37.544499Z","steps":["trace[1657523645] 'process raft request' (duration: 71.028902ms)","trace[1657523645] 'compare' (duration: 80.559906ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:49:38.352709Z","caller":"traceutil/trace.go:171","msg":"trace[794723720] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"216.864289ms","start":"2026-06-03T21:49:38.135792Z","end":"2026-06-03T21:49:38.352656Z","steps":["trace[794723720] 'process raft request' (duration: 216.675024ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:38.403697Z","caller":"traceutil/trace.go:171","msg":"trace[332900602] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"267.457429ms","start":"2026-06-03T21:49:38.136192Z","end":"2026-06-03T21:49:38.40365Z","steps":["trace[332900602] 'process raft request' (duration: 267.200043ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:38.403819Z","caller":"traceutil/trace.go:171","msg":"trace[1664850691] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"266.770773ms","start":"2026-06-03T21:49:38.137002Z","end":"2026-06-03T21:49:38.403773Z","steps":["trace[1664850691] 'process raft request' (duration: 266.557788ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:53.860639Z","caller":"traceutil/trace.go:171","msg":"trace[1198330530] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"172.920012ms","start":"2026-06-03T21:49:53.687596Z","end":"2026-06-03T21:49:53.860516Z","steps":["trace[1198330530] 'process raft request' (duration: 172.696256ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:53.868434Z","caller":"traceutil/trace.go:171","msg":"trace[1955657385] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"175.855883ms","start":"2026-06-03T21:49:53.692537Z","end":"2026-06-03T21:49:53.868393Z","steps":["trace[1955657385] 'process raft request' (duration: 174.951781ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:53.868539Z","caller":"traceutil/trace.go:171","msg":"trace[1904375870] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"169.60468ms","start":"2026-06-03T21:49:53.698878Z","end":"2026-06-03T21:49:53.868483Z","steps":["trace[1904375870] 'process raft request' (duration: 168.842572ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:53.868966Z","caller":"traceutil/trace.go:171","msg":"trace[562756556] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"176.258683ms","start":"2026-06-03T21:49:53.692695Z","end":"2026-06-03T21:49:53.868954Z","steps":["trace[562756556] 'process raft request' (duration: 174.954772ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:53.869078Z","caller":"traceutil/trace.go:171","msg":"trace[2035651221] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"166.843571ms","start":"2026-06-03T21:49:53.702226Z","end":"2026-06-03T21:49:53.86907Z","steps":["trace[2035651221] 'process raft request' (duration: 165.825807ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:53.869141Z","caller":"traceutil/trace.go:171","msg":"trace[1740599866] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"167.760575ms","start":"2026-06-03T21:49:53.701372Z","end":"2026-06-03T21:49:53.869132Z","steps":["trace[1740599866] 'process raft request' (duration: 166.505314ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:53.869165Z","caller":"traceutil/trace.go:171","msg":"trace[86535026] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"115.631596ms","start":"2026-06-03T21:49:53.753516Z","end":"2026-06-03T21:49:53.869148Z","steps":["trace[86535026] 'process raft request' (duration: 115.552714ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:53.869198Z","caller":"traceutil/trace.go:171","msg":"trace[1652063146] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"167.053428ms","start":"2026-06-03T21:49:53.702138Z","end":"2026-06-03T21:49:53.869191Z","steps":["trace[1652063146] 'process raft request' (duration: 165.794218ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:53.869307Z","caller":"traceutil/trace.go:171","msg":"trace[1062036843] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"159.074092ms","start":"2026-06-03T21:49:53.710222Z","end":"2026-06-03T21:49:53.869297Z","steps":["trace[1062036843] 'process raft request' (duration: 157.965535ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:53.869293Z","caller":"traceutil/trace.go:171","msg":"trace[1168268451] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"166.80847ms","start":"2026-06-03T21:49:53.702474Z","end":"2026-06-03T21:49:53.869282Z","steps":["trace[1168268451] 'process raft request' (duration: 165.637502ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:49:53.869406Z","caller":"traceutil/trace.go:171","msg":"trace[1709318008] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"155.765089ms","start":"2026-06-03T21:49:53.713635Z","end":"2026-06-03T21:49:53.8694Z","steps":["trace[1709318008] 'process raft request' (duration: 154.677583ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:00.179871Z","caller":"traceutil/trace.go:171","msg":"trace[1464479068] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"218.58011ms","start":"2026-06-03T21:49:59.961258Z","end":"2026-06-03T21:50:00.179838Z","steps":["trace[1464479068] 'process raft request' (duration: 217.892414ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:00.681843Z","caller":"traceutil/trace.go:171","msg":"trace[1234534983] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"414.497157ms","start":"2026-06-03T21:50:00.267319Z","end":"2026-06-03T21:50:00.681816Z","steps":["trace[1234534983] 'process raft request' (duration: 413.481602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:50:00.682018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:50:00.267271Z","time spent":"414.65581ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:50:00.681855Z","caller":"traceutil/trace.go:171","msg":"trace[16920858] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"401.287552ms","start":"2026-06-03T21:50:00.280479Z","end":"2026-06-03T21:50:00.681766Z","steps":["trace[16920858] 'read index received' (duration: 400.218776ms)","trace[16920858] 'applied index is now lower than readState.Index' (duration: 1.067696ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:50:00.681966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.479407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-03T21:50:00.682312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.05495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-03T21:50:00.682408Z","caller":"traceutil/trace.go:171","msg":"trace[1580782757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"223.191644ms","start":"2026-06-03T21:50:00.459202Z","end":"2026-06-03T21:50:00.682393Z","steps":["trace[1580782757] 'agreement among raft nodes before linearized reading' (duration: 222.991529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:50:00.682481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.00729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-03T21:50:00.682542Z","caller":"traceutil/trace.go:171","msg":"trace[815210513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:639; }","duration":"148.125493ms","start":"2026-06-03T21:50:00.534401Z","end":"2026-06-03T21:50:00.682526Z","steps":["trace[815210513] 'agreement among raft nodes before linearized reading' (duration: 147.952939ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:00.682347Z","caller":"traceutil/trace.go:171","msg":"trace[1501314389] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:639; }","duration":"401.878797ms","start":"2026-06-03T21:50:00.280404Z","end":"2026-06-03T21:50:00.682258Z","steps":["trace[1501314389] 'agreement among raft nodes before linearized reading' (duration: 401.508178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:50:00.68259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:50:00.280368Z","time spent":"402.210675ms","remote":"127.0.0.1:55316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-03T21:50:00.684908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.880858ms","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-06-03T21:50:00.685017Z","caller":"traceutil/trace.go:171","msg":"trace[1150176078] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:639; }","duration":"168.051582ms","start":"2026-06-03T21:50:00.516945Z","end":"2026-06-03T21:50:00.684997Z","steps":["trace[1150176078] 'agreement among raft nodes before linearized reading' (duration: 165.466928ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:01.27826Z","caller":"traceutil/trace.go:171","msg":"trace[48481488] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"205.737727ms","start":"2026-06-03T21:50:01.072487Z","end":"2026-06-03T21:50:01.278224Z","steps":["trace[48481488] 'process raft request' (duration: 205.112242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:50:02.134041Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726713062377543,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-03T21:50:02.635127Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726713062377543,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-03T21:50:02.683846Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.342616642s","expected-duration":"1s"} {"level":"info","ts":"2026-06-03T21:50:02.684349Z","caller":"traceutil/trace.go:171","msg":"trace[2145158907] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.343236966s","start":"2026-06-03T21:50:01.341081Z","end":"2026-06-03T21:50:02.684318Z","steps":["trace[2145158907] 'process raft request' (duration: 1.343072842s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:50:02.684502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:50:01.341048Z","time spent":"1.3433852s","remote":"127.0.0.1:55316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-03T21:50:02.717215Z","caller":"traceutil/trace.go:171","msg":"trace[1105824366] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:666; }","duration":"1.083647039s","start":"2026-06-03T21:50:01.633544Z","end":"2026-06-03T21:50:02.717191Z","steps":["trace[1105824366] 'read index received' (duration: 1.050643319s)","trace[1105824366] 'applied index is now lower than readState.Index' (duration: 33.00196ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:50:02.71739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.083836694s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T21:50:02.717559Z","caller":"traceutil/trace.go:171","msg":"trace[936145063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"1.084067119s","start":"2026-06-03T21:50:01.633476Z","end":"2026-06-03T21:50:02.717543Z","steps":["trace[936145063] 'agreement among raft nodes before linearized reading' (duration: 1.083857804s)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:50:02.717598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:50:01.633451Z","time spent":"1.084138081s","remote":"127.0.0.1:55034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-03T21:50:14.634725Z","caller":"traceutil/trace.go:171","msg":"trace[1612243515] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"265.219376ms","start":"2026-06-03T21:50:14.369473Z","end":"2026-06-03T21:50:14.634693Z","steps":["trace[1612243515] 'process raft request' (duration: 264.9832ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:14.635089Z","caller":"traceutil/trace.go:171","msg":"trace[2059552654] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"261.624607ms","start":"2026-06-03T21:50:14.373409Z","end":"2026-06-03T21:50:14.635034Z","steps":["trace[2059552654] 'process raft request' (duration: 261.221837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:50:18.315896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.21936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-03T21:50:18.316014Z","caller":"traceutil/trace.go:171","msg":"trace[787751751] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:805; }","duration":"118.405894ms","start":"2026-06-03T21:50:18.197582Z","end":"2026-06-03T21:50:18.315988Z","steps":["trace[787751751] 'range keys from in-memory index tree' (duration: 118.037585ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:18.627273Z","caller":"traceutil/trace.go:171","msg":"trace[1556191378] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"307.650485ms","start":"2026-06-03T21:50:18.319593Z","end":"2026-06-03T21:50:18.627243Z","steps":["trace[1556191378] 'process raft request' (duration: 307.478131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:50:18.627482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:50:18.319579Z","time spent":"307.791239ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:50:18.824992Z","caller":"traceutil/trace.go:171","msg":"trace[2106267103] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:834; }","duration":"190.633187ms","start":"2026-06-03T21:50:18.634332Z","end":"2026-06-03T21:50:18.824965Z","steps":["trace[2106267103] 'read index received' (duration: 190.37608ms)","trace[2106267103] 'applied index is now lower than readState.Index' (duration: 256.057µs)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:50:18.825182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.819101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T21:50:18.825187Z","caller":"traceutil/trace.go:171","msg":"trace[27168445] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"501.233114ms","start":"2026-06-03T21:50:18.323901Z","end":"2026-06-03T21:50:18.825134Z","steps":["trace[27168445] 'process raft request' (duration: 500.888795ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:18.82526Z","caller":"traceutil/trace.go:171","msg":"trace[754338539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:807; }","duration":"190.993316ms","start":"2026-06-03T21:50:18.634246Z","end":"2026-06-03T21:50:18.825239Z","steps":["trace[754338539] 'agreement among raft nodes before linearized reading' (duration: 190.823771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:50:18.825479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:50:18.323873Z","time spent":"501.470479ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:50:36.1629Z","caller":"traceutil/trace.go:171","msg":"trace[2013572767] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"135.407301ms","start":"2026-06-03T21:50:36.027456Z","end":"2026-06-03T21:50:36.162864Z","steps":["trace[2013572767] 'process raft request' (duration: 134.277493ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:36.163086Z","caller":"traceutil/trace.go:171","msg":"trace[2072305300] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"133.519375ms","start":"2026-06-03T21:50:36.029537Z","end":"2026-06-03T21:50:36.163057Z","steps":["trace[2072305300] 'process raft request' (duration: 133.227958ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:36.163368Z","caller":"traceutil/trace.go:171","msg":"trace[1991870685] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"125.724303ms","start":"2026-06-03T21:50:36.037603Z","end":"2026-06-03T21:50:36.163328Z","steps":["trace[1991870685] 'process raft request' (duration: 125.307533ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:36.163458Z","caller":"traceutil/trace.go:171","msg":"trace[2092665244] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"123.14342ms","start":"2026-06-03T21:50:36.040293Z","end":"2026-06-03T21:50:36.163436Z","steps":["trace[2092665244] 'process raft request' (duration: 122.908044ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:36.16354Z","caller":"traceutil/trace.go:171","msg":"trace[1889716880] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"122.851403ms","start":"2026-06-03T21:50:36.040593Z","end":"2026-06-03T21:50:36.163445Z","steps":["trace[1889716880] 'process raft request' (duration: 122.72718ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:36.791156Z","caller":"traceutil/trace.go:171","msg":"trace[1261380474] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"234.38009ms","start":"2026-06-03T21:50:36.556729Z","end":"2026-06-03T21:50:36.791109Z","steps":["trace[1261380474] 'process raft request' (duration: 233.697363ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:36.791116Z","caller":"traceutil/trace.go:171","msg":"trace[1834185070] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"157.215475ms","start":"2026-06-03T21:50:36.633843Z","end":"2026-06-03T21:50:36.791058Z","steps":["trace[1834185070] 'read index received' (duration: 156.293922ms)","trace[1834185070] 'applied index is now lower than readState.Index' (duration: 919.963µs)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:50:36.791477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.531433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T21:50:36.791586Z","caller":"traceutil/trace.go:171","msg":"trace[1974898375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1107; }","duration":"157.853571ms","start":"2026-06-03T21:50:36.633713Z","end":"2026-06-03T21:50:36.791567Z","steps":["trace[1974898375] 'agreement among raft nodes before linearized reading' (duration: 157.535673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:50:37.04438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.509692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/cert-manager/cert-manager-startupapicheck:create-cert\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T21:50:37.044484Z","caller":"traceutil/trace.go:171","msg":"trace[1574571297] range","detail":"{range_begin:/registry/rolebindings/cert-manager/cert-manager-startupapicheck:create-cert; range_end:; response_count:0; response_revision:1109; }","duration":"159.668736ms","start":"2026-06-03T21:50:36.884792Z","end":"2026-06-03T21:50:37.044461Z","steps":["trace[1574571297] 'range keys from in-memory index tree' (duration: 159.43522ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:37.465336Z","caller":"traceutil/trace.go:171","msg":"trace[1693006146] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"107.996369ms","start":"2026-06-03T21:50:37.357298Z","end":"2026-06-03T21:50:37.465294Z","steps":["trace[1693006146] 'process raft request' (duration: 69.851383ms)","trace[1693006146] 'compare' (duration: 37.95371ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:50:38.318071Z","caller":"traceutil/trace.go:171","msg":"trace[1492100747] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"139.688217ms","start":"2026-06-03T21:50:38.178345Z","end":"2026-06-03T21:50:38.318034Z","steps":["trace[1492100747] 'process raft request' (duration: 133.814352ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:38.333096Z","caller":"traceutil/trace.go:171","msg":"trace[1243064819] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"101.793157ms","start":"2026-06-03T21:50:38.231266Z","end":"2026-06-03T21:50:38.333059Z","steps":["trace[1243064819] 'process raft request' (duration: 101.597912ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:56.397454Z","caller":"traceutil/trace.go:171","msg":"trace[1873061694] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"150.205364ms","start":"2026-06-03T21:50:56.247196Z","end":"2026-06-03T21:50:56.397402Z","steps":["trace[1873061694] 'process raft request' (duration: 150.000009ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:50:58.753492Z","caller":"traceutil/trace.go:171","msg":"trace[676300230] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1289; }","duration":"120.195938ms","start":"2026-06-03T21:50:58.633275Z","end":"2026-06-03T21:50:58.753471Z","steps":["trace[676300230] 'read index received' (duration: 119.994473ms)","trace[676300230] 'applied index is now lower than readState.Index' (duration: 200.785µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:50:58.753586Z","caller":"traceutil/trace.go:171","msg":"trace[50356493] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"180.960559ms","start":"2026-06-03T21:50:58.572586Z","end":"2026-06-03T21:50:58.753547Z","steps":["trace[50356493] 'process raft request' (duration: 180.757924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:50:58.753612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.314492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T21:50:58.753678Z","caller":"traceutil/trace.go:171","msg":"trace[1352020091] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1254; }","duration":"120.427734ms","start":"2026-06-03T21:50:58.633236Z","end":"2026-06-03T21:50:58.753663Z","steps":["trace[1352020091] 'agreement among raft nodes before linearized reading' (duration: 120.327311ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:15.952733Z","caller":"traceutil/trace.go:171","msg":"trace[998845156] linearizableReadLoop","detail":"{readStateIndex:1447; appliedIndex:1445; }","duration":"136.543058ms","start":"2026-06-03T21:51:15.816161Z","end":"2026-06-03T21:51:15.952704Z","steps":["trace[998845156] 'read index received' (duration: 92.16558ms)","trace[998845156] 'applied index is now lower than readState.Index' (duration: 44.376058ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:51:15.9528Z","caller":"traceutil/trace.go:171","msg":"trace[1229685634] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"140.131386ms","start":"2026-06-03T21:51:15.812617Z","end":"2026-06-03T21:51:15.952748Z","steps":["trace[1229685634] 'process raft request' (duration: 139.89082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:15.953065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.880687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-9xtpf\" ","response":"range_response_count:1 size:4436"} {"level":"info","ts":"2026-06-03T21:51:15.953122Z","caller":"traceutil/trace.go:171","msg":"trace[1963063868] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-9xtpf; range_end:; response_count:1; response_revision:1403; }","duration":"137.006001ms","start":"2026-06-03T21:51:15.816101Z","end":"2026-06-03T21:51:15.953107Z","steps":["trace[1963063868] 'agreement among raft nodes before linearized reading' (duration: 136.732454ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:17.799377Z","caller":"traceutil/trace.go:171","msg":"trace[84749223] transaction","detail":"{read_only:false; response_revision:1486; number_of_response:1; }","duration":"144.660667ms","start":"2026-06-03T21:51:17.654684Z","end":"2026-06-03T21:51:17.799344Z","steps":["trace[84749223] 'process raft request' (duration: 96.833585ms)","trace[84749223] 'compare' (duration: 47.421043ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:51:17.799462Z","caller":"traceutil/trace.go:171","msg":"trace[2057055505] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"143.870408ms","start":"2026-06-03T21:51:17.655533Z","end":"2026-06-03T21:51:17.799403Z","steps":["trace[2057055505] 'process raft request' (duration: 143.664593ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:17.800167Z","caller":"traceutil/trace.go:171","msg":"trace[1757585651] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"140.28916ms","start":"2026-06-03T21:51:17.659827Z","end":"2026-06-03T21:51:17.800116Z","steps":["trace[1757585651] 'process raft request' (duration: 139.450399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:19.907219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.132203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-03T21:51:19.907249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.460337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-03T21:51:19.907351Z","caller":"traceutil/trace.go:171","msg":"trace[1138645262] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1498; }","duration":"104.311998ms","start":"2026-06-03T21:51:19.803009Z","end":"2026-06-03T21:51:19.907321Z","steps":["trace[1138645262] 'range keys from in-memory index tree' (duration: 103.925939ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:19.907362Z","caller":"traceutil/trace.go:171","msg":"trace[992778633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1498; }","duration":"103.656663ms","start":"2026-06-03T21:51:19.80368Z","end":"2026-06-03T21:51:19.907336Z","steps":["trace[992778633] 'range keys from in-memory index tree' (duration: 103.233072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:19.907385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.681097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-03T21:51:19.907494Z","caller":"traceutil/trace.go:171","msg":"trace[636112980] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1498; }","duration":"115.884402ms","start":"2026-06-03T21:51:19.791587Z","end":"2026-06-03T21:51:19.907471Z","steps":["trace[636112980] 'count revisions from in-memory index tree' (duration: 115.567125ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:21.917359Z","caller":"traceutil/trace.go:171","msg":"trace[660099314] transaction","detail":"{read_only:false; response_revision:1507; number_of_response:1; }","duration":"222.646238ms","start":"2026-06-03T21:51:21.694688Z","end":"2026-06-03T21:51:21.917334Z","steps":["trace[660099314] 'process raft request' (duration: 222.504714ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:22.028127Z","caller":"traceutil/trace.go:171","msg":"trace[2664934] transaction","detail":"{read_only:false; response_revision:1509; number_of_response:1; }","duration":"106.664676ms","start":"2026-06-03T21:51:21.92144Z","end":"2026-06-03T21:51:22.028104Z","steps":["trace[2664934] 'process raft request' (duration: 106.619074ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:22.028216Z","caller":"traceutil/trace.go:171","msg":"trace[592759468] transaction","detail":"{read_only:false; response_revision:1508; number_of_response:1; }","duration":"106.779948ms","start":"2026-06-03T21:51:21.921358Z","end":"2026-06-03T21:51:22.028138Z","steps":["trace[592759468] 'process raft request' (duration: 41.249604ms)","trace[592759468] 'compare' (duration: 65.316069ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:51:26.934998Z","caller":"traceutil/trace.go:171","msg":"trace[1447418126] transaction","detail":"{read_only:false; response_revision:1602; number_of_response:1; }","duration":"134.70238ms","start":"2026-06-03T21:51:26.800273Z","end":"2026-06-03T21:51:26.934975Z","steps":["trace[1447418126] 'process raft request' (duration: 134.516664ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:28.223719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.659883ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T21:51:28.223865Z","caller":"traceutil/trace.go:171","msg":"trace[755560160] linearizableReadLoop","detail":"{readStateIndex:1658; appliedIndex:1657; }","duration":"171.784111ms","start":"2026-06-03T21:51:28.052061Z","end":"2026-06-03T21:51:28.223845Z","steps":["trace[755560160] 'read index received' (duration: 58.644537ms)","trace[755560160] 'applied index is now lower than readState.Index' (duration: 113.137634ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:51:28.223911Z","caller":"traceutil/trace.go:171","msg":"trace[2069670048] transaction","detail":"{read_only:false; response_revision:1608; number_of_response:1; }","duration":"189.049301ms","start":"2026-06-03T21:51:28.034828Z","end":"2026-06-03T21:51:28.223877Z","steps":["trace[2069670048] 'process raft request' (duration: 75.976149ms)","trace[2069670048] 'compare' (duration: 112.525328ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:51:28.224096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.849412ms","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-06-03T21:51:28.224156Z","caller":"traceutil/trace.go:171","msg":"trace[1631288602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1608; }","duration":"171.969275ms","start":"2026-06-03T21:51:28.052171Z","end":"2026-06-03T21:51:28.224141Z","steps":["trace[1631288602] 'agreement among raft nodes before linearized reading' (duration: 171.792261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:28.224223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.115229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-03T21:51:28.22435Z","caller":"traceutil/trace.go:171","msg":"trace[157298565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1608; }","duration":"172.263062ms","start":"2026-06-03T21:51:28.052039Z","end":"2026-06-03T21:51:28.224302Z","steps":["trace[157298565] 'agreement among raft nodes before linearized reading' (duration: 171.872383ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:28.390156Z","caller":"traceutil/trace.go:171","msg":"trace[1130734713] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1610; }","duration":"105.728883ms","start":"2026-06-03T21:51:28.284409Z","end":"2026-06-03T21:51:28.390138Z","steps":["trace[1130734713] 'process raft request' (duration: 103.16383ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:28.904859Z","caller":"traceutil/trace.go:171","msg":"trace[1166233124] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1612; }","duration":"120.441432ms","start":"2026-06-03T21:51:28.784388Z","end":"2026-06-03T21:51:28.90483Z","steps":["trace[1166233124] 'process raft request' (duration: 120.270068ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:29.084803Z","caller":"traceutil/trace.go:171","msg":"trace[183142427] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1612; }","duration":"163.327925ms","start":"2026-06-03T21:51:28.921447Z","end":"2026-06-03T21:51:29.084775Z","steps":["trace[183142427] 'process raft request' (duration: 163.186311ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:29.260998Z","caller":"traceutil/trace.go:171","msg":"trace[2068906703] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1612; }","duration":"154.843678ms","start":"2026-06-03T21:51:29.10613Z","end":"2026-06-03T21:51:29.260974Z","steps":["trace[2068906703] 'process raft request' (duration: 154.702914ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:29.385484Z","caller":"traceutil/trace.go:171","msg":"trace[1818804172] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1613; }","duration":"105.177639ms","start":"2026-06-03T21:51:29.280283Z","end":"2026-06-03T21:51:29.385461Z","steps":["trace[1818804172] 'process raft request' (duration: 95.965006ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:40.819034Z","caller":"traceutil/trace.go:171","msg":"trace[246394323] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"104.059752ms","start":"2026-06-03T21:51:40.714944Z","end":"2026-06-03T21:51:40.819004Z","steps":["trace[246394323] 'process raft request' (duration: 103.851697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:48.210967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.310294ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T21:51:48.211121Z","caller":"traceutil/trace.go:171","msg":"trace[1631310756] linearizableReadLoop","detail":"{readStateIndex:1996; appliedIndex:1995; }","duration":"649.313911ms","start":"2026-06-03T21:51:47.561788Z","end":"2026-06-03T21:51:48.211102Z","steps":["trace[1631310756] 'read index received' (duration: 42.630488ms)","trace[1631310756] 'applied index is now lower than readState.Index' (duration: 606.681763ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:51:48.211305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.520417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-03T21:51:48.211345Z","caller":"traceutil/trace.go:171","msg":"trace[1506167464] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1922; }","duration":"649.624089ms","start":"2026-06-03T21:51:47.561709Z","end":"2026-06-03T21:51:48.211333Z","steps":["trace[1506167464] 'agreement among raft nodes before linearized reading' (duration: 649.476504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:48.211382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:47.561676Z","time spent":"649.696201ms","remote":"127.0.0.1:55096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":54,"response size":31,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"info","ts":"2026-06-03T21:51:48.211244Z","caller":"traceutil/trace.go:171","msg":"trace[2061438810] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"780.636766ms","start":"2026-06-03T21:51:47.430556Z","end":"2026-06-03T21:51:48.211192Z","steps":["trace[2061438810] 'process raft request' (duration: 173.957663ms)","trace[2061438810] 'compare' (duration: 606.077719ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:51:48.211725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:47.430527Z","time spent":"780.990606ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:51:48.410884Z","caller":"traceutil/trace.go:171","msg":"trace[693427030] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"442.308804ms","start":"2026-06-03T21:51:47.968545Z","end":"2026-06-03T21:51:48.410854Z","steps":["trace[693427030] 'process raft request' (duration: 366.602262ms)","trace[693427030] 'compare' (duration: 75.530378ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:51:48.411048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:47.96852Z","time spent":"442.443047ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:51:48.411479Z","caller":"traceutil/trace.go:171","msg":"trace[716094959] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"355.346538ms","start":"2026-06-03T21:51:48.056097Z","end":"2026-06-03T21:51:48.411443Z","steps":["trace[716094959] 'process raft request' (duration: 354.724543ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:48.411484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.519857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c44054e9-4b7a-4219-b530-fa48df66a2a3\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-03T21:51:48.411565Z","caller":"traceutil/trace.go:171","msg":"trace[311088564] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c44054e9-4b7a-4219-b530-fa48df66a2a3; range_end:; response_count:1; response_revision:1924; }","duration":"543.681231ms","start":"2026-06-03T21:51:47.867863Z","end":"2026-06-03T21:51:48.411544Z","steps":["trace[311088564] 'agreement among raft nodes before linearized reading' (duration: 543.279141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:48.411588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.660745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c44054e9-4b7a-4219-b530-fa48df66a2a3\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-06-03T21:51:48.411598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:48.056053Z","time spent":"355.490022ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T21:51:48.411606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:47.867832Z","time spent":"543.764753ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c44054e9-4b7a-4219-b530-fa48df66a2a3\" "} {"level":"warn","ts":"2026-06-03T21:51:48.411597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.529186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T21:51:48.411633Z","caller":"traceutil/trace.go:171","msg":"trace[26924744] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c44054e9-4b7a-4219-b530-fa48df66a2a3; range_end:; response_count:1; response_revision:1924; }","duration":"634.733727ms","start":"2026-06-03T21:51:47.776884Z","end":"2026-06-03T21:51:48.411618Z","steps":["trace[26924744] 'agreement among raft nodes before linearized reading' (duration: 634.566263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:48.411681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:47.776869Z","time spent":"634.801549ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c44054e9-4b7a-4219-b530-fa48df66a2a3\" "} {"level":"info","ts":"2026-06-03T21:51:48.411694Z","caller":"traceutil/trace.go:171","msg":"trace[726170550] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1924; }","duration":"778.66133ms","start":"2026-06-03T21:51:47.633006Z","end":"2026-06-03T21:51:48.411667Z","steps":["trace[726170550] 'agreement among raft nodes before linearized reading' (duration: 778.458145ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:48.411726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.843701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-06-03T21:51:48.411741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:47.632995Z","time spent":"778.741071ms","remote":"127.0.0.1:55034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-03T21:51:48.41172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.909443ms","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-06-03T21:51:48.411789Z","caller":"traceutil/trace.go:171","msg":"trace[1958230714] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1924; }","duration":"835.936223ms","start":"2026-06-03T21:51:47.575832Z","end":"2026-06-03T21:51:48.411768Z","steps":["trace[1958230714] 'agreement among raft nodes before linearized reading' (duration: 835.768879ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:48.411807Z","caller":"traceutil/trace.go:171","msg":"trace[135279888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1924; }","duration":"594.034637ms","start":"2026-06-03T21:51:47.817752Z","end":"2026-06-03T21:51:48.411787Z","steps":["trace[135279888] 'agreement among raft nodes before linearized reading' (duration: 593.74193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:48.411825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:47.575817Z","time spent":"835.999834ms","remote":"127.0.0.1:50524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-03T21:51:48.411842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:47.817743Z","time spent":"594.092888ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-03T21:51:48.411034Z","caller":"traceutil/trace.go:171","msg":"trace[576675631] linearizableReadLoop","detail":"{readStateIndex:1998; appliedIndex:1996; }","duration":"199.852995ms","start":"2026-06-03T21:51:48.211151Z","end":"2026-06-03T21:51:48.411004Z","steps":["trace[576675631] 'read index received' (duration: 123.961388ms)","trace[576675631] 'applied index is now lower than readState.Index' (duration: 75.890567ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:51:48.412393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.379423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-03T21:51:48.412438Z","caller":"traceutil/trace.go:171","msg":"trace[259341284] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1924; }","duration":"144.508466ms","start":"2026-06-03T21:51:48.267917Z","end":"2026-06-03T21:51:48.412425Z","steps":["trace[259341284] 'agreement among raft nodes before linearized reading' (duration: 144.339282ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:48.928092Z","caller":"traceutil/trace.go:171","msg":"trace[614961448] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"512.601454ms","start":"2026-06-03T21:51:48.415464Z","end":"2026-06-03T21:51:48.928066Z","steps":["trace[614961448] 'process raft request' (duration: 435.849097ms)","trace[614961448] 'compare' (duration: 76.522142ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:51:48.928253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:48.415444Z","time spent":"512.710157ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:51:48.930691Z","caller":"traceutil/trace.go:171","msg":"trace[755786182] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"514.116501ms","start":"2026-06-03T21:51:48.416556Z","end":"2026-06-03T21:51:48.930673Z","steps":["trace[755786182] 'process raft request' (duration: 513.958907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:48.930833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:48.416516Z","time spent":"514.270945ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:51:48.931086Z","caller":"traceutil/trace.go:171","msg":"trace[1123934159] linearizableReadLoop","detail":"{readStateIndex:2001; appliedIndex:1998; }","duration":"468.809398ms","start":"2026-06-03T21:51:48.462246Z","end":"2026-06-03T21:51:48.931055Z","steps":["trace[1123934159] 'read index received' (duration: 389.086968ms)","trace[1123934159] 'applied index is now lower than readState.Index' (duration: 79.7209ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:51:48.931371Z","caller":"traceutil/trace.go:171","msg":"trace[674021983] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"513.573679ms","start":"2026-06-03T21:51:48.417689Z","end":"2026-06-03T21:51:48.931262Z","steps":["trace[674021983] 'process raft request' (duration: 512.920622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:48.931459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.192399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-03T21:51:48.931508Z","caller":"traceutil/trace.go:171","msg":"trace[294985864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1928; }","duration":"469.325651ms","start":"2026-06-03T21:51:48.462168Z","end":"2026-06-03T21:51:48.931494Z","steps":["trace[294985864] 'agreement among raft nodes before linearized reading' (duration: 469.070665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:48.931488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:48.417675Z","time spent":"513.769803ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T21:51:48.931576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.396437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-03T21:51:48.931542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.481582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-03T21:51:48.9317Z","caller":"traceutil/trace.go:171","msg":"trace[1786037354] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1928; }","duration":"433.551971ms","start":"2026-06-03T21:51:48.498116Z","end":"2026-06-03T21:51:48.931668Z","steps":["trace[1786037354] 'agreement among raft nodes before linearized reading' (duration: 433.204852ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:51:48.931749Z","caller":"traceutil/trace.go:171","msg":"trace[1662542087] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1928; }","duration":"173.755538ms","start":"2026-06-03T21:51:48.757968Z","end":"2026-06-03T21:51:48.931723Z","steps":["trace[1662542087] 'agreement among raft nodes before linearized reading' (duration: 173.367349ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:51:48.93176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:48.498105Z","time spent":"433.642994ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-03T21:51:48.931554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:51:48.462143Z","time spent":"469.401064ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-03T21:51:58.77215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.498902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-03T21:51:58.772266Z","caller":"traceutil/trace.go:171","msg":"trace[936826595] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2019; }","duration":"286.701917ms","start":"2026-06-03T21:51:58.485538Z","end":"2026-06-03T21:51:58.77224Z","steps":["trace[936826595] 'range keys from in-memory index tree' (duration: 286.253076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:04.812303Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726713062380396,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-03T21:52:04.998901Z","caller":"traceutil/trace.go:171","msg":"trace[1093236472] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"699.613336ms","start":"2026-06-03T21:52:04.299258Z","end":"2026-06-03T21:52:04.998871Z","steps":["trace[1093236472] 'process raft request' (duration: 699.442642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:04.999085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:04.299237Z","time spent":"699.750049ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:52:05.020979Z","caller":"traceutil/trace.go:171","msg":"trace[796826754] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"538.739011ms","start":"2026-06-03T21:52:04.4822Z","end":"2026-06-03T21:52:05.020939Z","steps":["trace[796826754] 'process raft request' (duration: 538.387592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:05.021212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:04.482171Z","time spent":"538.912085ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:52:05.021362Z","caller":"traceutil/trace.go:171","msg":"trace[1466757972] linearizableReadLoop","detail":"{readStateIndex:2141; appliedIndex:2138; }","duration":"709.528057ms","start":"2026-06-03T21:52:04.311802Z","end":"2026-06-03T21:52:05.02133Z","steps":["trace[1466757972] 'read index received' (duration: 686.947917ms)","trace[1466757972] 'applied index is now lower than readState.Index' (duration: 22.57828ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:52:05.021542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.719701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-03T21:52:05.021611Z","caller":"traceutil/trace.go:171","msg":"trace[130116637] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:2064; }","duration":"709.832674ms","start":"2026-06-03T21:52:04.311761Z","end":"2026-06-03T21:52:05.021594Z","steps":["trace[130116637] 'agreement among raft nodes before linearized reading' (duration: 709.695731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:05.021607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.402972ms","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-06-03T21:52:05.021633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.823352ms","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":"warn","ts":"2026-06-03T21:52:05.021651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:04.311749Z","time spent":"709.892475ms","remote":"127.0.0.1:60808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":31,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"info","ts":"2026-06-03T21:52:05.021678Z","caller":"traceutil/trace.go:171","msg":"trace[1462506366] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2064; }","duration":"125.919884ms","start":"2026-06-03T21:52:04.895746Z","end":"2026-06-03T21:52:05.021666Z","steps":["trace[1462506366] 'agreement among raft nodes before linearized reading' (duration: 125.822062ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:05.021679Z","caller":"traceutil/trace.go:171","msg":"trace[647851062] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2064; }","duration":"291.529274ms","start":"2026-06-03T21:52:04.730112Z","end":"2026-06-03T21:52:05.021641Z","steps":["trace[647851062] 'agreement among raft nodes before linearized reading' (duration: 291.420782ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:05.021925Z","caller":"traceutil/trace.go:171","msg":"trace[2063643559] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"535.281836ms","start":"2026-06-03T21:52:04.48586Z","end":"2026-06-03T21:52:05.021142Z","steps":["trace[2063643559] 'process raft request' (duration: 534.897437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:05.022117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:04.485833Z","time spent":"536.170658ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T21:52:05.022163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.883817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-03T21:52:05.022452Z","caller":"traceutil/trace.go:171","msg":"trace[243166306] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2064; }","duration":"203.416591ms","start":"2026-06-03T21:52:04.819009Z","end":"2026-06-03T21:52:05.022425Z","steps":["trace[243166306] 'agreement among raft nodes before linearized reading' (duration: 202.56391ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:33.291855Z","caller":"traceutil/trace.go:171","msg":"trace[2097789296] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"139.313253ms","start":"2026-06-03T21:52:33.152512Z","end":"2026-06-03T21:52:33.291826Z","steps":["trace[2097789296] 'process raft request' (duration: 139.131678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:33.691214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.290179ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T21:52:33.691508Z","caller":"traceutil/trace.go:171","msg":"trace[1250796534] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"100.947161ms","start":"2026-06-03T21:52:33.590536Z","end":"2026-06-03T21:52:33.691483Z","steps":["trace[1250796534] 'process raft request' (duration: 100.89637ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:33.691605Z","caller":"traceutil/trace.go:171","msg":"trace[1005095787] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"528.068218ms","start":"2026-06-03T21:52:33.163516Z","end":"2026-06-03T21:52:33.691584Z","steps":["trace[1005095787] 'process raft request' (duration: 527.827793ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:33.691689Z","caller":"traceutil/trace.go:171","msg":"trace[2129641965] linearizableReadLoop","detail":"{readStateIndex:2308; appliedIndex:2305; }","duration":"502.572421ms","start":"2026-06-03T21:52:33.189101Z","end":"2026-06-03T21:52:33.691673Z","steps":["trace[2129641965] 'read index received' (duration: 102.649622ms)","trace[2129641965] 'applied index is now lower than readState.Index' (duration: 399.921158ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:52:33.691912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.812477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-03T21:52:33.691917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.779243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-03T21:52:33.691901Z","caller":"traceutil/trace.go:171","msg":"trace[642823461] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"529.338271ms","start":"2026-06-03T21:52:33.162469Z","end":"2026-06-03T21:52:33.691807Z","steps":["trace[642823461] 'process raft request' (duration: 303.347284ms)","trace[642823461] 'compare' (duration: 225.141175ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:52:33.691963Z","caller":"traceutil/trace.go:171","msg":"trace[431326281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2224; }","duration":"502.901209ms","start":"2026-06-03T21:52:33.189043Z","end":"2026-06-03T21:52:33.691944Z","steps":["trace[431326281] 'agreement among raft nodes before linearized reading' (duration: 502.731555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:33.691918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.90621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-03T21:52:33.691917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.83802ms","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":"warn","ts":"2026-06-03T21:52:33.692009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.729857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-03T21:52:33.692023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:33.189028Z","time spent":"502.981691ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-03T21:52:33.692045Z","caller":"traceutil/trace.go:171","msg":"trace[148600837] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2224; }","duration":"363.104715ms","start":"2026-06-03T21:52:33.328918Z","end":"2026-06-03T21:52:33.692023Z","steps":["trace[148600837] 'agreement among raft nodes before linearized reading' (duration: 362.88156ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:33.693381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:33.328901Z","time spent":"364.458587ms","remote":"127.0.0.1:55206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":31,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-06-03T21:52:33.692061Z","caller":"traceutil/trace.go:171","msg":"trace[624475772] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:2224; }","duration":"146.053005ms","start":"2026-06-03T21:52:33.545986Z","end":"2026-06-03T21:52:33.692039Z","steps":["trace[624475772] 'agreement among raft nodes before linearized reading' (duration: 145.82294ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:33.692Z","caller":"traceutil/trace.go:171","msg":"trace[1764967902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2224; }","duration":"492.880725ms","start":"2026-06-03T21:52:33.1991Z","end":"2026-06-03T21:52:33.691981Z","steps":["trace[1764967902] 'agreement among raft nodes before linearized reading' (duration: 492.700531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:33.693595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:33.19909Z","time spent":"494.488964ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-03T21:52:33.692041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.341867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-03T21:52:33.693784Z","caller":"traceutil/trace.go:171","msg":"trace[814374882] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2224; }","duration":"488.13022ms","start":"2026-06-03T21:52:33.205637Z","end":"2026-06-03T21:52:33.693767Z","steps":["trace[814374882] 'agreement among raft nodes before linearized reading' (duration: 486.180103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:33.693811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:33.205624Z","time spent":"488.17841ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-03T21:52:33.692075Z","caller":"traceutil/trace.go:171","msg":"trace[1993305046] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2224; }","duration":"491.839931ms","start":"2026-06-03T21:52:33.200211Z","end":"2026-06-03T21:52:33.692051Z","steps":["trace[1993305046] 'agreement among raft nodes before linearized reading' (duration: 491.664716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:33.693875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:33.200191Z","time spent":"493.678834ms","remote":"127.0.0.1:55334","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":"warn","ts":"2026-06-03T21:52:33.69212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.598638ms","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-06-03T21:52:33.692132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.461543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T21:52:33.693945Z","caller":"traceutil/trace.go:171","msg":"trace[1102937160] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2224; }","duration":"494.457403ms","start":"2026-06-03T21:52:33.199459Z","end":"2026-06-03T21:52:33.693916Z","steps":["trace[1102937160] 'agreement among raft nodes before linearized reading' (duration: 492.569938ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:33.694008Z","caller":"traceutil/trace.go:171","msg":"trace[1925284169] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:2224; }","duration":"262.365229ms","start":"2026-06-03T21:52:33.431623Z","end":"2026-06-03T21:52:33.693988Z","steps":["trace[1925284169] 'agreement among raft nodes before linearized reading' (duration: 260.475154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:33.694013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:33.19943Z","time spent":"494.567135ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-03T21:52:33.691835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:33.163494Z","time spent":"528.162402ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T21:52:33.692156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:33.162428Z","time spent":"529.599867ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T21:52:33.69217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.887384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-03T21:52:33.694138Z","caller":"traceutil/trace.go:171","msg":"trace[1229047239] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2224; }","duration":"440.900843ms","start":"2026-06-03T21:52:33.253218Z","end":"2026-06-03T21:52:33.694119Z","steps":["trace[1229047239] 'agreement among raft nodes before linearized reading' (duration: 438.69764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:33.694207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:33.253207Z","time spent":"440.959934ms","remote":"127.0.0.1:50524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-03T21:52:33.895818Z","caller":"traceutil/trace.go:171","msg":"trace[1274456510] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"195.075955ms","start":"2026-06-03T21:52:33.700713Z","end":"2026-06-03T21:52:33.895789Z","steps":["trace[1274456510] 'process raft request' (duration: 195.021883ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:33.896213Z","caller":"traceutil/trace.go:171","msg":"trace[1579029905] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"198.313165ms","start":"2026-06-03T21:52:33.697846Z","end":"2026-06-03T21:52:33.896159Z","steps":["trace[1579029905] 'process raft request' (duration: 197.791741ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:33.896348Z","caller":"traceutil/trace.go:171","msg":"trace[1772699972] transaction","detail":"{read_only:false; response_revision:2228; number_of_response:1; }","duration":"198.442518ms","start":"2026-06-03T21:52:33.697889Z","end":"2026-06-03T21:52:33.896332Z","steps":["trace[1772699972] 'process raft request' (duration: 197.799571ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:33.896494Z","caller":"traceutil/trace.go:171","msg":"trace[1554339015] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"198.790646ms","start":"2026-06-03T21:52:33.69765Z","end":"2026-06-03T21:52:33.89644Z","steps":["trace[1554339015] 'process raft request' (duration: 117.534434ms)","trace[1554339015] 'compare' (duration: 80.336719ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:52:39.896643Z","caller":"traceutil/trace.go:171","msg":"trace[116965906] transaction","detail":"{read_only:false; response_revision:2251; number_of_response:1; }","duration":"184.140839ms","start":"2026-06-03T21:52:39.712472Z","end":"2026-06-03T21:52:39.896613Z","steps":["trace[116965906] 'process raft request' (duration: 183.963505ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:40.014359Z","caller":"traceutil/trace.go:171","msg":"trace[775167050] transaction","detail":"{read_only:false; response_revision:2253; number_of_response:1; }","duration":"296.653021ms","start":"2026-06-03T21:52:39.717664Z","end":"2026-06-03T21:52:40.014317Z","steps":["trace[775167050] 'process raft request' (duration: 296.507087ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:40.014465Z","caller":"traceutil/trace.go:171","msg":"trace[564855990] transaction","detail":"{read_only:false; response_revision:2254; number_of_response:1; }","duration":"229.247425ms","start":"2026-06-03T21:52:39.785193Z","end":"2026-06-03T21:52:40.01444Z","steps":["trace[564855990] 'process raft request' (duration: 229.036979ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:40.014473Z","caller":"traceutil/trace.go:171","msg":"trace[471926754] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"298.340053ms","start":"2026-06-03T21:52:39.716097Z","end":"2026-06-03T21:52:40.014438Z","steps":["trace[471926754] 'process raft request' (duration: 240.370715ms)","trace[471926754] 'compare' (duration: 57.572837ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:52:40.01455Z","caller":"traceutil/trace.go:171","msg":"trace[652195172] linearizableReadLoop","detail":"{readStateIndex:2339; appliedIndex:2336; }","duration":"276.676377ms","start":"2026-06-03T21:52:39.737842Z","end":"2026-06-03T21:52:40.014519Z","steps":["trace[652195172] 'read index received' (duration: 158.581879ms)","trace[652195172] 'applied index is now lower than readState.Index' (duration: 118.090667ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:52:40.01482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.964123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-03T21:52:40.014892Z","caller":"traceutil/trace.go:171","msg":"trace[20397034] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2255; }","duration":"277.095417ms","start":"2026-06-03T21:52:39.737776Z","end":"2026-06-03T21:52:40.014871Z","steps":["trace[20397034] 'agreement among raft nodes before linearized reading' (duration: 276.878172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:40.014928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.81214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-03T21:52:40.015006Z","caller":"traceutil/trace.go:171","msg":"trace[1622528899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2255; }","duration":"206.911393ms","start":"2026-06-03T21:52:39.808078Z","end":"2026-06-03T21:52:40.014989Z","steps":["trace[1622528899] 'agreement among raft nodes before linearized reading' (duration: 206.620566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:41.960657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.876871ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T21:52:41.960865Z","caller":"traceutil/trace.go:171","msg":"trace[1975097308] linearizableReadLoop","detail":"{readStateIndex:2348; appliedIndex:2347; }","duration":"485.980987ms","start":"2026-06-03T21:52:41.474864Z","end":"2026-06-03T21:52:41.960845Z","steps":["trace[1975097308] 'read index received' (duration: 367.791788ms)","trace[1975097308] 'applied index is now lower than readState.Index' (duration: 118.187519ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:52:41.960906Z","caller":"traceutil/trace.go:171","msg":"trace[2080425229] transaction","detail":"{read_only:false; response_revision:2262; number_of_response:1; }","duration":"645.028438ms","start":"2026-06-03T21:52:41.315836Z","end":"2026-06-03T21:52:41.960864Z","steps":["trace[2080425229] 'process raft request' (duration: 526.825139ms)","trace[2080425229] 'compare' (duration: 117.598865ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:52:41.961196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.313655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-03T21:52:41.961237Z","caller":"traceutil/trace.go:171","msg":"trace[405314144] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2262; }","duration":"486.418208ms","start":"2026-06-03T21:52:41.474803Z","end":"2026-06-03T21:52:41.961221Z","steps":["trace[405314144] 'agreement among raft nodes before linearized reading' (duration: 486.124961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:41.961276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:41.474777Z","time spent":"486.490149ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-03T21:52:41.961104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:41.315806Z","time spent":"645.185412ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:52:42.19003Z","caller":"traceutil/trace.go:171","msg":"trace[416985125] linearizableReadLoop","detail":"{readStateIndex:2349; appliedIndex:2348; }","duration":"229.106542ms","start":"2026-06-03T21:52:41.960897Z","end":"2026-06-03T21:52:42.190003Z","steps":["trace[416985125] 'read index received' (duration: 205.625512ms)","trace[416985125] 'applied index is now lower than readState.Index' (duration: 23.47995ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:52:42.190054Z","caller":"traceutil/trace.go:171","msg":"trace[196344981] transaction","detail":"{read_only:false; response_revision:2263; number_of_response:1; }","duration":"287.641363ms","start":"2026-06-03T21:52:41.902358Z","end":"2026-06-03T21:52:42.189999Z","steps":["trace[196344981] 'process raft request' (duration: 264.146553ms)","trace[196344981] 'compare' (duration: 23.322816ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:52:42.190259Z","caller":"traceutil/trace.go:171","msg":"trace[974734833] transaction","detail":"{read_only:false; response_revision:2264; number_of_response:1; }","duration":"224.134281ms","start":"2026-06-03T21:52:41.966113Z","end":"2026-06-03T21:52:42.190247Z","steps":["trace[974734833] 'process raft request' (duration: 223.848084ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:42.19056Z","caller":"traceutil/trace.go:171","msg":"trace[12699479] transaction","detail":"{read_only:false; response_revision:2265; number_of_response:1; }","duration":"168.343346ms","start":"2026-06-03T21:52:42.022175Z","end":"2026-06-03T21:52:42.190518Z","steps":["trace[12699479] 'process raft request' (duration: 168.028289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:42.190595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.66114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-06-03T21:52:42.190661Z","caller":"traceutil/trace.go:171","msg":"trace[1404555357] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2265; }","duration":"291.796703ms","start":"2026-06-03T21:52:41.898848Z","end":"2026-06-03T21:52:42.190645Z","steps":["trace[1404555357] 'agreement among raft nodes before linearized reading' (duration: 291.305951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:42.190797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.933777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-06-03T21:52:42.190867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.032523ms","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-06-03T21:52:42.190893Z","caller":"traceutil/trace.go:171","msg":"trace[167135976] transaction","detail":"{read_only:false; response_revision:2266; number_of_response:1; }","duration":"168.412878ms","start":"2026-06-03T21:52:42.022464Z","end":"2026-06-03T21:52:42.190877Z","steps":["trace[167135976] 'process raft request' (duration: 167.955417ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:42.190961Z","caller":"traceutil/trace.go:171","msg":"trace[2132971751] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2266; }","duration":"159.077881ms","start":"2026-06-03T21:52:42.031824Z","end":"2026-06-03T21:52:42.190902Z","steps":["trace[2132971751] 'agreement among raft nodes before linearized reading' (duration: 158.698612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:42.190834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.149917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-03T21:52:42.1911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.608465ms","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-06-03T21:52:42.191165Z","caller":"traceutil/trace.go:171","msg":"trace[330838452] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2266; }","duration":"138.720238ms","start":"2026-06-03T21:52:42.052431Z","end":"2026-06-03T21:52:42.191151Z","steps":["trace[330838452] 'agreement among raft nodes before linearized reading' (duration: 138.478042ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:42.191112Z","caller":"traceutil/trace.go:171","msg":"trace[863857610] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2266; }","duration":"139.442685ms","start":"2026-06-03T21:52:42.05165Z","end":"2026-06-03T21:52:42.191093Z","steps":["trace[863857610] 'agreement among raft nodes before linearized reading' (duration: 138.882911ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:42.19094Z","caller":"traceutil/trace.go:171","msg":"trace[1737566892] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2266; }","duration":"141.140676ms","start":"2026-06-03T21:52:42.049783Z","end":"2026-06-03T21:52:42.190924Z","steps":["trace[1737566892] 'agreement among raft nodes before linearized reading' (duration: 140.960692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:42.191351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.856591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-03T21:52:42.191495Z","caller":"traceutil/trace.go:171","msg":"trace[1555623095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2266; }","duration":"146.075486ms","start":"2026-06-03T21:52:42.045387Z","end":"2026-06-03T21:52:42.191462Z","steps":["trace[1555623095] 'agreement among raft nodes before linearized reading' (duration: 145.597423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:42.191499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.092671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-03T21:52:42.19188Z","caller":"traceutil/trace.go:171","msg":"trace[870997589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2266; }","duration":"140.513811ms","start":"2026-06-03T21:52:42.051341Z","end":"2026-06-03T21:52:42.191854Z","steps":["trace[870997589] 'agreement among raft nodes before linearized reading' (duration: 139.532037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:42.471487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.218323ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T21:52:42.472043Z","caller":"traceutil/trace.go:171","msg":"trace[654066066] transaction","detail":"{read_only:false; response_revision:2271; number_of_response:1; }","duration":"273.252793ms","start":"2026-06-03T21:52:42.198772Z","end":"2026-06-03T21:52:42.472025Z","steps":["trace[654066066] 'process raft request' (duration: 273.031118ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:42.472016Z","caller":"traceutil/trace.go:171","msg":"trace[1817277974] transaction","detail":"{read_only:false; response_revision:2270; number_of_response:1; }","duration":"273.404817ms","start":"2026-06-03T21:52:42.198569Z","end":"2026-06-03T21:52:42.471974Z","steps":["trace[1817277974] 'process raft request' (duration: 273.202172ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:42.472129Z","caller":"traceutil/trace.go:171","msg":"trace[894637466] transaction","detail":"{read_only:false; response_revision:2272; number_of_response:1; }","duration":"143.589026ms","start":"2026-06-03T21:52:42.328485Z","end":"2026-06-03T21:52:42.472074Z","steps":["trace[894637466] 'process raft request' (duration: 143.35018ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:42.472037Z","caller":"traceutil/trace.go:171","msg":"trace[1250024497] transaction","detail":"{read_only:false; response_revision:2268; number_of_response:1; }","duration":"274.847562ms","start":"2026-06-03T21:52:42.197168Z","end":"2026-06-03T21:52:42.472015Z","steps":["trace[1250024497] 'process raft request' (duration: 274.514964ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:42.47238Z","caller":"traceutil/trace.go:171","msg":"trace[1406875585] linearizableReadLoop","detail":"{readStateIndex:2357; appliedIndex:2352; }","duration":"267.429753ms","start":"2026-06-03T21:52:42.204438Z","end":"2026-06-03T21:52:42.471868Z","steps":["trace[1406875585] 'read index received' (duration: 131.723468ms)","trace[1406875585] 'applied index is now lower than readState.Index' (duration: 135.705245ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:52:42.472113Z","caller":"traceutil/trace.go:171","msg":"trace[359361224] transaction","detail":"{read_only:false; response_revision:2269; number_of_response:1; }","duration":"274.611367ms","start":"2026-06-03T21:52:42.19746Z","end":"2026-06-03T21:52:42.472072Z","steps":["trace[359361224] 'process raft request' (duration: 274.274728ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:52:42.472133Z","caller":"traceutil/trace.go:171","msg":"trace[1439881735] transaction","detail":"{read_only:false; response_revision:2267; number_of_response:1; }","duration":"274.914433ms","start":"2026-06-03T21:52:42.196935Z","end":"2026-06-03T21:52:42.47185Z","steps":["trace[1439881735] 'process raft request' (duration: 139.241469ms)","trace[1439881735] 'compare' (duration: 135.098061ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:52:42.472444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.895313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T21:52:42.472588Z","caller":"traceutil/trace.go:171","msg":"trace[107154407] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2272; }","duration":"268.15654ms","start":"2026-06-03T21:52:42.204388Z","end":"2026-06-03T21:52:42.472545Z","steps":["trace[107154407] 'agreement among raft nodes before linearized reading' (duration: 267.791191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:52:47.589939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:52:47.288124Z","time spent":"301.809057ms","remote":"127.0.0.1:55070","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-03T21:52:47.692165Z","caller":"traceutil/trace.go:171","msg":"trace[1857412417] transaction","detail":"{read_only:false; response_revision:2293; number_of_response:1; }","duration":"171.483502ms","start":"2026-06-03T21:52:47.520642Z","end":"2026-06-03T21:52:47.692126Z","steps":["trace[1857412417] 'process raft request' (duration: 113.69743ms)","trace[1857412417] 'compare' (duration: 57.357022ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:52:47.692264Z","caller":"traceutil/trace.go:171","msg":"trace[1573122180] transaction","detail":"{read_only:false; response_revision:2294; number_of_response:1; }","duration":"101.118305ms","start":"2026-06-03T21:52:47.591117Z","end":"2026-06-03T21:52:47.692235Z","steps":["trace[1573122180] 'process raft request' (duration: 100.763027ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:53:28.185884Z","caller":"traceutil/trace.go:171","msg":"trace[1694844317] transaction","detail":"{read_only:false; response_revision:2655; number_of_response:1; }","duration":"163.831327ms","start":"2026-06-03T21:53:28.022024Z","end":"2026-06-03T21:53:28.185856Z","steps":["trace[1694844317] 'process raft request' (duration: 162.074364ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:53:28.186026Z","caller":"traceutil/trace.go:171","msg":"trace[717432343] transaction","detail":"{read_only:false; response_revision:2657; number_of_response:1; }","duration":"162.829483ms","start":"2026-06-03T21:53:28.023172Z","end":"2026-06-03T21:53:28.186001Z","steps":["trace[717432343] 'process raft request' (duration: 162.6858ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:53:28.186021Z","caller":"traceutil/trace.go:171","msg":"trace[1535852083] transaction","detail":"{read_only:false; response_revision:2656; number_of_response:1; }","duration":"163.776835ms","start":"2026-06-03T21:53:28.022196Z","end":"2026-06-03T21:53:28.185973Z","steps":["trace[1535852083] 'process raft request' (duration: 163.590791ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:13.527649Z","caller":"traceutil/trace.go:171","msg":"trace[1711389516] linearizableReadLoop","detail":"{readStateIndex:5146; appliedIndex:5145; }","duration":"201.388889ms","start":"2026-06-03T21:58:13.32624Z","end":"2026-06-03T21:58:13.527629Z","steps":["trace[1711389516] 'read index received' (duration: 201.228005ms)","trace[1711389516] 'applied index is now lower than readState.Index' (duration: 159.683µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:58:13.52774Z","caller":"traceutil/trace.go:171","msg":"trace[2055132325] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"246.836866ms","start":"2026-06-03T21:58:13.280896Z","end":"2026-06-03T21:58:13.527733Z","steps":["trace[2055132325] 'process raft request' (duration: 246.6038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:13.527964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.706867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-66c867eb-c80f-4bd3-b101-dd6de823ce44\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-06-03T21:58:13.528039Z","caller":"traceutil/trace.go:171","msg":"trace[1804199440] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-66c867eb-c80f-4bd3-b101-dd6de823ce44; range_end:; response_count:1; response_revision:4957; }","duration":"201.84299ms","start":"2026-06-03T21:58:13.326178Z","end":"2026-06-03T21:58:13.528021Z","steps":["trace[1804199440] 'agreement among raft nodes before linearized reading' (duration: 201.579234ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:13.538629Z","caller":"traceutil/trace.go:171","msg":"trace[595961893] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"200.668602ms","start":"2026-06-03T21:58:13.337944Z","end":"2026-06-03T21:58:13.538612Z","steps":["trace[595961893] 'process raft request' (duration: 200.522378ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:14.228567Z","caller":"traceutil/trace.go:171","msg":"trace[193173704] transaction","detail":"{read_only:false; response_revision:4967; number_of_response:1; }","duration":"105.061043ms","start":"2026-06-03T21:58:14.123476Z","end":"2026-06-03T21:58:14.228537Z","steps":["trace[193173704] 'process raft request' (duration: 104.885059ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:15.707685Z","caller":"traceutil/trace.go:171","msg":"trace[1490280292] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"164.358383ms","start":"2026-06-03T21:58:15.54328Z","end":"2026-06-03T21:58:15.707638Z","steps":["trace[1490280292] 'process raft request' (duration: 164.006255ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:15.743242Z","caller":"traceutil/trace.go:171","msg":"trace[818097855] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"199.127255ms","start":"2026-06-03T21:58:15.544094Z","end":"2026-06-03T21:58:15.743221Z","steps":["trace[818097855] 'process raft request' (duration: 198.90273ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:15.743639Z","caller":"traceutil/trace.go:171","msg":"trace[1339757149] linearizableReadLoop","detail":"{readStateIndex:5200; appliedIndex:5198; }","duration":"110.747251ms","start":"2026-06-03T21:58:15.632859Z","end":"2026-06-03T21:58:15.743606Z","steps":["trace[1339757149] 'read index received' (duration: 74.450532ms)","trace[1339757149] 'applied index is now lower than readState.Index' (duration: 36.295389ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:58:15.743813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.930245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T21:58:15.743869Z","caller":"traceutil/trace.go:171","msg":"trace[672985599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5010; }","duration":"111.022568ms","start":"2026-06-03T21:58:15.632821Z","end":"2026-06-03T21:58:15.743844Z","steps":["trace[672985599] 'agreement among raft nodes before linearized reading' (duration: 110.924435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:19.744159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.653394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-9jpjw-tls\" ","response":"range_response_count:1 size:2184"} {"level":"info","ts":"2026-06-03T21:58:19.74423Z","caller":"traceutil/trace.go:171","msg":"trace[530099995] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-9jpjw-tls; range_end:; response_count:1; response_revision:5183; }","duration":"361.775897ms","start":"2026-06-03T21:58:19.382438Z","end":"2026-06-03T21:58:19.744214Z","steps":["trace[530099995] 'range keys from in-memory index tree' (duration: 361.50564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:19.744259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:19.382413Z","time spent":"361.839317ms","remote":"127.0.0.1:60786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":2208,"request content":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-9jpjw-tls\" "} {"level":"warn","ts":"2026-06-03T21:58:19.744353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.184073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-06-03T21:58:19.744424Z","caller":"traceutil/trace.go:171","msg":"trace[1023546810] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5183; }","duration":"626.328867ms","start":"2026-06-03T21:58:19.118078Z","end":"2026-06-03T21:58:19.744407Z","steps":["trace[1023546810] 'range keys from in-memory index tree' (duration: 625.992088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:19.744454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:19.118046Z","time spent":"626.400748ms","remote":"127.0.0.1:55266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":1243,"request content":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-06-03T21:58:19.744449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.994032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-03T21:58:19.74445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.955868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-40031289-eafa-4478-bdb1-fb1a30b4055e\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-06-03T21:58:19.744507Z","caller":"traceutil/trace.go:171","msg":"trace[424715751] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5183; }","duration":"110.085864ms","start":"2026-06-03T21:58:19.634404Z","end":"2026-06-03T21:58:19.744489Z","steps":["trace[424715751] 'range keys from in-memory index tree' (duration: 109.91721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:19.744502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.229015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-06-03T21:58:19.744534Z","caller":"traceutil/trace.go:171","msg":"trace[1477939053] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-40031289-eafa-4478-bdb1-fb1a30b4055e; range_end:; response_count:1; response_revision:5183; }","duration":"504.093502ms","start":"2026-06-03T21:58:19.240418Z","end":"2026-06-03T21:58:19.744511Z","steps":["trace[1477939053] 'range keys from in-memory index tree' (duration: 503.789745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:19.744596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:19.240392Z","time spent":"504.194464ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3625,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-40031289-eafa-4478-bdb1-fb1a30b4055e\" "} {"level":"info","ts":"2026-06-03T21:58:19.744594Z","caller":"traceutil/trace.go:171","msg":"trace[938738287] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5183; }","duration":"425.365788ms","start":"2026-06-03T21:58:19.319207Z","end":"2026-06-03T21:58:19.744573Z","steps":["trace[938738287] 'range keys from in-memory index tree' (duration: 425.088112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:19.744637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:19.319188Z","time spent":"425.440609ms","remote":"127.0.0.1:55266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":918,"request content":"key:\"/registry/serviceaccounts/monitoring/vector\" "} {"level":"warn","ts":"2026-06-03T21:58:19.744758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.257407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787088"} {"level":"info","ts":"2026-06-03T21:58:19.744786Z","caller":"traceutil/trace.go:171","msg":"trace[359583934] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5183; }","duration":"647.347939ms","start":"2026-06-03T21:58:19.097429Z","end":"2026-06-03T21:58:19.744777Z","steps":["trace[359583934] 'range keys from in-memory index tree' (duration: 646.888209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:19.744807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:19.097383Z","time spent":"647.418511ms","remote":"127.0.0.1:55158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":25,"response size":787112,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"info","ts":"2026-06-03T21:58:20.390516Z","caller":"traceutil/trace.go:171","msg":"trace[778624207] transaction","detail":"{read_only:false; response_revision:5188; number_of_response:1; }","duration":"457.651471ms","start":"2026-06-03T21:58:19.932833Z","end":"2026-06-03T21:58:20.390484Z","steps":["trace[778624207] 'process raft request' (duration: 457.474427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:20.390714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:19.932821Z","time spent":"457.786364ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3706,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:58:20.396717Z","caller":"traceutil/trace.go:171","msg":"trace[821173546] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"354.989624ms","start":"2026-06-03T21:58:20.041654Z","end":"2026-06-03T21:58:20.396644Z","steps":["trace[821173546] 'process raft request' (duration: 354.865461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:20.396855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:20.041616Z","time spent":"355.176379ms","remote":"127.0.0.1:55242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17441,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:58:26.503369Z","caller":"traceutil/trace.go:171","msg":"trace[1003841992] linearizableReadLoop","detail":"{readStateIndex:5516; appliedIndex:5515; }","duration":"102.728078ms","start":"2026-06-03T21:58:26.400613Z","end":"2026-06-03T21:58:26.503341Z","steps":["trace[1003841992] 'read index received' (duration: 102.489483ms)","trace[1003841992] 'applied index is now lower than readState.Index' (duration: 234.305µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:58:26.503468Z","caller":"traceutil/trace.go:171","msg":"trace[628689741] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"123.491054ms","start":"2026-06-03T21:58:26.379941Z","end":"2026-06-03T21:58:26.503432Z","steps":["trace[628689741] 'process raft request' (duration: 123.236638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:26.503666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.032375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-6df54775b9-rdk2c\" ","response":"range_response_count:1 size:11848"} {"level":"info","ts":"2026-06-03T21:58:26.503747Z","caller":"traceutil/trace.go:171","msg":"trace[431410562] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-6df54775b9-rdk2c; range_end:; response_count:1; response_revision:5315; }","duration":"103.160188ms","start":"2026-06-03T21:58:26.400567Z","end":"2026-06-03T21:58:26.503727Z","steps":["trace[431410562] 'agreement among raft nodes before linearized reading' (duration: 102.915003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:26.675909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.325344ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T21:58:26.676152Z","caller":"traceutil/trace.go:171","msg":"trace[1407920795] transaction","detail":"{read_only:false; response_revision:5317; number_of_response:1; }","duration":"167.814885ms","start":"2026-06-03T21:58:26.508307Z","end":"2026-06-03T21:58:26.676122Z","steps":["trace[1407920795] 'process raft request' (duration: 61.172323ms)","trace[1407920795] 'compare' (duration: 105.380852ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:58:26.676245Z","caller":"traceutil/trace.go:171","msg":"trace[749471891] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"165.628393ms","start":"2026-06-03T21:58:26.510567Z","end":"2026-06-03T21:58:26.676195Z","steps":["trace[749471891] 'process raft request' (duration: 165.461589ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:26.676271Z","caller":"traceutil/trace.go:171","msg":"trace[512230874] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"165.451719ms","start":"2026-06-03T21:58:26.510792Z","end":"2026-06-03T21:58:26.676243Z","steps":["trace[512230874] 'process raft request' (duration: 165.336946ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:26.676307Z","caller":"traceutil/trace.go:171","msg":"trace[19403694] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"165.468079ms","start":"2026-06-03T21:58:26.51083Z","end":"2026-06-03T21:58:26.676299Z","steps":["trace[19403694] 'process raft request' (duration: 165.352366ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:26.676358Z","caller":"traceutil/trace.go:171","msg":"trace[1545874449] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"165.46117ms","start":"2026-06-03T21:58:26.510889Z","end":"2026-06-03T21:58:26.67635Z","steps":["trace[1545874449] 'process raft request' (duration: 165.328266ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:26.67664Z","caller":"traceutil/trace.go:171","msg":"trace[2021389858] transaction","detail":"{read_only:false; response_revision:5322; number_of_response:1; }","duration":"158.989234ms","start":"2026-06-03T21:58:26.517641Z","end":"2026-06-03T21:58:26.67663Z","steps":["trace[2021389858] 'process raft request' (duration: 158.643435ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:26.908442Z","caller":"traceutil/trace.go:171","msg":"trace[1910573194] transaction","detail":"{read_only:false; response_revision:5324; number_of_response:1; }","duration":"222.252688ms","start":"2026-06-03T21:58:26.68615Z","end":"2026-06-03T21:58:26.908403Z","steps":["trace[1910573194] 'process raft request' (duration: 215.426125ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:26.908576Z","caller":"traceutil/trace.go:171","msg":"trace[1794546861] transaction","detail":"{read_only:false; response_revision:5326; number_of_response:1; }","duration":"218.851537ms","start":"2026-06-03T21:58:26.689678Z","end":"2026-06-03T21:58:26.908529Z","steps":["trace[1794546861] 'process raft request' (duration: 218.689873ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:26.908728Z","caller":"traceutil/trace.go:171","msg":"trace[1362937650] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"220.012944ms","start":"2026-06-03T21:58:26.688658Z","end":"2026-06-03T21:58:26.908671Z","steps":["trace[1362937650] 'process raft request' (duration: 219.540433ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:27.594521Z","caller":"traceutil/trace.go:171","msg":"trace[1483500311] transaction","detail":"{read_only:false; response_revision:5356; number_of_response:1; }","duration":"181.511724ms","start":"2026-06-03T21:58:27.412975Z","end":"2026-06-03T21:58:27.594487Z","steps":["trace[1483500311] 'process raft request' (duration: 177.254632ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:27.594596Z","caller":"traceutil/trace.go:171","msg":"trace[431842862] linearizableReadLoop","detail":"{readStateIndex:5558; appliedIndex:5557; }","duration":"120.419881ms","start":"2026-06-03T21:58:27.474125Z","end":"2026-06-03T21:58:27.594545Z","steps":["trace[431842862] 'read index received' (duration: 116.130869ms)","trace[431842862] 'applied index is now lower than readState.Index' (duration: 4.286472ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:58:27.594756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.608346ms","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":"info","ts":"2026-06-03T21:58:27.594828Z","caller":"traceutil/trace.go:171","msg":"trace[302439555] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5356; }","duration":"120.732659ms","start":"2026-06-03T21:58:27.474079Z","end":"2026-06-03T21:58:27.594811Z","steps":["trace[302439555] 'agreement among raft nodes before linearized reading' (duration: 120.578195ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:33.389877Z","caller":"traceutil/trace.go:171","msg":"trace[966121297] linearizableReadLoop","detail":"{readStateIndex:5648; appliedIndex:5647; }","duration":"325.423856ms","start":"2026-06-03T21:58:33.064428Z","end":"2026-06-03T21:58:33.389852Z","steps":["trace[966121297] 'read index received' (duration: 325.300033ms)","trace[966121297] 'applied index is now lower than readState.Index' (duration: 122.513µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:58:33.38995Z","caller":"traceutil/trace.go:171","msg":"trace[629368249] transaction","detail":"{read_only:false; response_revision:5444; number_of_response:1; }","duration":"358.15113ms","start":"2026-06-03T21:58:33.031757Z","end":"2026-06-03T21:58:33.389908Z","steps":["trace[629368249] 'process raft request' (duration: 357.898184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:33.39011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.657452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-f8gc8\" ","response":"range_response_count:1 size:7818"} {"level":"warn","ts":"2026-06-03T21:58:33.390128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:33.031711Z","time spent":"358.321424ms","remote":"127.0.0.1:55110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":130698,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:58:33.39016Z","caller":"traceutil/trace.go:171","msg":"trace[1376181445] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-f8gc8; range_end:; response_count:1; response_revision:5444; }","duration":"325.775615ms","start":"2026-06-03T21:58:33.064371Z","end":"2026-06-03T21:58:33.390147Z","steps":["trace[1376181445] 'agreement among raft nodes before linearized reading' (duration: 325.57665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:33.390197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:33.06435Z","time spent":"325.838126ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":7842,"request content":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-f8gc8\" "} {"level":"info","ts":"2026-06-03T21:58:33.391262Z","caller":"traceutil/trace.go:171","msg":"trace[1503778529] transaction","detail":"{read_only:false; response_revision:5445; number_of_response:1; }","duration":"324.628756ms","start":"2026-06-03T21:58:33.066599Z","end":"2026-06-03T21:58:33.391228Z","steps":["trace[1503778529] 'process raft request' (duration: 324.39065ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:33.391496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:33.06658Z","time spent":"324.789831ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T21:58:37.28715Z","caller":"traceutil/trace.go:171","msg":"trace[254651634] transaction","detail":"{read_only:false; response_revision:5531; number_of_response:1; }","duration":"148.633526ms","start":"2026-06-03T21:58:37.138466Z","end":"2026-06-03T21:58:37.287099Z","steps":["trace[254651634] 'process raft request' (duration: 148.302408ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:42.001541Z","caller":"traceutil/trace.go:171","msg":"trace[592725705] transaction","detail":"{read_only:false; response_revision:5662; number_of_response:1; }","duration":"141.698112ms","start":"2026-06-03T21:58:41.859812Z","end":"2026-06-03T21:58:42.00151Z","steps":["trace[592725705] 'process raft request' (duration: 132.691256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:42.385672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.838993ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T21:58:42.385854Z","caller":"traceutil/trace.go:171","msg":"trace[613378566] linearizableReadLoop","detail":"{readStateIndex:5873; appliedIndex:5869; }","duration":"452.736913ms","start":"2026-06-03T21:58:41.933103Z","end":"2026-06-03T21:58:42.38584Z","steps":["trace[613378566] 'read index received' (duration: 59.367531ms)","trace[613378566] 'applied index is now lower than readState.Index' (duration: 393.368512ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:58:42.385937Z","caller":"traceutil/trace.go:171","msg":"trace[1248145047] transaction","detail":"{read_only:false; response_revision:5665; number_of_response:1; }","duration":"524.775227ms","start":"2026-06-03T21:58:41.861153Z","end":"2026-06-03T21:58:42.385928Z","steps":["trace[1248145047] 'process raft request' (duration: 524.656054ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:42.385945Z","caller":"traceutil/trace.go:171","msg":"trace[1510105787] transaction","detail":"{read_only:false; response_revision:5664; number_of_response:1; }","duration":"525.435712ms","start":"2026-06-03T21:58:41.860472Z","end":"2026-06-03T21:58:42.385908Z","steps":["trace[1510105787] 'process raft request' (duration: 525.290879ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:42.385974Z","caller":"traceutil/trace.go:171","msg":"trace[1057287097] transaction","detail":"{read_only:false; response_revision:5663; number_of_response:1; }","duration":"525.644378ms","start":"2026-06-03T21:58:41.860292Z","end":"2026-06-03T21:58:42.385937Z","steps":["trace[1057287097] 'process raft request' (duration: 266.458698ms)","trace[1057287097] 'compare' (duration: 258.380251ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:58:42.386118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:41.860449Z","time spent":"525.578496ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T21:58:42.386135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:41.860251Z","time spent":"525.796081ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T21:58:42.386152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.05584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a658457-d2a6-4c99-8b42-e926c0699a7e\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-03T21:58:42.386181Z","caller":"traceutil/trace.go:171","msg":"trace[266231621] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a658457-d2a6-4c99-8b42-e926c0699a7e; range_end:; response_count:1; response_revision:5665; }","duration":"453.114391ms","start":"2026-06-03T21:58:41.933056Z","end":"2026-06-03T21:58:42.38617Z","steps":["trace[266231621] 'agreement among raft nodes before linearized reading' (duration: 452.945017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:42.386201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:41.933043Z","time spent":"453.153652ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3670,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a658457-d2a6-4c99-8b42-e926c0699a7e\" "} {"level":"warn","ts":"2026-06-03T21:58:42.385982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:41.861148Z","time spent":"524.812147ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T21:58:42.386381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.172759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T21:58:42.386439Z","caller":"traceutil/trace.go:171","msg":"trace[1072814597] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:5665; }","duration":"129.253671ms","start":"2026-06-03T21:58:42.257159Z","end":"2026-06-03T21:58:42.386412Z","steps":["trace[1072814597] 'agreement among raft nodes before linearized reading' (duration: 129.176229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:42.386494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.599318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a658457-d2a6-4c99-8b42-e926c0699a7e\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-03T21:58:42.386522Z","caller":"traceutil/trace.go:171","msg":"trace[1487734513] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a658457-d2a6-4c99-8b42-e926c0699a7e; range_end:; response_count:1; response_revision:5665; }","duration":"187.65929ms","start":"2026-06-03T21:58:42.198855Z","end":"2026-06-03T21:58:42.386515Z","steps":["trace[1487734513] 'agreement among raft nodes before linearized reading' (duration: 187.588807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:42.387334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.491683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-phfth\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-03T21:58:42.387407Z","caller":"traceutil/trace.go:171","msg":"trace[682177289] range","detail":"{range_begin:/registry/pods/openstack/keepalived-phfth; range_end:; response_count:1; response_revision:5665; }","duration":"380.613656ms","start":"2026-06-03T21:58:42.006777Z","end":"2026-06-03T21:58:42.387391Z","steps":["trace[682177289] 'agreement among raft nodes before linearized reading' (duration: 379.305784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:42.387449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:42.006751Z","time spent":"380.686518ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-phfth\" "} {"level":"info","ts":"2026-06-03T21:58:42.848639Z","caller":"traceutil/trace.go:171","msg":"trace[398298786] linearizableReadLoop","detail":"{readStateIndex:5874; appliedIndex:5873; }","duration":"452.267442ms","start":"2026-06-03T21:58:42.396345Z","end":"2026-06-03T21:58:42.848612Z","steps":["trace[398298786] 'read index received' (duration: 452.024496ms)","trace[398298786] 'applied index is now lower than readState.Index' (duration: 241.156µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:58:42.848746Z","caller":"traceutil/trace.go:171","msg":"trace[540478760] transaction","detail":"{read_only:false; response_revision:5666; number_of_response:1; }","duration":"453.706926ms","start":"2026-06-03T21:58:42.394971Z","end":"2026-06-03T21:58:42.848678Z","steps":["trace[540478760] 'process raft request' (duration: 453.360548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:42.848965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:42.394958Z","time spent":"453.888861ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T21:58:42.849001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.635472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-958baa40-234e-44d6-ae4e-02cb82ffcf16\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-06-03T21:58:42.849086Z","caller":"traceutil/trace.go:171","msg":"trace[294914357] range","detail":"{range_begin:/registry/persistentvolumes/pvc-958baa40-234e-44d6-ae4e-02cb82ffcf16; range_end:; response_count:1; response_revision:5666; }","duration":"452.746594ms","start":"2026-06-03T21:58:42.396321Z","end":"2026-06-03T21:58:42.849067Z","steps":["trace[294914357] 'agreement among raft nodes before linearized reading' (duration: 452.516229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:42.84914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:42.396286Z","time spent":"452.839827ms","remote":"127.0.0.1:55206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1459,"request content":"key:\"/registry/persistentvolumes/pvc-958baa40-234e-44d6-ae4e-02cb82ffcf16\" "} {"level":"warn","ts":"2026-06-03T21:58:43.028926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.381857ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-03T21:58:43.029051Z","caller":"traceutil/trace.go:171","msg":"trace[1595284496] linearizableReadLoop","detail":"{readStateIndex:5875; appliedIndex:5874; }","duration":"180.245762ms","start":"2026-06-03T21:58:42.848785Z","end":"2026-06-03T21:58:43.029031Z","steps":["trace[1595284496] 'read index received' (duration: 65.680451ms)","trace[1595284496] 'applied index is now lower than readState.Index' (duration: 114.563761ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:58:43.029269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.154161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-03T21:58:43.02931Z","caller":"traceutil/trace.go:171","msg":"trace[955054798] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5666; }","duration":"422.252314ms","start":"2026-06-03T21:58:42.607046Z","end":"2026-06-03T21:58:43.029299Z","steps":["trace[955054798] 'agreement among raft nodes before linearized reading' (duration: 422.08508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:43.02935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:42.607006Z","time spent":"422.334576ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-03T21:58:43.029327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.258205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-03T21:58:43.029377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.440078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-03T21:58:43.029385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.828858ms","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-06-03T21:58:43.029449Z","caller":"traceutil/trace.go:171","msg":"trace[395225576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5666; }","duration":"262.414138ms","start":"2026-06-03T21:58:42.767006Z","end":"2026-06-03T21:58:43.029421Z","steps":["trace[395225576] 'agreement among raft nodes before linearized reading' (duration: 262.081651ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:43.029487Z","caller":"traceutil/trace.go:171","msg":"trace[166809657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5666; }","duration":"277.54464ms","start":"2026-06-03T21:58:42.751909Z","end":"2026-06-03T21:58:43.029454Z","steps":["trace[166809657] 'agreement among raft nodes before linearized reading' (duration: 277.318885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:43.029326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.171988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-03T21:58:43.029487Z","caller":"traceutil/trace.go:171","msg":"trace[1271528744] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5666; }","duration":"337.000163ms","start":"2026-06-03T21:58:42.692469Z","end":"2026-06-03T21:58:43.02947Z","steps":["trace[1271528744] 'agreement among raft nodes before linearized reading' (duration: 336.669445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:43.029607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.550874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13875"} {"level":"warn","ts":"2026-06-03T21:58:43.029643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.24119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-03T21:58:43.029622Z","caller":"traceutil/trace.go:171","msg":"trace[343614815] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5666; }","duration":"276.514846ms","start":"2026-06-03T21:58:42.753063Z","end":"2026-06-03T21:58:43.029578Z","steps":["trace[343614815] 'agreement among raft nodes before linearized reading' (duration: 276.105016ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:43.029704Z","caller":"traceutil/trace.go:171","msg":"trace[1290512765] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5666; }","duration":"176.694328ms","start":"2026-06-03T21:58:42.852987Z","end":"2026-06-03T21:58:43.029681Z","steps":["trace[1290512765] 'agreement among raft nodes before linearized reading' (duration: 176.38315ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:43.029713Z","caller":"traceutil/trace.go:171","msg":"trace[44145697] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5666; }","duration":"261.367813ms","start":"2026-06-03T21:58:42.76833Z","end":"2026-06-03T21:58:43.029698Z","steps":["trace[44145697] 'agreement among raft nodes before linearized reading' (duration: 261.075626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T21:58:43.029744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T21:58:42.692445Z","time spent":"337.240059ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-03T21:58:43.16762Z","caller":"traceutil/trace.go:171","msg":"trace[357011711] transaction","detail":"{read_only:false; response_revision:5669; number_of_response:1; }","duration":"133.250867ms","start":"2026-06-03T21:58:43.034347Z","end":"2026-06-03T21:58:43.167598Z","steps":["trace[357011711] 'process raft request' (duration: 133.166815ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:43.167653Z","caller":"traceutil/trace.go:171","msg":"trace[921900132] transaction","detail":"{read_only:false; response_revision:5668; number_of_response:1; }","duration":"133.633087ms","start":"2026-06-03T21:58:43.033982Z","end":"2026-06-03T21:58:43.167615Z","steps":["trace[921900132] 'process raft request' (duration: 130.087832ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:43.168004Z","caller":"traceutil/trace.go:171","msg":"trace[1962947380] transaction","detail":"{read_only:false; response_revision:5670; number_of_response:1; }","duration":"133.279158ms","start":"2026-06-03T21:58:43.034714Z","end":"2026-06-03T21:58:43.167993Z","steps":["trace[1962947380] 'process raft request' (duration: 132.845658ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:43.168291Z","caller":"traceutil/trace.go:171","msg":"trace[1408883729] transaction","detail":"{read_only:false; response_revision:5673; number_of_response:1; }","duration":"127.127142ms","start":"2026-06-03T21:58:43.041154Z","end":"2026-06-03T21:58:43.168281Z","steps":["trace[1408883729] 'process raft request' (duration: 126.798104ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:43.168463Z","caller":"traceutil/trace.go:171","msg":"trace[1557826034] transaction","detail":"{read_only:false; response_revision:5672; number_of_response:1; }","duration":"133.098005ms","start":"2026-06-03T21:58:43.035339Z","end":"2026-06-03T21:58:43.168437Z","steps":["trace[1557826034] 'process raft request' (duration: 132.561931ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:43.168462Z","caller":"traceutil/trace.go:171","msg":"trace[1435435957] transaction","detail":"{read_only:false; response_revision:5671; number_of_response:1; }","duration":"133.667699ms","start":"2026-06-03T21:58:43.034754Z","end":"2026-06-03T21:58:43.168421Z","steps":["trace[1435435957] 'process raft request' (duration: 133.092704ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:48.08356Z","caller":"traceutil/trace.go:171","msg":"trace[1748040517] transaction","detail":"{read_only:false; response_revision:5722; number_of_response:1; }","duration":"131.817104ms","start":"2026-06-03T21:58:47.951721Z","end":"2026-06-03T21:58:48.083538Z","steps":["trace[1748040517] 'process raft request' (duration: 131.62375ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:53.483024Z","caller":"traceutil/trace.go:171","msg":"trace[175112199] transaction","detail":"{read_only:false; response_revision:5766; number_of_response:1; }","duration":"197.65531ms","start":"2026-06-03T21:58:53.285337Z","end":"2026-06-03T21:58:53.482992Z","steps":["trace[175112199] 'process raft request' (duration: 148.717499ms)","trace[175112199] 'compare' (duration: 48.745006ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T21:58:53.483396Z","caller":"traceutil/trace.go:171","msg":"trace[725621673] transaction","detail":"{read_only:false; response_revision:5767; number_of_response:1; }","duration":"196.726977ms","start":"2026-06-03T21:58:53.286633Z","end":"2026-06-03T21:58:53.48336Z","steps":["trace[725621673] 'process raft request' (duration: 196.316047ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:53.483628Z","caller":"traceutil/trace.go:171","msg":"trace[106869960] transaction","detail":"{read_only:false; response_revision:5768; number_of_response:1; }","duration":"196.940362ms","start":"2026-06-03T21:58:53.286679Z","end":"2026-06-03T21:58:53.483619Z","steps":["trace[106869960] 'process raft request' (duration: 196.730377ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:58:53.483664Z","caller":"traceutil/trace.go:171","msg":"trace[322113560] linearizableReadLoop","detail":"{readStateIndex:5979; appliedIndex:5976; }","duration":"110.642787ms","start":"2026-06-03T21:58:53.372995Z","end":"2026-06-03T21:58:53.483638Z","steps":["trace[322113560] 'read index received' (duration: 61.090291ms)","trace[322113560] 'applied index is now lower than readState.Index' (duration: 49.550996ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T21:58:53.483925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.908764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-03T21:58:53.483973Z","caller":"traceutil/trace.go:171","msg":"trace[687697485] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5768; }","duration":"111.040367ms","start":"2026-06-03T21:58:53.372922Z","end":"2026-06-03T21:58:53.483962Z","steps":["trace[687697485] 'agreement among raft nodes before linearized reading' (duration: 110.842042ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T21:59:14.159621Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2958} {"level":"info","ts":"2026-06-03T21:59:14.23514Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2958,"took":"73.915771ms","hash":412796005,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":32501760,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-03T21:59:14.235229Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":412796005,"revision":2958,"compact-revision":-1} {"level":"info","ts":"2026-06-03T22:02:05.083495Z","caller":"traceutil/trace.go:171","msg":"trace[412734632] transaction","detail":"{read_only:false; response_revision:7057; number_of_response:1; }","duration":"167.569ms","start":"2026-06-03T22:02:04.915896Z","end":"2026-06-03T22:02:05.083465Z","steps":["trace[412734632] 'process raft request' (duration: 167.303693ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:02:06.278681Z","caller":"traceutil/trace.go:171","msg":"trace[1850254040] transaction","detail":"{read_only:false; response_revision:7062; number_of_response:1; }","duration":"182.379783ms","start":"2026-06-03T22:02:06.096279Z","end":"2026-06-03T22:02:06.278659Z","steps":["trace[1850254040] 'process raft request' (duration: 181.955193ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:02:11.317492Z","caller":"traceutil/trace.go:171","msg":"trace[2048223392] transaction","detail":"{read_only:false; response_revision:7122; number_of_response:1; }","duration":"101.855161ms","start":"2026-06-03T22:02:11.215616Z","end":"2026-06-03T22:02:11.317471Z","steps":["trace[2048223392] 'process raft request' (duration: 101.530343ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:02:11.317723Z","caller":"traceutil/trace.go:171","msg":"trace[2003186190] transaction","detail":"{read_only:false; response_revision:7123; number_of_response:1; }","duration":"102.055905ms","start":"2026-06-03T22:02:11.215628Z","end":"2026-06-03T22:02:11.317683Z","steps":["trace[2003186190] 'process raft request' (duration: 101.812049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:02:11.657039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.195007ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T22:02:11.657156Z","caller":"traceutil/trace.go:171","msg":"trace[1090222543] linearizableReadLoop","detail":"{readStateIndex:7382; appliedIndex:7381; }","duration":"333.251083ms","start":"2026-06-03T22:02:11.323888Z","end":"2026-06-03T22:02:11.657139Z","steps":["trace[1090222543] 'read index received' (duration: 92.859631ms)","trace[1090222543] 'applied index is now lower than readState.Index' (duration: 240.390012ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T22:02:11.657302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.409297ms","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-06-03T22:02:11.657272Z","caller":"traceutil/trace.go:171","msg":"trace[1938116495] transaction","detail":"{read_only:false; response_revision:7124; number_of_response:1; }","duration":"441.091317ms","start":"2026-06-03T22:02:11.216129Z","end":"2026-06-03T22:02:11.65722Z","steps":["trace[1938116495] 'process raft request' (duration: 200.605163ms)","trace[1938116495] 'compare' (duration: 240.003712ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:02:11.657345Z","caller":"traceutil/trace.go:171","msg":"trace[438185921] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7124; }","duration":"333.505549ms","start":"2026-06-03T22:02:11.323828Z","end":"2026-06-03T22:02:11.657334Z","steps":["trace[438185921] 'agreement among raft nodes before linearized reading' (duration: 333.395736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:02:11.657381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:02:11.323803Z","time spent":"333.569491ms","remote":"127.0.0.1:50492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-03T22:02:11.657505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:02:11.216112Z","time spent":"441.266601ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T22:02:11.657558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.755007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T22:02:11.657638Z","caller":"traceutil/trace.go:171","msg":"trace[1657853482] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:7124; }","duration":"326.840899ms","start":"2026-06-03T22:02:11.330778Z","end":"2026-06-03T22:02:11.657619Z","steps":["trace[1657853482] 'agreement among raft nodes before linearized reading' (duration: 326.699465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:02:11.6577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:02:11.330722Z","time spent":"326.958302ms","remote":"127.0.0.1:50378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true "} {"level":"info","ts":"2026-06-03T22:04:14.166788Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5895} {"level":"info","ts":"2026-06-03T22:04:14.264955Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5895,"took":"96.294026ms","hash":718756547,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":25956352,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-03T22:04:14.265038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":718756547,"revision":5895,"compact-revision":2958} {"level":"info","ts":"2026-06-03T22:04:59.707Z","caller":"traceutil/trace.go:171","msg":"trace[1443842281] transaction","detail":"{read_only:false; response_revision:8361; number_of_response:1; }","duration":"135.986861ms","start":"2026-06-03T22:04:59.570973Z","end":"2026-06-03T22:04:59.706959Z","steps":["trace[1443842281] 'process raft request' (duration: 135.691684ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:04:59.707074Z","caller":"traceutil/trace.go:171","msg":"trace[1836578484] transaction","detail":"{read_only:false; response_revision:8360; number_of_response:1; }","duration":"136.455172ms","start":"2026-06-03T22:04:59.570552Z","end":"2026-06-03T22:04:59.707007Z","steps":["trace[1836578484] 'process raft request' (duration: 117.527332ms)","trace[1836578484] 'compare' (duration: 18.402347ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:05:07.03997Z","caller":"traceutil/trace.go:171","msg":"trace[299720297] transaction","detail":"{read_only:false; response_revision:8526; number_of_response:1; }","duration":"688.258656ms","start":"2026-06-03T22:05:06.351679Z","end":"2026-06-03T22:05:07.039937Z","steps":["trace[299720297] 'process raft request' (duration: 688.00786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:07.040233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:06.351647Z","time spent":"688.42382ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:05:07.171667Z","caller":"traceutil/trace.go:171","msg":"trace[469854072] linearizableReadLoop","detail":"{readStateIndex:8829; appliedIndex:8827; }","duration":"538.328967ms","start":"2026-06-03T22:05:06.633311Z","end":"2026-06-03T22:05:07.17164Z","steps":["trace[469854072] 'read index received' (duration: 406.539278ms)","trace[469854072] 'applied index is now lower than readState.Index' (duration: 131.788589ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:05:07.171747Z","caller":"traceutil/trace.go:171","msg":"trace[2062113165] transaction","detail":"{read_only:false; response_revision:8527; number_of_response:1; }","duration":"782.581936ms","start":"2026-06-03T22:05:06.38912Z","end":"2026-06-03T22:05:07.171702Z","steps":["trace[2062113165] 'process raft request' (duration: 782.270909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:07.171873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.538112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-03T22:05:07.171945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.926306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-phfth\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-06-03T22:05:07.171966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:06.389084Z","time spent":"782.765581ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:05:07.171981Z","caller":"traceutil/trace.go:171","msg":"trace[817529888] range","detail":"{range_begin:/registry/pods/openstack/keepalived-phfth; range_end:; response_count:1; response_revision:8527; }","duration":"360.066509ms","start":"2026-06-03T22:05:06.811906Z","end":"2026-06-03T22:05:07.171972Z","steps":["trace[817529888] 'agreement among raft nodes before linearized reading' (duration: 359.879745ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:07.171977Z","caller":"traceutil/trace.go:171","msg":"trace[234665785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8527; }","duration":"538.715126ms","start":"2026-06-03T22:05:06.63324Z","end":"2026-06-03T22:05:07.171955Z","steps":["trace[234665785] 'agreement among raft nodes before linearized reading' (duration: 538.536962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:07.172018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:06.811875Z","time spent":"360.137281ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-phfth\" "} {"level":"warn","ts":"2026-06-03T22:05:07.172024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:06.633201Z","time spent":"538.815018ms","remote":"127.0.0.1:55034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-03T22:05:19.107028Z","caller":"traceutil/trace.go:171","msg":"trace[345251301] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"250.704056ms","start":"2026-06-03T22:05:18.856289Z","end":"2026-06-03T22:05:19.106994Z","steps":["trace[345251301] 'process raft request' (duration: 250.287246ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:19.450398Z","caller":"traceutil/trace.go:171","msg":"trace[2105466398] linearizableReadLoop","detail":"{readStateIndex:8896; appliedIndex:8894; }","duration":"193.772403ms","start":"2026-06-03T22:05:19.256589Z","end":"2026-06-03T22:05:19.450361Z","steps":["trace[2105466398] 'read index received' (duration: 174.796433ms)","trace[2105466398] 'applied index is now lower than readState.Index' (duration: 18.97455ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:05:19.450765Z","caller":"traceutil/trace.go:171","msg":"trace[240901154] transaction","detail":"{read_only:false; response_revision:8590; number_of_response:1; }","duration":"582.754627ms","start":"2026-06-03T22:05:18.867971Z","end":"2026-06-03T22:05:19.450725Z","steps":["trace[240901154] 'process raft request' (duration: 563.473198ms)","trace[240901154] 'compare' (duration: 18.191592ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T22:05:19.450806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.203045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-phfth\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-03T22:05:19.450853Z","caller":"traceutil/trace.go:171","msg":"trace[1734324088] transaction","detail":"{read_only:false; response_revision:8591; number_of_response:1; }","duration":"369.610312ms","start":"2026-06-03T22:05:19.081175Z","end":"2026-06-03T22:05:19.450785Z","steps":["trace[1734324088] 'process raft request' (duration: 369.055078ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:19.450914Z","caller":"traceutil/trace.go:171","msg":"trace[781913771] range","detail":"{range_begin:/registry/pods/openstack/keepalived-phfth; range_end:; response_count:1; response_revision:8591; }","duration":"194.360779ms","start":"2026-06-03T22:05:19.256529Z","end":"2026-06-03T22:05:19.45089Z","steps":["trace[781913771] 'agreement among raft nodes before linearized reading' (duration: 194.097451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:19.450959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:18.867932Z","time spent":"582.90286ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T22:05:19.451294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:19.08114Z","time spent":"369.832248ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:05:20.288528Z","caller":"traceutil/trace.go:171","msg":"trace[75070257] linearizableReadLoop","detail":"{readStateIndex:8905; appliedIndex:8903; }","duration":"191.687764ms","start":"2026-06-03T22:05:20.096811Z","end":"2026-06-03T22:05:20.288499Z","steps":["trace[75070257] 'read index received' (duration: 63.307137ms)","trace[75070257] 'applied index is now lower than readState.Index' (duration: 128.379317ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:05:20.288615Z","caller":"traceutil/trace.go:171","msg":"trace[1107660380] transaction","detail":"{read_only:false; response_revision:8600; number_of_response:1; }","duration":"194.513552ms","start":"2026-06-03T22:05:20.094055Z","end":"2026-06-03T22:05:20.288568Z","steps":["trace[1107660380] 'process raft request' (duration: 194.266016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:20.288834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.003171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-03T22:05:20.288891Z","caller":"traceutil/trace.go:171","msg":"trace[449564319] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:8600; }","duration":"192.081122ms","start":"2026-06-03T22:05:20.096791Z","end":"2026-06-03T22:05:20.288872Z","steps":["trace[449564319] 'agreement among raft nodes before linearized reading' (duration: 191.826706ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:21.612415Z","caller":"traceutil/trace.go:171","msg":"trace[13792518] linearizableReadLoop","detail":"{readStateIndex:8906; appliedIndex:8905; }","duration":"149.016007ms","start":"2026-06-03T22:05:21.463368Z","end":"2026-06-03T22:05:21.612384Z","steps":["trace[13792518] 'read index received' (duration: 148.800102ms)","trace[13792518] 'applied index is now lower than readState.Index' (duration: 214.345µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:05:21.61252Z","caller":"traceutil/trace.go:171","msg":"trace[536657502] transaction","detail":"{read_only:false; response_revision:8601; number_of_response:1; }","duration":"154.698715ms","start":"2026-06-03T22:05:21.45778Z","end":"2026-06-03T22:05:21.612479Z","steps":["trace[536657502] 'process raft request' (duration: 154.399928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:21.613691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.271667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-phfth\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-03T22:05:21.613793Z","caller":"traceutil/trace.go:171","msg":"trace[458347060] range","detail":"{range_begin:/registry/pods/openstack/keepalived-phfth; range_end:; response_count:1; response_revision:8601; }","duration":"150.472633ms","start":"2026-06-03T22:05:21.463302Z","end":"2026-06-03T22:05:21.613775Z","steps":["trace[458347060] 'agreement among raft nodes before linearized reading' (duration: 149.237222ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:21.867521Z","caller":"traceutil/trace.go:171","msg":"trace[793968532] linearizableReadLoop","detail":"{readStateIndex:8907; appliedIndex:8906; }","duration":"249.092706ms","start":"2026-06-03T22:05:21.61839Z","end":"2026-06-03T22:05:21.867482Z","steps":["trace[793968532] 'read index received' (duration: 242.66179ms)","trace[793968532] 'applied index is now lower than readState.Index' (duration: 6.428106ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T22:05:21.867935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.84248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-03T22:05:21.867997Z","caller":"traceutil/trace.go:171","msg":"trace[50830721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8602; }","duration":"234.945012ms","start":"2026-06-03T22:05:21.63304Z","end":"2026-06-03T22:05:21.867985Z","steps":["trace[50830721] 'agreement among raft nodes before linearized reading' (duration: 234.705836ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:21.867538Z","caller":"traceutil/trace.go:171","msg":"trace[1535242198] transaction","detail":"{read_only:false; response_revision:8602; number_of_response:1; }","duration":"250.139572ms","start":"2026-06-03T22:05:21.617364Z","end":"2026-06-03T22:05:21.867503Z","steps":["trace[1535242198] 'process raft request' (duration: 243.642494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:21.868299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.133725ms","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-06-03T22:05:21.86835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.928898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:224142"} {"level":"info","ts":"2026-06-03T22:05:21.868381Z","caller":"traceutil/trace.go:171","msg":"trace[2114839025] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8602; }","duration":"183.279289ms","start":"2026-06-03T22:05:21.68508Z","end":"2026-06-03T22:05:21.868359Z","steps":["trace[2114839025] 'agreement among raft nodes before linearized reading' (duration: 183.094594ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:21.868417Z","caller":"traceutil/trace.go:171","msg":"trace[477350690] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8602; }","duration":"250.03488ms","start":"2026-06-03T22:05:21.618363Z","end":"2026-06-03T22:05:21.868398Z","steps":["trace[477350690] 'agreement among raft nodes before linearized reading' (duration: 249.358743ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:22.320748Z","caller":"traceutil/trace.go:171","msg":"trace[1665979866] transaction","detail":"{read_only:false; response_revision:8604; number_of_response:1; }","duration":"447.182431ms","start":"2026-06-03T22:05:21.873535Z","end":"2026-06-03T22:05:22.320718Z","steps":["trace[1665979866] 'process raft request' (duration: 446.891354ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:22.320903Z","caller":"traceutil/trace.go:171","msg":"trace[36272582] transaction","detail":"{read_only:false; response_revision:8606; number_of_response:1; }","duration":"447.212342ms","start":"2026-06-03T22:05:21.873673Z","end":"2026-06-03T22:05:22.320885Z","steps":["trace[36272582] 'process raft request' (duration: 447.155551ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:22.320934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:21.873494Z","time spent":"447.340955ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T22:05:22.321001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:21.873654Z","time spent":"447.295454ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:05:22.320984Z","caller":"traceutil/trace.go:171","msg":"trace[2110021133] transaction","detail":"{read_only:false; response_revision:8605; number_of_response:1; }","duration":"447.262504ms","start":"2026-06-03T22:05:21.873674Z","end":"2026-06-03T22:05:22.320937Z","steps":["trace[2110021133] 'process raft request' (duration: 446.980647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:22.3212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:21.87366Z","time spent":"447.419317ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:05:22.336895Z","caller":"traceutil/trace.go:171","msg":"trace[2001061521] transaction","detail":"{read_only:false; response_revision:8607; number_of_response:1; }","duration":"383.562116ms","start":"2026-06-03T22:05:21.953289Z","end":"2026-06-03T22:05:22.336851Z","steps":["trace[2001061521] 'process raft request' (duration: 383.32014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:22.337118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:21.953269Z","time spent":"383.727639ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:05:22.337268Z","caller":"traceutil/trace.go:171","msg":"trace[1350341042] linearizableReadLoop","detail":"{readStateIndex:8912; appliedIndex:8908; }","duration":"213.969308ms","start":"2026-06-03T22:05:22.123266Z","end":"2026-06-03T22:05:22.337236Z","steps":["trace[1350341042] 'read index received' (duration: 197.035738ms)","trace[1350341042] 'applied index is now lower than readState.Index' (duration: 16.9323ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:05:22.337329Z","caller":"traceutil/trace.go:171","msg":"trace[1082256816] transaction","detail":"{read_only:false; response_revision:8608; number_of_response:1; }","duration":"172.25337ms","start":"2026-06-03T22:05:22.165049Z","end":"2026-06-03T22:05:22.337302Z","steps":["trace[1082256816] 'process raft request' (duration: 171.754698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:22.33757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.195586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T22:05:22.337611Z","caller":"traceutil/trace.go:171","msg":"trace[415858317] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8609; }","duration":"174.277928ms","start":"2026-06-03T22:05:22.163319Z","end":"2026-06-03T22:05:22.337597Z","steps":["trace[415858317] 'agreement among raft nodes before linearized reading' (duration: 174.182986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:22.337662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.400929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-03T22:05:22.337711Z","caller":"traceutil/trace.go:171","msg":"trace[518717140] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:8609; }","duration":"214.501142ms","start":"2026-06-03T22:05:22.123194Z","end":"2026-06-03T22:05:22.337695Z","steps":["trace[518717140] 'agreement among raft nodes before linearized reading' (duration: 214.318638ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:54.41264Z","caller":"traceutil/trace.go:171","msg":"trace[1045007915] linearizableReadLoop","detail":"{readStateIndex:9142; appliedIndex:9141; }","duration":"353.546847ms","start":"2026-06-03T22:05:54.05905Z","end":"2026-06-03T22:05:54.412597Z","steps":["trace[1045007915] 'read index received' (duration: 353.400814ms)","trace[1045007915] 'applied index is now lower than readState.Index' (duration: 144.023µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:05:54.412791Z","caller":"traceutil/trace.go:171","msg":"trace[1879652846] transaction","detail":"{read_only:false; response_revision:8827; number_of_response:1; }","duration":"356.283373ms","start":"2026-06-03T22:05:54.056451Z","end":"2026-06-03T22:05:54.412734Z","steps":["trace[1879652846] 'process raft request' (duration: 355.885913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:54.413076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:54.056416Z","time spent":"356.515768ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T22:05:54.413117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.018439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-03T22:05:54.413082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.382265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-phfth\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-03T22:05:54.413238Z","caller":"traceutil/trace.go:171","msg":"trace[23507564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8827; }","duration":"354.175182ms","start":"2026-06-03T22:05:54.059036Z","end":"2026-06-03T22:05:54.413211Z","steps":["trace[23507564] 'agreement among raft nodes before linearized reading' (duration: 353.800763ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:54.413317Z","caller":"traceutil/trace.go:171","msg":"trace[353771676] range","detail":"{range_begin:/registry/pods/openstack/keepalived-phfth; range_end:; response_count:1; response_revision:8827; }","duration":"332.651051ms","start":"2026-06-03T22:05:54.080641Z","end":"2026-06-03T22:05:54.413292Z","steps":["trace[353771676] 'agreement among raft nodes before linearized reading' (duration: 332.229761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:54.413349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:54.05903Z","time spent":"354.307565ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-03T22:05:54.413382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:54.080633Z","time spent":"332.734733ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6548,"request content":"key:\"/registry/pods/openstack/keepalived-phfth\" "} {"level":"warn","ts":"2026-06-03T22:05:54.769994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.00197ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T22:05:54.770545Z","caller":"traceutil/trace.go:171","msg":"trace[1491552419] transaction","detail":"{read_only:false; response_revision:8828; number_of_response:1; }","duration":"352.00695ms","start":"2026-06-03T22:05:54.418462Z","end":"2026-06-03T22:05:54.770469Z","steps":["trace[1491552419] 'process raft request' (duration: 108.414725ms)","trace[1491552419] 'compare' (duration: 242.870777ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:05:54.770704Z","caller":"traceutil/trace.go:171","msg":"trace[1479732249] linearizableReadLoop","detail":"{readStateIndex:9143; appliedIndex:9142; }","duration":"351.976369ms","start":"2026-06-03T22:05:54.41849Z","end":"2026-06-03T22:05:54.770466Z","steps":["trace[1479732249] 'read index received' (duration: 108.457505ms)","trace[1479732249] 'applied index is now lower than readState.Index' (duration: 243.515914ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T22:05:54.770771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:54.418438Z","time spent":"352.212115ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T22:05:54.771369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.84278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228870"} {"level":"info","ts":"2026-06-03T22:05:54.771501Z","caller":"traceutil/trace.go:171","msg":"trace[1486740387] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8828; }","duration":"353.014904ms","start":"2026-06-03T22:05:54.418459Z","end":"2026-06-03T22:05:54.771474Z","steps":["trace[1486740387] 'agreement among raft nodes before linearized reading' (duration: 352.281057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:54.771574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:54.418433Z","time spent":"353.122696ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":26,"response size":228894,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-06-03T22:05:54.780438Z","caller":"traceutil/trace.go:171","msg":"trace[1033007180] transaction","detail":"{read_only:false; response_revision:8829; number_of_response:1; }","duration":"321.218855ms","start":"2026-06-03T22:05:54.459207Z","end":"2026-06-03T22:05:54.780426Z","steps":["trace[1033007180] 'process raft request' (duration: 321.075571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:54.780541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:54.45919Z","time spent":"321.284986ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:05:54.780822Z","caller":"traceutil/trace.go:171","msg":"trace[2060579270] transaction","detail":"{read_only:false; response_revision:8830; number_of_response:1; }","duration":"321.572563ms","start":"2026-06-03T22:05:54.459208Z","end":"2026-06-03T22:05:54.78078Z","steps":["trace[2060579270] 'process raft request' (duration: 321.186444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:54.781024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:54.459191Z","time spent":"321.713966ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T22:05:54.781352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.51476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T22:05:54.781364Z","caller":"traceutil/trace.go:171","msg":"trace[1031025208] transaction","detail":"{read_only:false; response_revision:8831; number_of_response:1; }","duration":"321.435948ms","start":"2026-06-03T22:05:54.459897Z","end":"2026-06-03T22:05:54.781333Z","steps":["trace[1031025208] 'process raft request' (duration: 320.766142ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:05:54.781402Z","caller":"traceutil/trace.go:171","msg":"trace[1899987672] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8831; }","duration":"147.614702ms","start":"2026-06-03T22:05:54.633776Z","end":"2026-06-03T22:05:54.781391Z","steps":["trace[1899987672] 'agreement among raft nodes before linearized reading' (duration: 147.53668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:54.781404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.413982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-03T22:05:54.781449Z","caller":"traceutil/trace.go:171","msg":"trace[1286647009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8831; }","duration":"310.486164ms","start":"2026-06-03T22:05:54.470952Z","end":"2026-06-03T22:05:54.781439Z","steps":["trace[1286647009] 'agreement among raft nodes before linearized reading' (duration: 310.353011ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:54.781486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:54.470943Z","time spent":"310.536285ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-03T22:05:54.781475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:54.459865Z","time spent":"321.556862ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T22:05:54.781671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.463154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-03T22:05:54.7817Z","caller":"traceutil/trace.go:171","msg":"trace[367911245] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8831; }","duration":"298.515025ms","start":"2026-06-03T22:05:54.483178Z","end":"2026-06-03T22:05:54.781693Z","steps":["trace[367911245] 'agreement among raft nodes before linearized reading' (duration: 298.396771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:54.78226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.806409ms","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-06-03T22:05:54.782325Z","caller":"traceutil/trace.go:171","msg":"trace[1844592345] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8831; }","duration":"309.905721ms","start":"2026-06-03T22:05:54.472402Z","end":"2026-06-03T22:05:54.782308Z","steps":["trace[1844592345] 'agreement among raft nodes before linearized reading' (duration: 309.175262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:05:54.782377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:05:54.472395Z","time spent":"309.968942ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-03T22:06:00.524244Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023fa.wal"} {"level":"info","ts":"2026-06-03T22:06:02.511104Z","caller":"traceutil/trace.go:171","msg":"trace[1330866728] transaction","detail":"{read_only:false; response_revision:8913; number_of_response:1; }","duration":"128.09717ms","start":"2026-06-03T22:06:02.382957Z","end":"2026-06-03T22:06:02.511055Z","steps":["trace[1330866728] 'process raft request' (duration: 127.439613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:06:02.79963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.471406ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-03T22:06:02.799856Z","caller":"traceutil/trace.go:171","msg":"trace[1659383354] linearizableReadLoop","detail":"{readStateIndex:9235; appliedIndex:9233; }","duration":"281.603517ms","start":"2026-06-03T22:06:02.518232Z","end":"2026-06-03T22:06:02.799836Z","steps":["trace[1659383354] 'read index received' (duration: 46.781673ms)","trace[1659383354] 'applied index is now lower than readState.Index' (duration: 234.820694ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T22:06:02.800036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.811631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-h99hp\" ","response":"range_response_count:1 size:4650"} {"level":"info","ts":"2026-06-03T22:06:02.800043Z","caller":"traceutil/trace.go:171","msg":"trace[1401762412] transaction","detail":"{read_only:false; response_revision:8915; number_of_response:1; }","duration":"283.846481ms","start":"2026-06-03T22:06:02.516151Z","end":"2026-06-03T22:06:02.799998Z","steps":["trace[1401762412] 'process raft request' (duration: 283.607445ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:06:02.800077Z","caller":"traceutil/trace.go:171","msg":"trace[1719447592] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-h99hp; range_end:; response_count:1; response_revision:8915; }","duration":"281.899723ms","start":"2026-06-03T22:06:02.518163Z","end":"2026-06-03T22:06:02.800063Z","steps":["trace[1719447592] 'agreement among raft nodes before linearized reading' (duration: 281.732899ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:06:02.800052Z","caller":"traceutil/trace.go:171","msg":"trace[350989519] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8914; }","duration":"284.560718ms","start":"2026-06-03T22:06:02.515448Z","end":"2026-06-03T22:06:02.800008Z","steps":["trace[350989519] 'process raft request' (duration: 49.529249ms)","trace[350989519] 'compare' (duration: 234.23567ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:06:02.964598Z","caller":"traceutil/trace.go:171","msg":"trace[850233812] linearizableReadLoop","detail":"{readStateIndex:9236; appliedIndex:9235; }","duration":"160.453184ms","start":"2026-06-03T22:06:02.804103Z","end":"2026-06-03T22:06:02.964556Z","steps":["trace[850233812] 'read index received' (duration: 127.528527ms)","trace[850233812] 'applied index is now lower than readState.Index' (duration: 32.921006ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:06:02.964668Z","caller":"traceutil/trace.go:171","msg":"trace[1287892593] transaction","detail":"{read_only:false; response_revision:8916; number_of_response:1; }","duration":"157.838031ms","start":"2026-06-03T22:06:02.806772Z","end":"2026-06-03T22:06:02.96461Z","steps":["trace[1287892593] 'process raft request' (duration: 157.591214ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:06:02.964666Z","caller":"traceutil/trace.go:171","msg":"trace[503808054] transaction","detail":"{read_only:false; response_revision:8917; number_of_response:1; }","duration":"152.958652ms","start":"2026-06-03T22:06:02.811671Z","end":"2026-06-03T22:06:02.964629Z","steps":["trace[503808054] 'process raft request' (duration: 152.8478ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:06:02.965009Z","caller":"traceutil/trace.go:171","msg":"trace[1945234418] transaction","detail":"{read_only:false; response_revision:8918; number_of_response:1; }","duration":"148.73873ms","start":"2026-06-03T22:06:02.816256Z","end":"2026-06-03T22:06:02.964994Z","steps":["trace[1945234418] 'process raft request' (duration: 148.3201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:06:02.964989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.872755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-03T22:06:02.965157Z","caller":"traceutil/trace.go:171","msg":"trace[1541491314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8918; }","duration":"147.07482ms","start":"2026-06-03T22:06:02.818056Z","end":"2026-06-03T22:06:02.965131Z","steps":["trace[1541491314] 'agreement among raft nodes before linearized reading' (duration: 146.766853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:06:02.966049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.699188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-phfth\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-03T22:06:02.96629Z","caller":"traceutil/trace.go:171","msg":"trace[1116374409] range","detail":"{range_begin:/registry/pods/openstack/keepalived-phfth; range_end:; response_count:1; response_revision:8918; }","duration":"129.826652ms","start":"2026-06-03T22:06:02.836291Z","end":"2026-06-03T22:06:02.966117Z","steps":["trace[1116374409] 'agreement among raft nodes before linearized reading' (duration: 128.794107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:06:02.966318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.195546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-h99hp\" ","response":"range_response_count:1 size:4650"} {"level":"info","ts":"2026-06-03T22:06:02.96642Z","caller":"traceutil/trace.go:171","msg":"trace[126544600] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-h99hp; range_end:; response_count:1; response_revision:8918; }","duration":"162.35354ms","start":"2026-06-03T22:06:02.804046Z","end":"2026-06-03T22:06:02.9664Z","steps":["trace[126544600] 'agreement among raft nodes before linearized reading' (duration: 160.647019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:06:02.96655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.056094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T22:06:02.966844Z","caller":"traceutil/trace.go:171","msg":"trace[1664408663] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:8918; }","duration":"134.451624ms","start":"2026-06-03T22:06:02.832346Z","end":"2026-06-03T22:06:02.966798Z","steps":["trace[1664408663] 'agreement among raft nodes before linearized reading' (duration: 132.763854ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:06:04.230756Z","caller":"traceutil/trace.go:171","msg":"trace[1904227327] transaction","detail":"{read_only:false; response_revision:8927; number_of_response:1; }","duration":"246.064306ms","start":"2026-06-03T22:06:03.984662Z","end":"2026-06-03T22:06:04.230726Z","steps":["trace[1904227327] 'process raft request' (duration: 152.660305ms)","trace[1904227327] 'compare' (duration: 93.235426ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:07:17.440332Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f3d52791b64f7591","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-03T22:07:17.449043Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-03T22:07:17.449206Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-03T22:07:22.852509Z","caller":"traceutil/trace.go:171","msg":"trace[142701030] transaction","detail":"{read_only:false; response_revision:9686; number_of_response:1; }","duration":"112.405305ms","start":"2026-06-03T22:07:22.740066Z","end":"2026-06-03T22:07:22.852471Z","steps":["trace[142701030] 'process raft request' (duration: 112.19228ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:09:14.173431Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8050} {"level":"info","ts":"2026-06-03T22:09:14.248132Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8050,"took":"71.804612ms","hash":2842752477,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":28508160,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-03T22:09:14.248214Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2842752477,"revision":8050,"compact-revision":5895} {"level":"info","ts":"2026-06-03T22:12:01.23289Z","caller":"traceutil/trace.go:171","msg":"trace[3561367] transaction","detail":"{read_only:false; response_revision:11583; number_of_response:1; }","duration":"194.45754ms","start":"2026-06-03T22:12:01.038397Z","end":"2026-06-03T22:12:01.232854Z","steps":["trace[3561367] 'process raft request' (duration: 192.640126ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:12:01.234342Z","caller":"traceutil/trace.go:171","msg":"trace[1445029003] linearizableReadLoop","detail":"{readStateIndex:11995; appliedIndex:11990; }","duration":"188.607419ms","start":"2026-06-03T22:12:01.045717Z","end":"2026-06-03T22:12:01.234325Z","steps":["trace[1445029003] 'read index received' (duration: 185.33485ms)","trace[1445029003] 'applied index is now lower than readState.Index' (duration: 3.271439ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:12:01.234444Z","caller":"traceutil/trace.go:171","msg":"trace[2105747260] transaction","detail":"{read_only:false; response_revision:11587; number_of_response:1; }","duration":"194.194173ms","start":"2026-06-03T22:12:01.04024Z","end":"2026-06-03T22:12:01.234434Z","steps":["trace[2105747260] 'process raft request' (duration: 194.0344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:12:01.234625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.735793ms","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-06-03T22:12:01.234535Z","caller":"traceutil/trace.go:171","msg":"trace[167237860] transaction","detail":"{read_only:false; response_revision:11586; number_of_response:1; }","duration":"195.107174ms","start":"2026-06-03T22:12:01.039364Z","end":"2026-06-03T22:12:01.234471Z","steps":["trace[167237860] 'process raft request' (duration: 194.867879ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:12:01.234626Z","caller":"traceutil/trace.go:171","msg":"trace[212665190] transaction","detail":"{read_only:false; response_revision:11585; number_of_response:1; }","duration":"195.411082ms","start":"2026-06-03T22:12:01.039153Z","end":"2026-06-03T22:12:01.234564Z","steps":["trace[212665190] 'process raft request' (duration: 195.019483ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:12:01.234708Z","caller":"traceutil/trace.go:171","msg":"trace[710826879] transaction","detail":"{read_only:false; response_revision:11584; number_of_response:1; }","duration":"195.847004ms","start":"2026-06-03T22:12:01.038847Z","end":"2026-06-03T22:12:01.234694Z","steps":["trace[710826879] 'process raft request' (duration: 195.223409ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:12:01.234709Z","caller":"traceutil/trace.go:171","msg":"trace[857114991] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11587; }","duration":"186.842575ms","start":"2026-06-03T22:12:01.047846Z","end":"2026-06-03T22:12:01.234688Z","steps":["trace[857114991] 'agreement among raft nodes before linearized reading' (duration: 186.638481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:12:01.234621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.890045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-03T22:12:01.234944Z","caller":"traceutil/trace.go:171","msg":"trace[1635318424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11587; }","duration":"189.247024ms","start":"2026-06-03T22:12:01.045681Z","end":"2026-06-03T22:12:01.234928Z","steps":["trace[1635318424] 'agreement among raft nodes before linearized reading' (duration: 188.834544ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:12:44.745875Z","caller":"traceutil/trace.go:171","msg":"trace[2077733709] transaction","detail":"{read_only:false; response_revision:12024; number_of_response:1; }","duration":"146.054055ms","start":"2026-06-03T22:12:44.599784Z","end":"2026-06-03T22:12:44.745838Z","steps":["trace[2077733709] 'process raft request' (duration: 146.001903ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:12:44.746356Z","caller":"traceutil/trace.go:171","msg":"trace[1311434087] transaction","detail":"{read_only:false; response_revision:12023; number_of_response:1; }","duration":"164.196041ms","start":"2026-06-03T22:12:44.582147Z","end":"2026-06-03T22:12:44.746343Z","steps":["trace[1311434087] 'process raft request' (duration: 163.482644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:13:02.931729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.412899ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-03T22:13:02.967692Z","caller":"traceutil/trace.go:171","msg":"trace[940247957] transaction","detail":"{read_only:false; response_revision:12124; number_of_response:1; }","duration":"199.827368ms","start":"2026-06-03T22:13:02.767837Z","end":"2026-06-03T22:13:02.967664Z","steps":["trace[940247957] 'process raft request' (duration: 199.659524ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:13:02.9853Z","caller":"traceutil/trace.go:171","msg":"trace[1288089395] transaction","detail":"{read_only:false; response_revision:12125; number_of_response:1; }","duration":"164.782884ms","start":"2026-06-03T22:13:02.820502Z","end":"2026-06-03T22:13:02.985285Z","steps":["trace[1288089395] 'process raft request' (duration: 164.639121ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:13:02.985499Z","caller":"traceutil/trace.go:171","msg":"trace[2047181555] transaction","detail":"{read_only:false; response_revision:12126; number_of_response:1; }","duration":"163.218886ms","start":"2026-06-03T22:13:02.822184Z","end":"2026-06-03T22:13:02.985403Z","steps":["trace[2047181555] 'process raft request' (duration: 163.047292ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:14:14.181632Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10451} {"level":"info","ts":"2026-06-03T22:14:14.264423Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10451,"took":"80.307417ms","hash":3719597480,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":25239552,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-03T22:14:14.264504Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3719597480,"revision":10451,"compact-revision":8050} {"level":"info","ts":"2026-06-03T22:19:14.187986Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12611} {"level":"info","ts":"2026-06-03T22:19:14.266028Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12611,"took":"74.946865ms","hash":2285737334,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":27009024,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-03T22:19:14.266125Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2285737334,"revision":12611,"compact-revision":10451} {"level":"warn","ts":"2026-06-03T22:19:47.51302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.994857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:138"} {"level":"info","ts":"2026-06-03T22:19:47.513122Z","caller":"traceutil/trace.go:171","msg":"trace[618215685] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:14819; }","duration":"123.145191ms","start":"2026-06-03T22:19:47.389957Z","end":"2026-06-03T22:19:47.513102Z","steps":["trace[618215685] 'range keys from in-memory index tree' (duration: 122.811822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:19:48.504965Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726713062413788,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-03T22:19:48.519136Z","caller":"traceutil/trace.go:171","msg":"trace[2117807631] transaction","detail":"{read_only:false; response_revision:14823; number_of_response:1; }","duration":"680.582849ms","start":"2026-06-03T22:19:47.838521Z","end":"2026-06-03T22:19:48.519103Z","steps":["trace[2117807631] 'process raft request' (duration: 680.375603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:19:48.519317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:19:47.838504Z","time spent":"680.722433ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:19:48.656606Z","caller":"traceutil/trace.go:171","msg":"trace[1310862939] linearizableReadLoop","detail":"{readStateIndex:15344; appliedIndex:15342; }","duration":"652.467434ms","start":"2026-06-03T22:19:48.004107Z","end":"2026-06-03T22:19:48.656574Z","steps":["trace[1310862939] 'read index received' (duration: 514.908506ms)","trace[1310862939] 'applied index is now lower than readState.Index' (duration: 137.557778ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:19:48.656786Z","caller":"traceutil/trace.go:171","msg":"trace[252146983] transaction","detail":"{read_only:false; response_revision:14824; number_of_response:1; }","duration":"815.965035ms","start":"2026-06-03T22:19:47.840787Z","end":"2026-06-03T22:19:48.656752Z","steps":["trace[252146983] 'process raft request' (duration: 790.566134ms)","trace[252146983] 'compare' (duration: 24.620061ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:19:48.656935Z","caller":"traceutil/trace.go:171","msg":"trace[473463918] transaction","detail":"{read_only:false; response_revision:14825; number_of_response:1; }","duration":"114.79964ms","start":"2026-06-03T22:19:48.542075Z","end":"2026-06-03T22:19:48.656875Z","steps":["trace[473463918] 'process raft request' (duration: 114.409871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:19:48.656948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:19:47.840771Z","time spent":"816.085757ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:19:48.657126Z","caller":"traceutil/trace.go:171","msg":"trace[1251247143] transaction","detail":"{read_only:false; response_revision:14826; number_of_response:1; }","duration":"114.995874ms","start":"2026-06-03T22:19:48.542118Z","end":"2026-06-03T22:19:48.657114Z","steps":["trace[1251247143] 'process raft request' (duration: 114.690357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:19:48.657394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.166041ms","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-06-03T22:19:48.657443Z","caller":"traceutil/trace.go:171","msg":"trace[678307054] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:14827; }","duration":"309.235763ms","start":"2026-06-03T22:19:48.348195Z","end":"2026-06-03T22:19:48.657431Z","steps":["trace[678307054] 'agreement among raft nodes before linearized reading' (duration: 309.025638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:19:48.657493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:19:48.348132Z","time spent":"309.351016ms","remote":"127.0.0.1:55398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":99,"response size":31,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-06-03T22:19:48.657503Z","caller":"traceutil/trace.go:171","msg":"trace[800353432] transaction","detail":"{read_only:false; response_revision:14827; number_of_response:1; }","duration":"113.166299ms","start":"2026-06-03T22:19:48.544291Z","end":"2026-06-03T22:19:48.657457Z","steps":["trace[800353432] 'process raft request' (duration: 112.742699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:19:48.659388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.26603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-8wtdz\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-06-03T22:19:48.65943Z","caller":"traceutil/trace.go:171","msg":"trace[435760694] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-8wtdz; range_end:; response_count:1; response_revision:14827; }","duration":"655.352453ms","start":"2026-06-03T22:19:48.004069Z","end":"2026-06-03T22:19:48.659421Z","steps":["trace[435760694] 'agreement among raft nodes before linearized reading' (duration: 652.710009ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:19:48.659454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:19:48.00405Z","time spent":"655.397814ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":12388,"request content":"key:\"/registry/pods/openstack/openvswitch-8wtdz\" "} {"level":"info","ts":"2026-06-03T22:19:58.462993Z","caller":"traceutil/trace.go:171","msg":"trace[863045000] transaction","detail":"{read_only:false; response_revision:14993; number_of_response:1; }","duration":"231.163447ms","start":"2026-06-03T22:19:58.231773Z","end":"2026-06-03T22:19:58.462937Z","steps":["trace[863045000] 'process raft request' (duration: 132.192148ms)","trace[863045000] 'compare' (duration: 98.644191ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T22:19:58.817335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.179567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-03T22:19:58.81743Z","caller":"traceutil/trace.go:171","msg":"trace[383805822] linearizableReadLoop","detail":"{readStateIndex:15517; appliedIndex:15516; }","duration":"250.733848ms","start":"2026-06-03T22:19:58.566683Z","end":"2026-06-03T22:19:58.817416Z","steps":["trace[383805822] 'read index received' (duration: 148.355936ms)","trace[383805822] 'applied index is now lower than readState.Index' (duration: 102.377162ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:19:58.817748Z","caller":"traceutil/trace.go:171","msg":"trace[1581493823] transaction","detail":"{read_only:false; response_revision:14994; number_of_response:1; }","duration":"342.80194ms","start":"2026-06-03T22:19:58.474899Z","end":"2026-06-03T22:19:58.817701Z","steps":["trace[1581493823] 'process raft request' (duration: 240.172653ms)","trace[1581493823] 'compare' (duration: 102.083215ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T22:19:58.817863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.144267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-03T22:19:58.817946Z","caller":"traceutil/trace.go:171","msg":"trace[2041903043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14994; }","duration":"251.325342ms","start":"2026-06-03T22:19:58.566603Z","end":"2026-06-03T22:19:58.817928Z","steps":["trace[2041903043] 'agreement among raft nodes before linearized reading' (duration: 251.075336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:19:58.818019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:19:58.474866Z","time spent":"343.064657ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3712,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T22:19:58.852397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.926269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-03T22:19:58.852507Z","caller":"traceutil/trace.go:171","msg":"trace[393640564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14998; }","duration":"218.097583ms","start":"2026-06-03T22:19:58.634385Z","end":"2026-06-03T22:19:58.852482Z","steps":["trace[393640564] 'agreement among raft nodes before linearized reading' (duration: 217.929669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:19:58.852631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.546072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-default-2gwcw.18b5b23bb4c1153f\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-06-03T22:19:58.852753Z","caller":"traceutil/trace.go:171","msg":"trace[1244350937] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-default-2gwcw.18b5b23bb4c1153f; range_end:; response_count:1; response_revision:14998; }","duration":"121.719706ms","start":"2026-06-03T22:19:58.731011Z","end":"2026-06-03T22:19:58.852731Z","steps":["trace[1244350937] 'agreement among raft nodes before linearized reading' (duration: 121.231424ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:21:23.253351Z","caller":"traceutil/trace.go:171","msg":"trace[1025522552] transaction","detail":"{read_only:false; response_revision:16002; number_of_response:1; }","duration":"101.233185ms","start":"2026-06-03T22:21:23.152091Z","end":"2026-06-03T22:21:23.253324Z","steps":["trace[1025522552] 'process raft request' (duration: 100.764662ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:21:23.292815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.499019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-06-03T22:21:23.292877Z","caller":"traceutil/trace.go:171","msg":"trace[58357364] transaction","detail":"{read_only:false; response_revision:16003; number_of_response:1; }","duration":"105.917937ms","start":"2026-06-03T22:21:23.186926Z","end":"2026-06-03T22:21:23.292844Z","steps":["trace[58357364] 'process raft request' (duration: 105.433084ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:21:23.292912Z","caller":"traceutil/trace.go:171","msg":"trace[1170689538] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16004; }","duration":"133.663463ms","start":"2026-06-03T22:21:23.159225Z","end":"2026-06-03T22:21:23.292889Z","steps":["trace[1170689538] 'agreement among raft nodes before linearized reading' (duration: 133.370806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:21:23.293194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.450778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-03T22:21:23.293274Z","caller":"traceutil/trace.go:171","msg":"trace[33404868] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16004; }","duration":"128.606001ms","start":"2026-06-03T22:21:23.164651Z","end":"2026-06-03T22:21:23.293257Z","steps":["trace[33404868] 'agreement among raft nodes before linearized reading' (duration: 128.354855ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:21:24.214729Z","caller":"traceutil/trace.go:171","msg":"trace[680072286] transaction","detail":"{read_only:false; response_revision:16009; number_of_response:1; }","duration":"153.602082ms","start":"2026-06-03T22:21:24.061094Z","end":"2026-06-03T22:21:24.214696Z","steps":["trace[680072286] 'process raft request' (duration: 153.421448ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:21:24.215349Z","caller":"traceutil/trace.go:171","msg":"trace[943260642] linearizableReadLoop","detail":"{readStateIndex:16560; appliedIndex:16560; }","duration":"108.57226ms","start":"2026-06-03T22:21:24.106764Z","end":"2026-06-03T22:21:24.215337Z","steps":["trace[943260642] 'read index received' (duration: 108.56664ms)","trace[943260642] 'applied index is now lower than readState.Index' (duration: 4.51µs)"],"step_count":2} {"level":"warn","ts":"2026-06-03T22:21:24.215997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.222695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-03T22:21:24.216066Z","caller":"traceutil/trace.go:171","msg":"trace[30080246] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16009; }","duration":"109.357088ms","start":"2026-06-03T22:21:24.106697Z","end":"2026-06-03T22:21:24.216054Z","steps":["trace[30080246] 'agreement among raft nodes before linearized reading' (duration: 109.182964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:21:24.588543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.716365ms","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-06-03T22:21:24.588699Z","caller":"traceutil/trace.go:171","msg":"trace[373227050] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16009; }","duration":"262.883999ms","start":"2026-06-03T22:21:24.325771Z","end":"2026-06-03T22:21:24.588655Z","steps":["trace[373227050] 'range keys from in-memory index tree' (duration: 262.53109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:21:24.588719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.729892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-pv9ln\" ","response":"range_response_count:1 size:22093"} {"level":"info","ts":"2026-06-03T22:21:24.589205Z","caller":"traceutil/trace.go:171","msg":"trace[1136825297] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-pv9ln; range_end:; response_count:1; response_revision:16009; }","duration":"292.266115ms","start":"2026-06-03T22:21:24.296911Z","end":"2026-06-03T22:21:24.589177Z","steps":["trace[1136825297] 'range keys from in-memory index tree' (duration: 291.466786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:21:24.590313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.028968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769876"} {"level":"info","ts":"2026-06-03T22:21:24.590409Z","caller":"traceutil/trace.go:171","msg":"trace[594283101] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:16009; }","duration":"351.174552ms","start":"2026-06-03T22:21:24.239214Z","end":"2026-06-03T22:21:24.590389Z","steps":["trace[594283101] 'range keys from in-memory index tree' (duration: 349.029399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:21:24.590497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:21:24.23919Z","time spent":"351.258644ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":79,"response size":769900,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-06-03T22:21:24.748851Z","caller":"traceutil/trace.go:171","msg":"trace[634282277] linearizableReadLoop","detail":"{readStateIndex:16561; appliedIndex:16560; }","duration":"150.803373ms","start":"2026-06-03T22:21:24.598019Z","end":"2026-06-03T22:21:24.748822Z","steps":["trace[634282277] 'read index received' (duration: 150.538237ms)","trace[634282277] 'applied index is now lower than readState.Index' (duration: 263.756µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:21:24.74892Z","caller":"traceutil/trace.go:171","msg":"trace[755982366] transaction","detail":"{read_only:false; response_revision:16010; number_of_response:1; }","duration":"155.552649ms","start":"2026-06-03T22:21:24.593327Z","end":"2026-06-03T22:21:24.74888Z","steps":["trace[755982366] 'process raft request' (duration: 155.19004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:21:24.749854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.806329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769876"} {"level":"info","ts":"2026-06-03T22:21:24.749953Z","caller":"traceutil/trace.go:171","msg":"trace[2073056185] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:16010; }","duration":"151.917962ms","start":"2026-06-03T22:21:24.598012Z","end":"2026-06-03T22:21:24.74993Z","steps":["trace[2073056185] 'agreement among raft nodes before linearized reading' (duration: 150.935927ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:21:55.639513Z","caller":"traceutil/trace.go:171","msg":"trace[2121173636] transaction","detail":"{read_only:false; response_revision:16168; number_of_response:1; }","duration":"104.588218ms","start":"2026-06-03T22:21:55.534894Z","end":"2026-06-03T22:21:55.639482Z","steps":["trace[2121173636] 'process raft request' (duration: 104.387513ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:24:14.195199Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14632} {"level":"info","ts":"2026-06-03T22:24:14.275032Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14632,"took":"75.868715ms","hash":3047935994,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":32391168,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-03T22:24:14.27515Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3047935994,"revision":14632,"compact-revision":12611} {"level":"info","ts":"2026-06-03T22:27:23.714805Z","caller":"traceutil/trace.go:171","msg":"trace[2106378660] transaction","detail":"{read_only:false; response_revision:18617; number_of_response:1; }","duration":"127.798601ms","start":"2026-06-03T22:27:23.586967Z","end":"2026-06-03T22:27:23.714766Z","steps":["trace[2106378660] 'process raft request' (duration: 101.945161ms)","trace[2106378660] 'compare' (duration: 25.637974ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:27:24.797686Z","caller":"traceutil/trace.go:171","msg":"trace[694252741] transaction","detail":"{read_only:false; response_revision:18621; number_of_response:1; }","duration":"335.849334ms","start":"2026-06-03T22:27:24.461808Z","end":"2026-06-03T22:27:24.797657Z","steps":["trace[694252741] 'process raft request' (duration: 335.551367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:24.797878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:27:24.461784Z","time spent":"335.998898ms","remote":"127.0.0.1:55258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20967,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:27:24.838754Z","caller":"traceutil/trace.go:171","msg":"trace[855573623] linearizableReadLoop","detail":"{readStateIndex:19260; appliedIndex:19257; }","duration":"164.951011ms","start":"2026-06-03T22:27:24.673774Z","end":"2026-06-03T22:27:24.838725Z","steps":["trace[855573623] 'read index received' (duration: 123.675422ms)","trace[855573623] 'applied index is now lower than readState.Index' (duration: 41.274149ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:27:24.838798Z","caller":"traceutil/trace.go:171","msg":"trace[755275732] transaction","detail":"{read_only:false; response_revision:18622; number_of_response:1; }","duration":"216.995177ms","start":"2026-06-03T22:27:24.621759Z","end":"2026-06-03T22:27:24.838755Z","steps":["trace[755275732] 'process raft request' (duration: 198.054523ms)","trace[755275732] 'compare' (duration: 18.692068ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:27:24.838914Z","caller":"traceutil/trace.go:171","msg":"trace[1080702290] transaction","detail":"{read_only:false; response_revision:18624; number_of_response:1; }","duration":"160.627968ms","start":"2026-06-03T22:27:24.67824Z","end":"2026-06-03T22:27:24.838868Z","steps":["trace[1080702290] 'process raft request' (duration: 160.443364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:24.83904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.242648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-03T22:27:24.838891Z","caller":"traceutil/trace.go:171","msg":"trace[537080415] transaction","detail":"{read_only:false; response_revision:18623; number_of_response:1; }","duration":"167.381509ms","start":"2026-06-03T22:27:24.67144Z","end":"2026-06-03T22:27:24.838822Z","steps":["trace[537080415] 'process raft request' (duration: 167.200595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:24.839074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.886588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1985"} {"level":"info","ts":"2026-06-03T22:27:24.8391Z","caller":"traceutil/trace.go:171","msg":"trace[1323285906] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18624; }","duration":"165.363101ms","start":"2026-06-03T22:27:24.673722Z","end":"2026-06-03T22:27:24.839085Z","steps":["trace[1323285906] 'agreement among raft nodes before linearized reading' (duration: 165.163756ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:27:24.839127Z","caller":"traceutil/trace.go:171","msg":"trace[1316461276] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:18624; }","duration":"142.002592ms","start":"2026-06-03T22:27:24.697107Z","end":"2026-06-03T22:27:24.83911Z","steps":["trace[1316461276] 'agreement among raft nodes before linearized reading' (duration: 141.798357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:24.839203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.61293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-06-03T22:27:24.839307Z","caller":"traceutil/trace.go:171","msg":"trace[288875962] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18624; }","duration":"100.776034ms","start":"2026-06-03T22:27:24.738512Z","end":"2026-06-03T22:27:24.839288Z","steps":["trace[288875962] 'agreement among raft nodes before linearized reading' (duration: 100.479087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:25.464992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.188242ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-03T22:27:25.465446Z","caller":"traceutil/trace.go:171","msg":"trace[699620909] transaction","detail":"{read_only:false; response_revision:18625; number_of_response:1; }","duration":"621.3254ms","start":"2026-06-03T22:27:24.844098Z","end":"2026-06-03T22:27:25.465423Z","steps":["trace[699620909] 'process raft request' (duration: 299.603576ms)","trace[699620909] 'compare' (duration: 320.738311ms)"],"step_count":2} {"level":"warn","ts":"2026-06-03T22:27:25.465535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:27:24.844059Z","time spent":"621.439382ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:27:25.502994Z","caller":"traceutil/trace.go:171","msg":"trace[1577389830] transaction","detail":"{read_only:false; response_revision:18626; number_of_response:1; }","duration":"656.588525ms","start":"2026-06-03T22:27:24.846375Z","end":"2026-06-03T22:27:25.502963Z","steps":["trace[1577389830] 'process raft request' (duration: 656.34986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:25.503167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:27:24.846354Z","time spent":"656.719678ms","remote":"127.0.0.1:55364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-03T22:27:25.503164Z","caller":"traceutil/trace.go:171","msg":"trace[381949129] linearizableReadLoop","detail":"{readStateIndex:19263; appliedIndex:19261; }","duration":"631.418901ms","start":"2026-06-03T22:27:24.871709Z","end":"2026-06-03T22:27:25.503128Z","steps":["trace[381949129] 'read index received' (duration: 272.007174ms)","trace[381949129] 'applied index is now lower than readState.Index' (duration: 359.409467ms)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:27:25.5033Z","caller":"traceutil/trace.go:171","msg":"trace[348531718] transaction","detail":"{read_only:false; response_revision:18627; number_of_response:1; }","duration":"565.052343ms","start":"2026-06-03T22:27:24.938233Z","end":"2026-06-03T22:27:25.503285Z","steps":["trace[348531718] 'process raft request' (duration: 564.636953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:25.503458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:27:24.938209Z","time spent":"565.149115ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-03T22:27:25.503476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.497008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-06-03T22:27:25.503565Z","caller":"traceutil/trace.go:171","msg":"trace[2079285488] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18627; }","duration":"551.592371ms","start":"2026-06-03T22:27:24.951929Z","end":"2026-06-03T22:27:25.503522Z","steps":["trace[2079285488] 'agreement among raft nodes before linearized reading' (duration: 551.396086ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:25.503612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:27:24.951902Z","time spent":"551.701993ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":727,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"warn","ts":"2026-06-03T22:27:25.503706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.030812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-03T22:27:25.503791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.090898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"warn","ts":"2026-06-03T22:27:25.503805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.758775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-03T22:27:25.503857Z","caller":"traceutil/trace.go:171","msg":"trace[877679781] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:18627; }","duration":"455.838187ms","start":"2026-06-03T22:27:25.048004Z","end":"2026-06-03T22:27:25.503842Z","steps":["trace[877679781] 'agreement among raft nodes before linearized reading' (duration: 455.767235ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:25.503895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:27:25.047981Z","time spent":"455.905499ms","remote":"127.0.0.1:45012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-06-03T22:27:25.504164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.8941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-pv9ln\" ","response":"range_response_count:1 size:22094"} {"level":"info","ts":"2026-06-03T22:27:25.504237Z","caller":"traceutil/trace.go:171","msg":"trace[1661129956] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18627; }","duration":"632.18311ms","start":"2026-06-03T22:27:24.871652Z","end":"2026-06-03T22:27:25.503836Z","steps":["trace[1661129956] 'agreement among raft nodes before linearized reading' (duration: 632.056297ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:27:25.504279Z","caller":"traceutil/trace.go:171","msg":"trace[1577298890] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-pv9ln; range_end:; response_count:1; response_revision:18627; }","duration":"183.070544ms","start":"2026-06-03T22:27:25.321182Z","end":"2026-06-03T22:27:25.504253Z","steps":["trace[1577298890] 'agreement among raft nodes before linearized reading' (duration: 182.678865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:25.504343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-03T22:27:24.871627Z","time spent":"632.705143ms","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":727,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"info","ts":"2026-06-03T22:27:25.503756Z","caller":"traceutil/trace.go:171","msg":"trace[664009108] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:18627; }","duration":"218.127804ms","start":"2026-06-03T22:27:25.285615Z","end":"2026-06-03T22:27:25.503742Z","steps":["trace[664009108] 'agreement among raft nodes before linearized reading' (duration: 218.041162ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:27:33.95687Z","caller":"traceutil/trace.go:171","msg":"trace[1114162457] transaction","detail":"{read_only:false; response_revision:18735; number_of_response:1; }","duration":"158.525607ms","start":"2026-06-03T22:27:33.798315Z","end":"2026-06-03T22:27:33.956841Z","steps":["trace[1114162457] 'process raft request' (duration: 158.021334ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:27:33.957013Z","caller":"traceutil/trace.go:171","msg":"trace[56382364] linearizableReadLoop","detail":"{readStateIndex:19377; appliedIndex:19375; }","duration":"142.632606ms","start":"2026-06-03T22:27:33.814345Z","end":"2026-06-03T22:27:33.956977Z","steps":["trace[56382364] 'read index received' (duration: 142.269447ms)","trace[56382364] 'applied index is now lower than readState.Index' (duration: 360.519µs)"],"step_count":2} {"level":"info","ts":"2026-06-03T22:27:33.957074Z","caller":"traceutil/trace.go:171","msg":"trace[666340457] transaction","detail":"{read_only:false; number_of_response:1; response_revision:18735; }","duration":"158.081996ms","start":"2026-06-03T22:27:33.79896Z","end":"2026-06-03T22:27:33.957042Z","steps":["trace[666340457] 'process raft request' (duration: 157.78699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:33.957542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.927562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-06-03T22:27:33.957667Z","caller":"traceutil/trace.go:171","msg":"trace[196338891] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:18735; }","duration":"168.118426ms","start":"2026-06-03T22:27:33.789517Z","end":"2026-06-03T22:27:33.957635Z","steps":["trace[196338891] 'agreement among raft nodes before linearized reading' (duration: 167.592384ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:27:33.966142Z","caller":"traceutil/trace.go:171","msg":"trace[830774206] transaction","detail":"{read_only:false; response_revision:18736; number_of_response:1; }","duration":"137.625586ms","start":"2026-06-03T22:27:33.8285Z","end":"2026-06-03T22:27:33.966126Z","steps":["trace[830774206] 'process raft request' (duration: 137.339569ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:27:33.966237Z","caller":"traceutil/trace.go:171","msg":"trace[1843132875] transaction","detail":"{read_only:false; number_of_response:1; response_revision:18736; }","duration":"128.338694ms","start":"2026-06-03T22:27:33.837875Z","end":"2026-06-03T22:27:33.966214Z","steps":["trace[1843132875] 'process raft request' (duration: 128.18053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-03T22:27:33.966416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.265692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-06-03T22:27:33.966462Z","caller":"traceutil/trace.go:171","msg":"trace[1343752675] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:18736; }","duration":"146.320483ms","start":"2026-06-03T22:27:33.820125Z","end":"2026-06-03T22:27:33.966446Z","steps":["trace[1343752675] 'agreement among raft nodes before linearized reading' (duration: 146.17966ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T22:29:14.208135Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17211} {"level":"info","ts":"2026-06-03T22:29:14.31005Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17211,"took":"96.814948ms","hash":1252109284,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":30851072,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-03T22:29:14.310137Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1252109284,"revision":17211,"compact-revision":14632} {"level":"info","ts":"2026-06-03T22:29:21.030794Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f3d52791b64f7591","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-03T22:29:21.036414Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-03T22:29:21.036539Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-03T22:34:14.21439Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19299} {"level":"info","ts":"2026-06-03T22:34:14.319017Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19299,"took":"99.072685ms","hash":4231826721,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":25133056,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-03T22:34:14.319113Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4231826721,"revision":19299,"compact-revision":17211}