{"level":"warn","ts":"2026-04-18T09:10:54.754808Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T09:10:54.754891Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.155: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.155:2380","--initial-cluster=instance=https://199.204.45.155:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.155:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.155:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-18T09:10:54.754956Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T09:10:54.754969Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-04-18T09:10:54.754985Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-18T09:10:54.755856Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"]} {"level":"info","ts":"2026-04-18T09:10:54.756538Z","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.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.155:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-18T09:10:54.761787Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.92328ms"} {"level":"info","ts":"2026-04-18T09:10:54.7676Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"344940fc142d902f","cluster-id":"c7d65bf2a36fbd4"} {"level":"info","ts":"2026-04-18T09:10:54.76765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T09:10:54.767676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 0"} {"level":"info","ts":"2026-04-18T09:10:54.767691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 344940fc142d902f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T09:10:54.767705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 1"} {"level":"info","ts":"2026-04-18T09:10:54.767737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"warn","ts":"2026-04-18T09:10:54.778542Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T09:10:54.780945Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T09:10:54.78218Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-18T09:10:54.784556Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"344940fc142d902f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T09:10:54.785149Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"344940fc142d902f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T09:10:54.785289Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T09:10:54.78538Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T09:10:54.785433Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T09:10:54.78661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"info","ts":"2026-04-18T09:10:54.7869Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","added-peer-id":"344940fc142d902f","added-peer-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-04-18T09:10:54.787201Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-18T09:10:54.78733Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-04-18T09:10:54.787409Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-04-18T09:10:54.787435Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"344940fc142d902f","initial-advertise-peer-urls":["https://199.204.45.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T09:10:54.787477Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T09:10:55.268577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T09:10:55.268622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T09:10:55.268641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgPreVoteResp from 344940fc142d902f at term 1"} {"level":"info","ts":"2026-04-18T09:10:55.268652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became candidate at term 2"} {"level":"info","ts":"2026-04-18T09:10:55.268657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgVoteResp from 344940fc142d902f at term 2"} {"level":"info","ts":"2026-04-18T09:10:55.268673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became leader at term 2"} {"level":"info","ts":"2026-04-18T09:10:55.26868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 344940fc142d902f elected leader 344940fc142d902f at term 2"} {"level":"info","ts":"2026-04-18T09:10:55.26962Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:10:55.271233Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"344940fc142d902f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.155:2379]}","request-path":"/0/members/344940fc142d902f/attributes","cluster-id":"c7d65bf2a36fbd4","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T09:10:55.271255Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T09:10:55.27128Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T09:10:55.271637Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T09:10:55.27168Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:10:55.271727Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T09:10:55.271873Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:10:55.27192Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T09:10:55.27472Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.155:2379"} {"level":"info","ts":"2026-04-18T09:10:55.275029Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-18T09:11:09.496869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036735544s","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-04-18T09:11:09.497003Z","caller":"traceutil/trace.go:171","msg":"trace[1954958176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:355; }","duration":"1.036916658s","start":"2026-04-18T09:11:08.460061Z","end":"2026-04-18T09:11:09.496978Z","steps":["trace[1954958176] 'range keys from in-memory index tree' (duration: 1.036573609s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:09.49707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:08.460041Z","time spent":"1.03701424s","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-18T09:11:09.497227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.769033ms","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-04-18T09:11:09.497293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.326923271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-18T09:11:09.4973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.570904ms","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-04-18T09:11:09.497383Z","caller":"traceutil/trace.go:171","msg":"trace[633607315] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:355; }","duration":"1.327076704s","start":"2026-04-18T09:11:08.170285Z","end":"2026-04-18T09:11:09.497362Z","steps":["trace[633607315] 'range keys from in-memory index tree' (duration: 1.326781768s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:09.49743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:08.170262Z","time spent":"1.327159357s","remote":"127.0.0.1:57874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.155\" "} {"level":"info","ts":"2026-04-18T09:11:09.497316Z","caller":"traceutil/trace.go:171","msg":"trace[1393398974] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:355; }","duration":"751.902267ms","start":"2026-04-18T09:11:08.745392Z","end":"2026-04-18T09:11:09.497294Z","steps":["trace[1393398974] 'range keys from in-memory index tree' (duration: 751.63255ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:09.497398Z","caller":"traceutil/trace.go:171","msg":"trace[1078333009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:355; }","duration":"727.762859ms","start":"2026-04-18T09:11:08.769613Z","end":"2026-04-18T09:11:09.497376Z","steps":["trace[1078333009] 'range keys from in-memory index tree' (duration: 727.237716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:09.497527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:08.745378Z","time spent":"752.129822ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-18T09:11:09.497647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:08.76959Z","time spent":"728.041236ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-18T09:11:09.612282Z","caller":"traceutil/trace.go:171","msg":"trace[1238295348] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"110.948465ms","start":"2026-04-18T09:11:09.501307Z","end":"2026-04-18T09:11:09.612256Z","steps":["trace[1238295348] 'process raft request' (duration: 109.803538ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:09.61232Z","caller":"traceutil/trace.go:171","msg":"trace[128946671] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"110.955005ms","start":"2026-04-18T09:11:09.501344Z","end":"2026-04-18T09:11:09.612299Z","steps":["trace[128946671] 'process raft request' (duration: 110.768431ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:09.612307Z","caller":"traceutil/trace.go:171","msg":"trace[1913672942] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"110.209247ms","start":"2026-04-18T09:11:09.502069Z","end":"2026-04-18T09:11:09.612278Z","steps":["trace[1913672942] 'process raft request' (duration: 110.153096ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:09.612372Z","caller":"traceutil/trace.go:171","msg":"trace[494571029] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"110.917564ms","start":"2026-04-18T09:11:09.501418Z","end":"2026-04-18T09:11:09.612336Z","steps":["trace[494571029] 'process raft request' (duration: 110.761751ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:27.708926Z","caller":"traceutil/trace.go:171","msg":"trace[1888065025] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"119.26197ms","start":"2026-04-18T09:11:27.589636Z","end":"2026-04-18T09:11:27.708898Z","steps":["trace[1888065025] 'process raft request' (duration: 119.083095ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:27.714097Z","caller":"traceutil/trace.go:171","msg":"trace[939343950] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"121.728589ms","start":"2026-04-18T09:11:27.592346Z","end":"2026-04-18T09:11:27.714074Z","steps":["trace[939343950] 'process raft request' (duration: 121.580816ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:27.714228Z","caller":"traceutil/trace.go:171","msg":"trace[1185276281] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"112.679108ms","start":"2026-04-18T09:11:27.601542Z","end":"2026-04-18T09:11:27.714221Z","steps":["trace[1185276281] 'process raft request' (duration: 112.522334ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:27.714284Z","caller":"traceutil/trace.go:171","msg":"trace[1195702728] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"108.138018ms","start":"2026-04-18T09:11:27.60614Z","end":"2026-04-18T09:11:27.714278Z","steps":["trace[1195702728] 'process raft request' (duration: 108.045256ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:27.714352Z","caller":"traceutil/trace.go:171","msg":"trace[1388549444] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"111.261824ms","start":"2026-04-18T09:11:27.603085Z","end":"2026-04-18T09:11:27.714347Z","steps":["trace[1388549444] 'process raft request' (duration: 111.023268ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:27.714337Z","caller":"traceutil/trace.go:171","msg":"trace[1584812177] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"119.014893ms","start":"2026-04-18T09:11:27.59523Z","end":"2026-04-18T09:11:27.714245Z","steps":["trace[1584812177] 'process raft request' (duration: 118.794488ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:27.714405Z","caller":"traceutil/trace.go:171","msg":"trace[798212335] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"100.325776ms","start":"2026-04-18T09:11:27.614054Z","end":"2026-04-18T09:11:27.71438Z","steps":["trace[798212335] 'process raft request' (duration: 100.169903ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:27.714457Z","caller":"traceutil/trace.go:171","msg":"trace[1220117947] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"109.676895ms","start":"2026-04-18T09:11:27.604685Z","end":"2026-04-18T09:11:27.714362Z","steps":["trace[1220117947] 'process raft request' (duration: 109.45803ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:32.291026Z","caller":"traceutil/trace.go:171","msg":"trace[987658576] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"176.75077ms","start":"2026-04-18T09:11:32.114249Z","end":"2026-04-18T09:11:32.291Z","steps":["trace[987658576] 'process raft request' (duration: 176.228347ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:33.956271Z","caller":"traceutil/trace.go:171","msg":"trace[1801091963] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"156.389714ms","start":"2026-04-18T09:11:33.79985Z","end":"2026-04-18T09:11:33.956239Z","steps":["trace[1801091963] 'read index received' (duration: 154.271372ms)","trace[1801091963] 'applied index is now lower than readState.Index' (duration: 2.117122ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:11:33.95652Z","caller":"traceutil/trace.go:171","msg":"trace[891513642] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"189.04316ms","start":"2026-04-18T09:11:33.76744Z","end":"2026-04-18T09:11:33.956483Z","steps":["trace[891513642] 'process raft request' (duration: 187.099683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:33.956589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.725662ms","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-04-18T09:11:33.956661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.383954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:33.95667Z","caller":"traceutil/trace.go:171","msg":"trace[1654940251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"156.836035ms","start":"2026-04-18T09:11:33.799815Z","end":"2026-04-18T09:11:33.956651Z","steps":["trace[1654940251] 'agreement among raft nodes before linearized reading' (duration: 156.607629ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:33.956734Z","caller":"traceutil/trace.go:171","msg":"trace[970656144] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:577; }","duration":"131.497666ms","start":"2026-04-18T09:11:33.825218Z","end":"2026-04-18T09:11:33.956716Z","steps":["trace[970656144] 'agreement among raft nodes before linearized reading' (duration: 131.353763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:33.95682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.139871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-18T09:11:33.956876Z","caller":"traceutil/trace.go:171","msg":"trace[764270154] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"150.196512ms","start":"2026-04-18T09:11:33.806662Z","end":"2026-04-18T09:11:33.956859Z","steps":["trace[764270154] 'agreement among raft nodes before linearized reading' (duration: 150.095659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:33.956925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.816529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:33.956724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.591435ms","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-04-18T09:11:33.956954Z","caller":"traceutil/trace.go:171","msg":"trace[1550789295] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:577; }","duration":"130.868971ms","start":"2026-04-18T09:11:33.826078Z","end":"2026-04-18T09:11:33.956947Z","steps":["trace[1550789295] 'agreement among raft nodes before linearized reading' (duration: 130.82512ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:33.956975Z","caller":"traceutil/trace.go:171","msg":"trace[101897848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"146.869481ms","start":"2026-04-18T09:11:33.81009Z","end":"2026-04-18T09:11:33.956959Z","steps":["trace[101897848] 'agreement among raft nodes before linearized reading' (duration: 146.509173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:33.957016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.682991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:33.957036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.722585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-18T09:11:33.957063Z","caller":"traceutil/trace.go:171","msg":"trace[1890589636] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:577; }","duration":"131.779804ms","start":"2026-04-18T09:11:33.825271Z","end":"2026-04-18T09:11:33.957051Z","steps":["trace[1890589636] 'agreement among raft nodes before linearized reading' (duration: 131.711012ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:33.957078Z","caller":"traceutil/trace.go:171","msg":"trace[250376366] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"150.807177ms","start":"2026-04-18T09:11:33.806259Z","end":"2026-04-18T09:11:33.957066Z","steps":["trace[250376366] 'agreement among raft nodes before linearized reading' (duration: 150.640373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.425483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.324792ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:11:34.425736Z","caller":"traceutil/trace.go:171","msg":"trace[844072572] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"460.261796ms","start":"2026-04-18T09:11:33.965455Z","end":"2026-04-18T09:11:34.425716Z","steps":["trace[844072572] 'compare' (duration: 450.193409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.425859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:33.965431Z","time spent":"460.388749ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:11:34.476123Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389696175274734539,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T09:11:34.565376Z","caller":"traceutil/trace.go:171","msg":"trace[421905906] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"598.066386ms","start":"2026-04-18T09:11:33.967262Z","end":"2026-04-18T09:11:34.565328Z","steps":["trace[421905906] 'process raft request' (duration: 576.180712ms)","trace[421905906] 'compare' (duration: 21.74133ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:11:34.56564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:33.967246Z","time spent":"598.20037ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:11:34.565648Z","caller":"traceutil/trace.go:171","msg":"trace[240169461] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"598.287912ms","start":"2026-04-18T09:11:33.967322Z","end":"2026-04-18T09:11:34.56561Z","steps":["trace[240169461] 'process raft request' (duration: 597.974685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.565799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:33.967305Z","time spent":"598.424275ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:11:34.566053Z","caller":"traceutil/trace.go:171","msg":"trace[235277745] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"597.303338ms","start":"2026-04-18T09:11:33.968738Z","end":"2026-04-18T09:11:34.566041Z","steps":["trace[235277745] 'process raft request' (duration: 596.790015ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:34.566129Z","caller":"traceutil/trace.go:171","msg":"trace[1065595358] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"592.330977ms","start":"2026-04-18T09:11:33.973769Z","end":"2026-04-18T09:11:34.5661Z","steps":["trace[1065595358] 'process raft request' (duration: 592.166843ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.566116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:33.968695Z","time spent":"597.38958ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:11:34.56631Z","caller":"traceutil/trace.go:171","msg":"trace[1327181617] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:600; }","duration":"591.218089ms","start":"2026-04-18T09:11:33.975079Z","end":"2026-04-18T09:11:34.566297Z","steps":["trace[1327181617] 'read index received' (duration: 568.461724ms)","trace[1327181617] 'applied index is now lower than readState.Index' (duration: 22.755375ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:11:34.566315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:33.973748Z","time spent":"592.48065ms","remote":"127.0.0.1:58014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:11:34.566428Z","caller":"traceutil/trace.go:171","msg":"trace[2100387548] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"533.177313ms","start":"2026-04-18T09:11:34.033218Z","end":"2026-04-18T09:11:34.566395Z","steps":["trace[2100387548] 'process raft request' (duration: 532.800364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.566483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.391873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:34.566498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.709695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.566524Z","caller":"traceutil/trace.go:171","msg":"trace[1623964016] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"591.470325ms","start":"2026-04-18T09:11:33.975042Z","end":"2026-04-18T09:11:34.566513Z","steps":["trace[1623964016] 'agreement among raft nodes before linearized reading' (duration: 591.352042ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:34.566539Z","caller":"traceutil/trace.go:171","msg":"trace[1335746267] 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:583; }","duration":"307.799497ms","start":"2026-04-18T09:11:34.258725Z","end":"2026-04-18T09:11:34.566525Z","steps":["trace[1335746267] 'agreement among raft nodes before linearized reading' (duration: 307.731516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.566561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:33.975028Z","time spent":"591.524326ms","remote":"127.0.0.1:40866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-18T09:11:34.566548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.033185Z","time spent":"533.311007ms","remote":"127.0.0.1:58318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T09:11:34.566574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.258689Z","time spent":"307.877589ms","remote":"127.0.0.1:40910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-18T09:11:34.566495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.321791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.566775Z","caller":"traceutil/trace.go:171","msg":"trace[448159537] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"591.542807ms","start":"2026-04-18T09:11:33.975135Z","end":"2026-04-18T09:11:34.566678Z","steps":["trace[448159537] 'agreement among raft nodes before linearized reading' (duration: 591.310481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.566821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.776722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:34.566832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:33.97513Z","time spent":"591.68614ms","remote":"127.0.0.1:40866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-18T09:11:34.566841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.232302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.566855Z","caller":"traceutil/trace.go:171","msg":"trace[952108239] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:583; }","duration":"265.834744ms","start":"2026-04-18T09:11:34.301011Z","end":"2026-04-18T09:11:34.566845Z","steps":["trace[952108239] 'agreement among raft nodes before linearized reading' (duration: 265.777663ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:34.566869Z","caller":"traceutil/trace.go:171","msg":"trace[451730544] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:583; }","duration":"204.302293ms","start":"2026-04-18T09:11:34.362558Z","end":"2026-04-18T09:11:34.56686Z","steps":["trace[451730544] 'agreement among raft nodes before linearized reading' (duration: 204.256172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.566929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.537195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.566991Z","caller":"traceutil/trace.go:171","msg":"trace[1536577521] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:583; }","duration":"233.623068ms","start":"2026-04-18T09:11:34.33335Z","end":"2026-04-18T09:11:34.566973Z","steps":["trace[1536577521] 'agreement among raft nodes before linearized reading' (duration: 233.531986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.567009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.008598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.567037Z","caller":"traceutil/trace.go:171","msg":"trace[1431312477] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:583; }","duration":"266.061819ms","start":"2026-04-18T09:11:34.300967Z","end":"2026-04-18T09:11:34.567029Z","steps":["trace[1431312477] 'agreement among raft nodes before linearized reading' (duration: 266.018768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.567151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.364642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.567183Z","caller":"traceutil/trace.go:171","msg":"trace[1426863891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"272.410714ms","start":"2026-04-18T09:11:34.294764Z","end":"2026-04-18T09:11:34.567175Z","steps":["trace[1426863891] 'agreement among raft nodes before linearized reading' (duration: 272.367893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.567208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.885233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:34.567215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.157819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:34.567222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.792375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.567248Z","caller":"traceutil/trace.go:171","msg":"trace[1426296135] 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:583; }","duration":"308.947314ms","start":"2026-04-18T09:11:34.258288Z","end":"2026-04-18T09:11:34.567235Z","steps":["trace[1426296135] 'agreement among raft nodes before linearized reading' (duration: 308.879533ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:34.567253Z","caller":"traceutil/trace.go:171","msg":"trace[1878884175] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:583; }","duration":"204.21314ms","start":"2026-04-18T09:11:34.36303Z","end":"2026-04-18T09:11:34.567243Z","steps":["trace[1878884175] 'agreement among raft nodes before linearized reading' (duration: 204.159339ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:34.567266Z","caller":"traceutil/trace.go:171","msg":"trace[1736710418] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:583; }","duration":"204.839376ms","start":"2026-04-18T09:11:34.362414Z","end":"2026-04-18T09:11:34.567253Z","steps":["trace[1736710418] 'agreement among raft nodes before linearized reading' (duration: 204.769674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.56728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.258277Z","time spent":"308.995596ms","remote":"127.0.0.1:40910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T09:11:34.567321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.12356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.567358Z","caller":"traceutil/trace.go:171","msg":"trace[296189431] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:583; }","duration":"291.176331ms","start":"2026-04-18T09:11:34.276173Z","end":"2026-04-18T09:11:34.567349Z","steps":["trace[296189431] 'agreement among raft nodes before linearized reading' (duration: 291.12614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.567424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.823722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:34.567427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.922579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.567475Z","caller":"traceutil/trace.go:171","msg":"trace[1925566344] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:583; }","duration":"381.899344ms","start":"2026-04-18T09:11:34.185562Z","end":"2026-04-18T09:11:34.567462Z","steps":["trace[1925566344] 'agreement among raft nodes before linearized reading' (duration: 381.816782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.567177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.903264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.567493Z","caller":"traceutil/trace.go:171","msg":"trace[465960667] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:583; }","duration":"292.020902ms","start":"2026-04-18T09:11:34.27546Z","end":"2026-04-18T09:11:34.567481Z","steps":["trace[465960667] 'agreement among raft nodes before linearized reading' (duration: 291.891219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.567519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.185558Z","time spent":"381.948955ms","remote":"127.0.0.1:40886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-18T09:11:34.56757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.984556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.567641Z","caller":"traceutil/trace.go:171","msg":"trace[229143477] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:583; }","duration":"382.061458ms","start":"2026-04-18T09:11:34.185542Z","end":"2026-04-18T09:11:34.567604Z","steps":["trace[229143477] 'agreement among raft nodes before linearized reading' (duration: 381.964346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.567681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.185496Z","time spent":"382.172701ms","remote":"127.0.0.1:40886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T09:11:34.567737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.442386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.567781Z","caller":"traceutil/trace.go:171","msg":"trace[845665058] 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:583; }","duration":"309.517058ms","start":"2026-04-18T09:11:34.258251Z","end":"2026-04-18T09:11:34.567768Z","steps":["trace[845665058] 'agreement among raft nodes before linearized reading' (duration: 309.447746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.567834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.258237Z","time spent":"309.583349ms","remote":"127.0.0.1:40910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-18T09:11:34.56775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.286358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:34.567827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.752187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.567522Z","caller":"traceutil/trace.go:171","msg":"trace[1031049403] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:583; }","duration":"234.270163ms","start":"2026-04-18T09:11:34.333242Z","end":"2026-04-18T09:11:34.567513Z","steps":["trace[1031049403] 'agreement among raft nodes before linearized reading' (duration: 233.901004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.567874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.261918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.567899Z","caller":"traceutil/trace.go:171","msg":"trace[1503722629] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:583; }","duration":"292.455522ms","start":"2026-04-18T09:11:34.275426Z","end":"2026-04-18T09:11:34.567881Z","steps":["trace[1503722629] 'agreement among raft nodes before linearized reading' (duration: 292.269247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.567946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.732387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.567982Z","caller":"traceutil/trace.go:171","msg":"trace[44175295] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"335.778378ms","start":"2026-04-18T09:11:34.232194Z","end":"2026-04-18T09:11:34.567973Z","steps":["trace[44175295] 'agreement among raft nodes before linearized reading' (duration: 335.728507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.56805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.177952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:34.56809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.232189Z","time spent":"335.819239ms","remote":"127.0.0.1:40892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-04-18T09:11:34.5679Z","caller":"traceutil/trace.go:171","msg":"trace[2008291326] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"353.84551ms","start":"2026-04-18T09:11:34.214044Z","end":"2026-04-18T09:11:34.567889Z","steps":["trace[2008291326] 'agreement among raft nodes before linearized reading' (duration: 353.750168ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:34.5681Z","caller":"traceutil/trace.go:171","msg":"trace[1016869520] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"517.402279ms","start":"2026-04-18T09:11:34.050684Z","end":"2026-04-18T09:11:34.568087Z","steps":["trace[1016869520] 'agreement among raft nodes before linearized reading' (duration: 517.110481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.568144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.050622Z","time spent":"517.510722ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-18T09:11:34.568151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.214039Z","time spent":"354.093757ms","remote":"127.0.0.1:40892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-18T09:11:34.568023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.059785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:34.566778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.304781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.568299Z","caller":"traceutil/trace.go:171","msg":"trace[711319984] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:583; }","duration":"266.90054ms","start":"2026-04-18T09:11:34.301386Z","end":"2026-04-18T09:11:34.568286Z","steps":["trace[711319984] 'agreement among raft nodes before linearized reading' (duration: 265.320552ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:34.568293Z","caller":"traceutil/trace.go:171","msg":"trace[1922322551] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"354.369353ms","start":"2026-04-18T09:11:34.213872Z","end":"2026-04-18T09:11:34.568241Z","steps":["trace[1922322551] 'agreement among raft nodes before linearized reading' (duration: 354.013964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.568334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.694922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.568373Z","caller":"traceutil/trace.go:171","msg":"trace[1764719639] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"336.763354ms","start":"2026-04-18T09:11:34.231598Z","end":"2026-04-18T09:11:34.568362Z","steps":["trace[1764719639] 'agreement among raft nodes before linearized reading' (duration: 336.633231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.568366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.28053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:34.568374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.213852Z","time spent":"354.503396ms","remote":"127.0.0.1:40892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-18T09:11:34.567917Z","caller":"traceutil/trace.go:171","msg":"trace[261858660] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:583; }","duration":"381.33798ms","start":"2026-04-18T09:11:34.186567Z","end":"2026-04-18T09:11:34.567905Z","steps":["trace[261858660] 'agreement among raft nodes before linearized reading' (duration: 381.278259ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:34.568416Z","caller":"traceutil/trace.go:171","msg":"trace[1502060978] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"518.373032ms","start":"2026-04-18T09:11:34.050026Z","end":"2026-04-18T09:11:34.568399Z","steps":["trace[1502060978] 'agreement among raft nodes before linearized reading' (duration: 518.29756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.568442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.231584Z","time spent":"336.812855ms","remote":"127.0.0.1:40902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T09:11:34.56845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.186548Z","time spent":"381.887314ms","remote":"127.0.0.1:40886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-18T09:11:34.568455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.356727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:34.56846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.050012Z","time spent":"518.434693ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-18T09:11:34.568489Z","caller":"traceutil/trace.go:171","msg":"trace[593689114] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"592.413338ms","start":"2026-04-18T09:11:33.976067Z","end":"2026-04-18T09:11:34.56848Z","steps":["trace[593689114] 'agreement among raft nodes before linearized reading' (duration: 592.358067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.568519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:33.976055Z","time spent":"592.45592ms","remote":"127.0.0.1:40866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T09:11:34.568665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.468914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:11:34.568691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.067331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:11:34.568719Z","caller":"traceutil/trace.go:171","msg":"trace[45200440] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:583; }","duration":"518.570326ms","start":"2026-04-18T09:11:34.050135Z","end":"2026-04-18T09:11:34.568705Z","steps":["trace[45200440] 'agreement among raft nodes before linearized reading' (duration: 518.488224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.568774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.050111Z","time spent":"518.638568ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-18T09:11:34.568724Z","caller":"traceutil/trace.go:171","msg":"trace[538144284] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:583; }","duration":"337.127653ms","start":"2026-04-18T09:11:34.231586Z","end":"2026-04-18T09:11:34.568714Z","steps":["trace[538144284] 'agreement among raft nodes before linearized reading' (duration: 337.073721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:34.568972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:11:34.231569Z","time spent":"337.377568ms","remote":"127.0.0.1:40902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-18T09:11:48.748988Z","caller":"traceutil/trace.go:171","msg":"trace[1451471628] linearizableReadLoop","detail":"{readStateIndex:769; appliedIndex:768; }","duration":"112.187772ms","start":"2026-04-18T09:11:48.636758Z","end":"2026-04-18T09:11:48.748946Z","steps":["trace[1451471628] 'read index received' (duration: 110.157312ms)","trace[1451471628] 'applied index is now lower than readState.Index' (duration: 2.0289ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:11:48.749056Z","caller":"traceutil/trace.go:171","msg":"trace[2049792234] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"263.93167ms","start":"2026-04-18T09:11:48.485085Z","end":"2026-04-18T09:11:48.749017Z","steps":["trace[2049792234] 'process raft request' (duration: 261.911691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:48.749247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.472218ms","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-04-18T09:11:48.749302Z","caller":"traceutil/trace.go:171","msg":"trace[1518091299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:743; }","duration":"112.568341ms","start":"2026-04-18T09:11:48.636721Z","end":"2026-04-18T09:11:48.74929Z","steps":["trace[1518091299] 'agreement among raft nodes before linearized reading' (duration: 112.419347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:11:48.749471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.463934ms","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-04-18T09:11:48.749454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.414457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-18T09:11:48.749488Z","caller":"traceutil/trace.go:171","msg":"trace[585164005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:743; }","duration":"111.504895ms","start":"2026-04-18T09:11:48.637978Z","end":"2026-04-18T09:11:48.749483Z","steps":["trace[585164005] 'agreement among raft nodes before linearized reading' (duration: 111.456203ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:48.749507Z","caller":"traceutil/trace.go:171","msg":"trace[263102887] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:743; }","duration":"112.614092ms","start":"2026-04-18T09:11:48.636878Z","end":"2026-04-18T09:11:48.749492Z","steps":["trace[263102887] 'agreement among raft nodes before linearized reading' (duration: 112.303804ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:48.88217Z","caller":"traceutil/trace.go:171","msg":"trace[2088004029] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"128.337095ms","start":"2026-04-18T09:11:48.753805Z","end":"2026-04-18T09:11:48.882142Z","steps":["trace[2088004029] 'process raft request' (duration: 128.281274ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:11:48.882328Z","caller":"traceutil/trace.go:171","msg":"trace[349955996] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"129.117425ms","start":"2026-04-18T09:11:48.753171Z","end":"2026-04-18T09:11:48.882288Z","steps":["trace[349955996] 'process raft request' (duration: 128.729816ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:12:31.102767Z","caller":"traceutil/trace.go:171","msg":"trace[926876699] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1281; }","duration":"105.327024ms","start":"2026-04-18T09:12:30.9974Z","end":"2026-04-18T09:12:31.102727Z","steps":["trace[926876699] 'read index received' (duration: 105.024896ms)","trace[926876699] 'applied index is now lower than readState.Index' (duration: 301.018µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:12:31.102805Z","caller":"traceutil/trace.go:171","msg":"trace[1514513372] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"111.033943ms","start":"2026-04-18T09:12:30.991743Z","end":"2026-04-18T09:12:31.102777Z","steps":["trace[1514513372] 'process raft request' (duration: 110.849408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:12:31.102932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.512028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:12:31.102988Z","caller":"traceutil/trace.go:171","msg":"trace[1050121527] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:0; response_revision:1241; }","duration":"105.643931ms","start":"2026-04-18T09:12:30.997332Z","end":"2026-04-18T09:12:31.102976Z","steps":["trace[1050121527] 'agreement among raft nodes before linearized reading' (duration: 105.549259ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:12:32.783769Z","caller":"traceutil/trace.go:171","msg":"trace[2143963785] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1289; }","duration":"371.916498ms","start":"2026-04-18T09:12:32.411831Z","end":"2026-04-18T09:12:32.783748Z","steps":["trace[2143963785] 'read index received' (duration: 371.747724ms)","trace[2143963785] 'applied index is now lower than readState.Index' (duration: 167.604µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:12:32.783959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.987467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-18T09:12:32.783973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.122823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T09:12:32.784005Z","caller":"traceutil/trace.go:171","msg":"trace[1725756787] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1249; }","duration":"236.073259ms","start":"2026-04-18T09:12:32.547919Z","end":"2026-04-18T09:12:32.783992Z","steps":["trace[1725756787] 'agreement among raft nodes before linearized reading' (duration: 235.958846ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:12:32.784049Z","caller":"traceutil/trace.go:171","msg":"trace[1110629498] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1249; }","duration":"372.231895ms","start":"2026-04-18T09:12:32.411799Z","end":"2026-04-18T09:12:32.784031Z","steps":["trace[1110629498] 'agreement among raft nodes before linearized reading' (duration: 372.070531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:12:32.784091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:12:32.411788Z","time spent":"372.293877ms","remote":"127.0.0.1:58330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":31,"response size":29,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-04-18T09:12:32.784083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.434523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:12:32.784204Z","caller":"traceutil/trace.go:171","msg":"trace[317104408] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1249; }","duration":"192.587036ms","start":"2026-04-18T09:12:32.591577Z","end":"2026-04-18T09:12:32.784164Z","steps":["trace[317104408] 'agreement among raft nodes before linearized reading' (duration: 192.381701ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:12:32.783842Z","caller":"traceutil/trace.go:171","msg":"trace[2047419964] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"382.476226ms","start":"2026-04-18T09:12:32.401334Z","end":"2026-04-18T09:12:32.78381Z","steps":["trace[2047419964] 'process raft request' (duration: 382.302791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:12:32.784084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.021679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:12:32.784512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:12:32.40132Z","time spent":"383.137902ms","remote":"127.0.0.1:57952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":369,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T09:12:32.784556Z","caller":"traceutil/trace.go:171","msg":"trace[357028283] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1249; }","duration":"126.575263ms","start":"2026-04-18T09:12:32.657904Z","end":"2026-04-18T09:12:32.78448Z","steps":["trace[357028283] 'agreement among raft nodes before linearized reading' (duration: 125.999929ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:12:33.1006Z","caller":"traceutil/trace.go:171","msg":"trace[1762092298] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"312.554348ms","start":"2026-04-18T09:12:32.788021Z","end":"2026-04-18T09:12:33.100575Z","steps":["trace[1762092298] 'process raft request' (duration: 309.319639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:12:33.100715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:12:32.788004Z","time spent":"312.660061ms","remote":"127.0.0.1:58036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":168,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T09:12:33.101984Z","caller":"traceutil/trace.go:171","msg":"trace[837145280] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"313.684555ms","start":"2026-04-18T09:12:32.788285Z","end":"2026-04-18T09:12:33.10197Z","steps":["trace[837145280] 'process raft request' (duration: 313.586963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:12:33.10206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:12:32.788266Z","time spent":"313.761807ms","remote":"127.0.0.1:57936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T09:12:43.940916Z","caller":"traceutil/trace.go:171","msg":"trace[1890768368] linearizableReadLoop","detail":"{readStateIndex:1459; appliedIndex:1458; }","duration":"278.316777ms","start":"2026-04-18T09:12:43.662565Z","end":"2026-04-18T09:12:43.940882Z","steps":["trace[1890768368] 'read index received' (duration: 182.612026ms)","trace[1890768368] 'applied index is now lower than readState.Index' (duration: 95.703111ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:12:43.941108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.510162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:12:43.941155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.496971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T09:12:43.941219Z","caller":"traceutil/trace.go:171","msg":"trace[1162993683] 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:1414; }","duration":"278.647165ms","start":"2026-04-18T09:12:43.662548Z","end":"2026-04-18T09:12:43.941195Z","steps":["trace[1162993683] 'agreement among raft nodes before linearized reading' (duration: 278.445791ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:12:43.941242Z","caller":"traceutil/trace.go:171","msg":"trace[1484207806] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1414; }","duration":"186.645484ms","start":"2026-04-18T09:12:43.754577Z","end":"2026-04-18T09:12:43.941223Z","steps":["trace[1484207806] 'agreement among raft nodes before linearized reading' (duration: 186.48474ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:12:44.415881Z","caller":"traceutil/trace.go:171","msg":"trace[890924576] linearizableReadLoop","detail":"{readStateIndex:1460; appliedIndex:1459; }","duration":"163.341715ms","start":"2026-04-18T09:12:44.252514Z","end":"2026-04-18T09:12:44.415855Z","steps":["trace[890924576] 'read index received' (duration: 163.178321ms)","trace[890924576] 'applied index is now lower than readState.Index' (duration: 162.254µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:12:44.415951Z","caller":"traceutil/trace.go:171","msg":"trace[1842247383] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"186.517443ms","start":"2026-04-18T09:12:44.229397Z","end":"2026-04-18T09:12:44.415915Z","steps":["trace[1842247383] 'process raft request' (duration: 186.284507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:12:44.416022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.478358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:12:44.41606Z","caller":"traceutil/trace.go:171","msg":"trace[1179376258] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1415; }","duration":"163.56235ms","start":"2026-04-18T09:12:44.252488Z","end":"2026-04-18T09:12:44.41605Z","steps":["trace[1179376258] 'agreement among raft nodes before linearized reading' (duration: 163.474548ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:12:44.424589Z","caller":"traceutil/trace.go:171","msg":"trace[1411145846] transaction","detail":"{read_only:false; response_revision:1416; number_of_response:1; }","duration":"163.862167ms","start":"2026-04-18T09:12:44.260712Z","end":"2026-04-18T09:12:44.424574Z","steps":["trace[1411145846] 'process raft request' (duration: 163.718714ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:07.585021Z","caller":"traceutil/trace.go:171","msg":"trace[1655905714] linearizableReadLoop","detail":"{readStateIndex:1882; appliedIndex:1881; }","duration":"280.41786ms","start":"2026-04-18T09:13:07.304562Z","end":"2026-04-18T09:13:07.58498Z","steps":["trace[1655905714] 'read index received' (duration: 280.168083ms)","trace[1655905714] 'applied index is now lower than readState.Index' (duration: 247.947µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:13:07.585161Z","caller":"traceutil/trace.go:171","msg":"trace[2106739539] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"289.804199ms","start":"2026-04-18T09:13:07.295308Z","end":"2026-04-18T09:13:07.585112Z","steps":["trace[2106739539] 'process raft request' (duration: 289.405568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:07.585447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.84224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-18T09:13:07.585504Z","caller":"traceutil/trace.go:171","msg":"trace[497338279] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1811; }","duration":"280.945753ms","start":"2026-04-18T09:13:07.304543Z","end":"2026-04-18T09:13:07.585489Z","steps":["trace[497338279] 'agreement among raft nodes before linearized reading' (duration: 280.702077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:07.585569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.778625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-578d82bf-2aee-401a-ad10-e871b40253d9\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-18T09:13:07.585715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.369561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-578d82bf-2aee-401a-ad10-e871b40253d9\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-18T09:13:07.585677Z","caller":"traceutil/trace.go:171","msg":"trace[455052958] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-578d82bf-2aee-401a-ad10-e871b40253d9; range_end:; response_count:1; response_revision:1811; }","duration":"174.95301ms","start":"2026-04-18T09:13:07.410693Z","end":"2026-04-18T09:13:07.585646Z","steps":["trace[455052958] 'agreement among raft nodes before linearized reading' (duration: 174.661223ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:07.585779Z","caller":"traceutil/trace.go:171","msg":"trace[373449058] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-578d82bf-2aee-401a-ad10-e871b40253d9; range_end:; response_count:1; response_revision:1811; }","duration":"247.484524ms","start":"2026-04-18T09:13:07.338269Z","end":"2026-04-18T09:13:07.585753Z","steps":["trace[373449058] 'agreement among raft nodes before linearized reading' (duration: 247.239918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:07.585833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.603424ms","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-04-18T09:13:07.585814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.297272ms","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-04-18T09:13:07.585915Z","caller":"traceutil/trace.go:171","msg":"trace[1651991958] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1811; }","duration":"157.733858ms","start":"2026-04-18T09:13:07.428161Z","end":"2026-04-18T09:13:07.585895Z","steps":["trace[1651991958] 'agreement among raft nodes before linearized reading' (duration: 157.477001ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:07.585983Z","caller":"traceutil/trace.go:171","msg":"trace[800913365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1811; }","duration":"277.510488ms","start":"2026-04-18T09:13:07.308403Z","end":"2026-04-18T09:13:07.585913Z","steps":["trace[800913365] 'agreement among raft nodes before linearized reading' (duration: 277.16929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:07.586184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.236866ms","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-04-18T09:13:07.586264Z","caller":"traceutil/trace.go:171","msg":"trace[246815725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1811; }","duration":"278.365578ms","start":"2026-04-18T09:13:07.307878Z","end":"2026-04-18T09:13:07.586243Z","steps":["trace[246815725] 'agreement among raft nodes before linearized reading' (duration: 277.428785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:08.728921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.574741ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:13:08.729117Z","caller":"traceutil/trace.go:171","msg":"trace[1361916114] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"1.138547839s","start":"2026-04-18T09:13:07.590546Z","end":"2026-04-18T09:13:08.729094Z","steps":["trace[1361916114] 'process raft request' (duration: 936.697742ms)","trace[1361916114] 'compare' (duration: 201.331815ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:13:08.729505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:07.590518Z","time spent":"1.138930709s","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:08.813444Z","caller":"traceutil/trace.go:171","msg":"trace[1768385479] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"1.222300198s","start":"2026-04-18T09:13:07.591114Z","end":"2026-04-18T09:13:08.813414Z","steps":["trace[1768385479] 'process raft request' (duration: 1.221921938s)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:08.813464Z","caller":"traceutil/trace.go:171","msg":"trace[964555262] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"1.222246416s","start":"2026-04-18T09:13:07.591192Z","end":"2026-04-18T09:13:08.813439Z","steps":["trace[964555262] 'process raft request' (duration: 1.222044891s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:08.813612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:07.591081Z","time spent":"1.22244481s","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:13:08.813727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:07.591186Z","time spent":"1.222434591s","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:08.813766Z","caller":"traceutil/trace.go:171","msg":"trace[566244362] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"1.218109995s","start":"2026-04-18T09:13:07.595618Z","end":"2026-04-18T09:13:08.813728Z","steps":["trace[566244362] 'process raft request' (duration: 1.217769087s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:08.813882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:07.595608Z","time spent":"1.218219598s","remote":"127.0.0.1:58014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:08.813531Z","caller":"traceutil/trace.go:171","msg":"trace[2130815667] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"1.22160459s","start":"2026-04-18T09:13:07.591872Z","end":"2026-04-18T09:13:08.813477Z","steps":["trace[2130815667] 'process raft request' (duration: 1.221468777s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:08.814035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:07.591862Z","time spent":"1.222079811s","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:08.814314Z","caller":"traceutil/trace.go:171","msg":"trace[865901126] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"749.860431ms","start":"2026-04-18T09:13:08.064441Z","end":"2026-04-18T09:13:08.814302Z","steps":["trace[865901126] 'process raft request' (duration: 749.054322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:08.814452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:08.064426Z","time spent":"749.953853ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:08.814471Z","caller":"traceutil/trace.go:171","msg":"trace[1869596885] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"306.953108ms","start":"2026-04-18T09:13:08.507504Z","end":"2026-04-18T09:13:08.814457Z","steps":["trace[1869596885] 'process raft request' (duration: 306.672351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:08.8146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:08.50748Z","time spent":"307.07536ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:08.815023Z","caller":"traceutil/trace.go:171","msg":"trace[701218418] linearizableReadLoop","detail":"{readStateIndex:1888; appliedIndex:1882; }","duration":"636.95984ms","start":"2026-04-18T09:13:08.177293Z","end":"2026-04-18T09:13:08.814253Z","steps":["trace[701218418] 'read index received' (duration: 350.006191ms)","trace[701218418] 'applied index is now lower than readState.Index' (duration: 286.952799ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:13:08.814766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.462982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T09:13:08.815321Z","caller":"traceutil/trace.go:171","msg":"trace[1660004677] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:1818; }","duration":"638.051047ms","start":"2026-04-18T09:13:08.177252Z","end":"2026-04-18T09:13:08.815303Z","steps":["trace[1660004677] 'agreement among raft nodes before linearized reading' (duration: 637.347829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:08.815374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:08.177239Z","time spent":"638.121648ms","remote":"127.0.0.1:57874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.155\" "} {"level":"warn","ts":"2026-04-18T09:13:09.051988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.062979ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:13:09.052174Z","caller":"traceutil/trace.go:171","msg":"trace[908220268] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"387.206141ms","start":"2026-04-18T09:13:08.664932Z","end":"2026-04-18T09:13:09.052138Z","steps":["trace[908220268] 'process raft request' (duration: 185.854535ms)","trace[908220268] 'compare' (duration: 200.861254ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:13:09.052332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:08.664908Z","time spent":"387.342694ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:09.052342Z","caller":"traceutil/trace.go:171","msg":"trace[1641200627] linearizableReadLoop","detail":"{readStateIndex:1890; appliedIndex:1889; }","duration":"237.225582ms","start":"2026-04-18T09:13:08.815083Z","end":"2026-04-18T09:13:09.052309Z","steps":["trace[1641200627] 'read index received' (duration: 35.669152ms)","trace[1641200627] 'applied index is now lower than readState.Index' (duration: 201.55328ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:13:09.05247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.795273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-18T09:13:09.052575Z","caller":"traceutil/trace.go:171","msg":"trace[530933784] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1819; }","duration":"512.950037ms","start":"2026-04-18T09:13:08.539611Z","end":"2026-04-18T09:13:09.052561Z","steps":["trace[530933784] 'agreement among raft nodes before linearized reading' (duration: 512.716891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:09.052507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.440719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:13:09.052614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:08.539592Z","time spent":"513.013208ms","remote":"127.0.0.1:58100","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":"warn","ts":"2026-04-18T09:13:09.052598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.507246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-18T09:13:09.052649Z","caller":"traceutil/trace.go:171","msg":"trace[1736276924] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1819; }","duration":"318.612843ms","start":"2026-04-18T09:13:08.734013Z","end":"2026-04-18T09:13:09.052626Z","steps":["trace[1736276924] 'agreement among raft nodes before linearized reading' (duration: 318.398557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:09.052719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:08.734004Z","time spent":"318.704364ms","remote":"127.0.0.1:58048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-04-18T09:13:09.05274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.095226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-04-18T09:13:09.052775Z","caller":"traceutil/trace.go:171","msg":"trace[771773228] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1819; }","duration":"234.153017ms","start":"2026-04-18T09:13:08.818613Z","end":"2026-04-18T09:13:09.052766Z","steps":["trace[771773228] 'agreement among raft nodes before linearized reading' (duration: 234.032494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:09.052774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.319719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-578d82bf-2aee-401a-ad10-e871b40253d9\" ","response":"range_response_count:1 size:3744"} {"level":"warn","ts":"2026-04-18T09:13:09.052667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.162857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:13:09.052819Z","caller":"traceutil/trace.go:171","msg":"trace[1648541465] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-578d82bf-2aee-401a-ad10-e871b40253d9; range_end:; response_count:1; response_revision:1819; }","duration":"462.36068ms","start":"2026-04-18T09:13:08.590445Z","end":"2026-04-18T09:13:09.052806Z","steps":["trace[1648541465] 'agreement among raft nodes before linearized reading' (duration: 462.257427ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:09.052833Z","caller":"traceutil/trace.go:171","msg":"trace[211971907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1819; }","duration":"761.367182ms","start":"2026-04-18T09:13:08.291454Z","end":"2026-04-18T09:13:09.052821Z","steps":["trace[211971907] 'agreement among raft nodes before linearized reading' (duration: 761.112016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:09.052842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.997146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-04-18T09:13:09.052869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:08.291443Z","time spent":"761.416673ms","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T09:13:09.052868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:08.590373Z","time spent":"462.483282ms","remote":"127.0.0.1:58014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3766,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-578d82bf-2aee-401a-ad10-e871b40253d9\" "} {"level":"info","ts":"2026-04-18T09:13:09.052884Z","caller":"traceutil/trace.go:171","msg":"trace[1513172968] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1819; }","duration":"416.150289ms","start":"2026-04-18T09:13:08.636717Z","end":"2026-04-18T09:13:09.052868Z","steps":["trace[1513172968] 'agreement among raft nodes before linearized reading' (duration: 415.999406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:09.052751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.90836ms","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-04-18T09:13:09.052988Z","caller":"traceutil/trace.go:171","msg":"trace[1758545205] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1819; }","duration":"460.172897ms","start":"2026-04-18T09:13:08.592795Z","end":"2026-04-18T09:13:09.052968Z","steps":["trace[1758545205] 'agreement among raft nodes before linearized reading' (duration: 459.5186ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:09.052664Z","caller":"traceutil/trace.go:171","msg":"trace[1836925537] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1819; }","duration":"631.622539ms","start":"2026-04-18T09:13:08.421021Z","end":"2026-04-18T09:13:09.052643Z","steps":["trace[1836925537] 'agreement among raft nodes before linearized reading' (duration: 631.318242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:09.053092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:08.420998Z","time spent":"632.085162ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-18T09:13:09.052924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:08.636706Z","time spent":"416.210362ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-18T09:13:09.053069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:08.592784Z","time spent":"460.271299ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-18T09:13:09.348566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.67585ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:13:09.348855Z","caller":"traceutil/trace.go:171","msg":"trace[1108677855] linearizableReadLoop","detail":"{readStateIndex:1892; appliedIndex:1891; }","duration":"294.604456ms","start":"2026-04-18T09:13:09.054237Z","end":"2026-04-18T09:13:09.348841Z","steps":["trace[1108677855] 'read index received' (duration: 133.570928ms)","trace[1108677855] 'applied index is now lower than readState.Index' (duration: 161.032228ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:13:09.349017Z","caller":"traceutil/trace.go:171","msg":"trace[113321071] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"291.763986ms","start":"2026-04-18T09:13:09.057219Z","end":"2026-04-18T09:13:09.348983Z","steps":["trace[113321071] 'process raft request' (duration: 291.540771ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:09.349037Z","caller":"traceutil/trace.go:171","msg":"trace[792929416] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"291.51602ms","start":"2026-04-18T09:13:09.057499Z","end":"2026-04-18T09:13:09.349015Z","steps":["trace[792929416] 'process raft request' (duration: 291.333696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:09.349089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.845701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:13:09.349099Z","caller":"traceutil/trace.go:171","msg":"trace[460600995] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"290.752301ms","start":"2026-04-18T09:13:09.058315Z","end":"2026-04-18T09:13:09.349068Z","steps":["trace[460600995] 'process raft request' (duration: 290.572017ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:09.349165Z","caller":"traceutil/trace.go:171","msg":"trace[1953550072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1823; }","duration":"294.937514ms","start":"2026-04-18T09:13:09.054184Z","end":"2026-04-18T09:13:09.349122Z","steps":["trace[1953550072] 'agreement among raft nodes before linearized reading' (duration: 294.762769ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:09.349385Z","caller":"traceutil/trace.go:171","msg":"trace[1219608316] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"286.57717ms","start":"2026-04-18T09:13:09.062756Z","end":"2026-04-18T09:13:09.349333Z","steps":["trace[1219608316] 'process raft request' (duration: 286.18054ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:09.348807Z","caller":"traceutil/trace.go:171","msg":"trace[819681493] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"294.851051ms","start":"2026-04-18T09:13:09.053929Z","end":"2026-04-18T09:13:09.34878Z","steps":["trace[819681493] 'process raft request' (duration: 133.785452ms)","trace[819681493] 'compare' (duration: 160.441144ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:13:09.852695Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389696175274736966,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T09:13:10.09839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.463474ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:13:10.098526Z","caller":"traceutil/trace.go:171","msg":"trace[1639320820] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"829.10946ms","start":"2026-04-18T09:13:09.269392Z","end":"2026-04-18T09:13:10.098501Z","steps":["trace[1639320820] 'process raft request' (duration: 621.41798ms)","trace[1639320820] 'compare' (duration: 207.311811ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:13:10.098584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:09.269371Z","time spent":"829.189302ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:10.116408Z","caller":"traceutil/trace.go:171","msg":"trace[1053646338] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"761.111007ms","start":"2026-04-18T09:13:09.355272Z","end":"2026-04-18T09:13:10.116383Z","steps":["trace[1053646338] 'process raft request' (duration: 760.917002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:10.1166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:09.355254Z","time spent":"761.23292ms","remote":"127.0.0.1:58102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:10.116692Z","caller":"traceutil/trace.go:171","msg":"trace[277177026] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"761.348193ms","start":"2026-04-18T09:13:09.355328Z","end":"2026-04-18T09:13:10.116676Z","steps":["trace[277177026] 'process raft request' (duration: 760.996634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:10.116763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:09.355299Z","time spent":"761.424395ms","remote":"127.0.0.1:58006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:10.116997Z","caller":"traceutil/trace.go:171","msg":"trace[1060879043] linearizableReadLoop","detail":"{readStateIndex:1902; appliedIndex:1896; }","duration":"765.044703ms","start":"2026-04-18T09:13:09.351938Z","end":"2026-04-18T09:13:10.116983Z","steps":["trace[1060879043] 'read index received' (duration: 538.978554ms)","trace[1060879043] 'applied index is now lower than readState.Index' (duration: 226.065709ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:13:10.117047Z","caller":"traceutil/trace.go:171","msg":"trace[108616461] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"761.038845ms","start":"2026-04-18T09:13:09.355998Z","end":"2026-04-18T09:13:10.117037Z","steps":["trace[108616461] 'process raft request' (duration: 760.595134ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:10.117024Z","caller":"traceutil/trace.go:171","msg":"trace[153526086] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"760.85736ms","start":"2026-04-18T09:13:09.356138Z","end":"2026-04-18T09:13:10.116995Z","steps":["trace[153526086] 'process raft request' (duration: 760.710486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:10.117126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.943738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:13:10.117133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:09.355977Z","time spent":"761.122376ms","remote":"127.0.0.1:58102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:10.117151Z","caller":"traceutil/trace.go:171","msg":"trace[1812885069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1830; }","duration":"758.01521ms","start":"2026-04-18T09:13:09.359129Z","end":"2026-04-18T09:13:10.117144Z","steps":["trace[1812885069] 'agreement among raft nodes before linearized reading' (duration: 757.964979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:10.11717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:09.359117Z","time spent":"758.049141ms","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T09:13:10.117184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:09.356112Z","time spent":"761.012864ms","remote":"127.0.0.1:58006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:13:10.117192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.235268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-04-18T09:13:10.117275Z","caller":"traceutil/trace.go:171","msg":"trace[1106105106] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1830; }","duration":"765.388091ms","start":"2026-04-18T09:13:09.351868Z","end":"2026-04-18T09:13:10.117256Z","steps":["trace[1106105106] 'agreement among raft nodes before linearized reading' (duration: 765.198506ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:10.1173Z","caller":"traceutil/trace.go:171","msg":"trace[1255975103] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"684.428781ms","start":"2026-04-18T09:13:09.432859Z","end":"2026-04-18T09:13:10.117287Z","steps":["trace[1255975103] 'process raft request' (duration: 684.068742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:10.117319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:09.351838Z","time spent":"765.471643ms","remote":"127.0.0.1:58006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-04-18T09:13:10.117352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:09.432813Z","time spent":"684.510523ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:13:10.117394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.60624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-18T09:13:10.117415Z","caller":"traceutil/trace.go:171","msg":"trace[163975972] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1830; }","duration":"526.667503ms","start":"2026-04-18T09:13:09.590742Z","end":"2026-04-18T09:13:10.11741Z","steps":["trace[163975972] 'agreement among raft nodes before linearized reading' (duration: 526.55873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:10.11743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:09.590722Z","time spent":"526.704864ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-18T09:13:21.882067Z","caller":"traceutil/trace.go:171","msg":"trace[647981402] linearizableReadLoop","detail":"{readStateIndex:2002; appliedIndex:2001; }","duration":"467.355642ms","start":"2026-04-18T09:13:21.414686Z","end":"2026-04-18T09:13:21.882042Z","steps":["trace[647981402] 'read index received' (duration: 467.093315ms)","trace[647981402] 'applied index is now lower than readState.Index' (duration: 261.206µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:13:21.882129Z","caller":"traceutil/trace.go:171","msg":"trace[1469597702] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"469.139225ms","start":"2026-04-18T09:13:21.412964Z","end":"2026-04-18T09:13:21.882103Z","steps":["trace[1469597702] 'process raft request' (duration: 468.92088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:21.882242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.301041ms","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":"warn","ts":"2026-04-18T09:13:21.882268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.566127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-18T09:13:21.882284Z","caller":"traceutil/trace.go:171","msg":"trace[824826099] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:1927; }","duration":"178.407234ms","start":"2026-04-18T09:13:21.703865Z","end":"2026-04-18T09:13:21.882272Z","steps":["trace[824826099] 'agreement among raft nodes before linearized reading' (duration: 178.315782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:21.882281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:21.412933Z","time spent":"469.263737ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:21.882343Z","caller":"traceutil/trace.go:171","msg":"trace[1969447139] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1927; }","duration":"467.648169ms","start":"2026-04-18T09:13:21.414662Z","end":"2026-04-18T09:13:21.88231Z","steps":["trace[1969447139] 'agreement among raft nodes before linearized reading' (duration: 467.469825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:21.882382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:21.414651Z","time spent":"467.72228ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-18T09:13:22.158588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.482781ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:13:22.158739Z","caller":"traceutil/trace.go:171","msg":"trace[784055985] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"271.202113ms","start":"2026-04-18T09:13:21.887488Z","end":"2026-04-18T09:13:22.15869Z","steps":["trace[784055985] 'process raft request' (duration: 111.530458ms)","trace[784055985] 'compare' (duration: 159.240365ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:13:25.016228Z","caller":"traceutil/trace.go:171","msg":"trace[864921782] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"116.367867ms","start":"2026-04-18T09:13:24.899832Z","end":"2026-04-18T09:13:25.0162Z","steps":["trace[864921782] 'process raft request' (duration: 116.188862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:25.243352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.848165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-18T09:13:25.24343Z","caller":"traceutil/trace.go:171","msg":"trace[1619678706] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1953; }","duration":"335.972528ms","start":"2026-04-18T09:13:24.907428Z","end":"2026-04-18T09:13:25.2434Z","steps":["trace[1619678706] 'agreement among raft nodes before linearized reading' (duration: 335.787573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:25.243462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:24.907408Z","time spent":"336.04712ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-18T09:13:25.243178Z","caller":"traceutil/trace.go:171","msg":"trace[1753408613] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"341.769339ms","start":"2026-04-18T09:13:24.901389Z","end":"2026-04-18T09:13:25.243158Z","steps":["trace[1753408613] 'process raft request' (duration: 341.581254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:25.243654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:24.90137Z","time spent":"342.22601ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:25.243736Z","caller":"traceutil/trace.go:171","msg":"trace[2136967255] linearizableReadLoop","detail":"{readStateIndex:2029; appliedIndex:2027; }","duration":"335.6216ms","start":"2026-04-18T09:13:24.907492Z","end":"2026-04-18T09:13:25.243113Z","steps":["trace[2136967255] 'read index received' (duration: 108.494484ms)","trace[2136967255] 'applied index is now lower than readState.Index' (duration: 227.126186ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:13:25.24456Z","caller":"traceutil/trace.go:171","msg":"trace[821016089] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"115.956675ms","start":"2026-04-18T09:13:25.128584Z","end":"2026-04-18T09:13:25.244541Z","steps":["trace[821016089] 'process raft request' (duration: 115.841842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:25.244628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.864325ms","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-04-18T09:13:25.244634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.960738ms","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-04-18T09:13:25.244653Z","caller":"traceutil/trace.go:171","msg":"trace[963374846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1955; }","duration":"315.913307ms","start":"2026-04-18T09:13:24.928733Z","end":"2026-04-18T09:13:25.244646Z","steps":["trace[963374846] 'agreement among raft nodes before linearized reading' (duration: 315.840945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:25.24467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:24.928717Z","time spent":"315.949557ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-18T09:13:25.244673Z","caller":"traceutil/trace.go:171","msg":"trace[1177147842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1955; }","duration":"316.046139ms","start":"2026-04-18T09:13:24.928616Z","end":"2026-04-18T09:13:25.244662Z","steps":["trace[1177147842] 'agreement among raft nodes before linearized reading' (duration: 315.875065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:25.244697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:24.9286Z","time spent":"316.092181ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-18T09:13:25.244776Z","caller":"traceutil/trace.go:171","msg":"trace[127242217] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"142.125945ms","start":"2026-04-18T09:13:25.102636Z","end":"2026-04-18T09:13:25.244762Z","steps":["trace[127242217] 'process raft request' (duration: 141.676565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:26.393828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049598712s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:13:26.394264Z","caller":"traceutil/trace.go:171","msg":"trace[1959962416] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"1.1471592s","start":"2026-04-18T09:13:25.247077Z","end":"2026-04-18T09:13:26.394236Z","steps":["trace[1959962416] 'process raft request' (duration: 96.623484ms)","trace[1959962416] 'compare' (duration: 1.04947123s)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:13:26.394365Z","caller":"traceutil/trace.go:171","msg":"trace[1960105157] transaction","detail":"{read_only:false; response_revision:1957; number_of_response:1; }","duration":"1.145215392s","start":"2026-04-18T09:13:25.249134Z","end":"2026-04-18T09:13:26.39435Z","steps":["trace[1960105157] 'process raft request' (duration: 1.144811892s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:26.394453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:25.249117Z","time spent":"1.145293963s","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:13:26.394366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:25.24706Z","time spent":"1.147263022s","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:13:26.394584Z","caller":"traceutil/trace.go:171","msg":"trace[1729455405] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"1.14516242s","start":"2026-04-18T09:13:25.249402Z","end":"2026-04-18T09:13:26.394565Z","steps":["trace[1729455405] 'process raft request' (duration: 1.144917994s)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:26.39456Z","caller":"traceutil/trace.go:171","msg":"trace[18312122] linearizableReadLoop","detail":"{readStateIndex:2034; appliedIndex:2031; }","duration":"494.843134ms","start":"2026-04-18T09:13:25.899689Z","end":"2026-04-18T09:13:26.394532Z","steps":["trace[18312122] 'read index received' (duration: 35.701µs)","trace[18312122] 'applied index is now lower than readState.Index' (duration: 494.805683ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:13:26.394688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:25.249396Z","time spent":"1.145236713s","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:13:26.394797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.019365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:13:26.394826Z","caller":"traceutil/trace.go:171","msg":"trace[1482675315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1958; }","duration":"104.051835ms","start":"2026-04-18T09:13:26.290767Z","end":"2026-04-18T09:13:26.394819Z","steps":["trace[1482675315] 'agreement among raft nodes before linearized reading' (duration: 104.009254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:26.39484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.296633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-18T09:13:26.39488Z","caller":"traceutil/trace.go:171","msg":"trace[1012501295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1958; }","duration":"156.356454ms","start":"2026-04-18T09:13:26.238512Z","end":"2026-04-18T09:13:26.394868Z","steps":["trace[1012501295] 'agreement among raft nodes before linearized reading' (duration: 156.221931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:26.394922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.069983ms","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-04-18T09:13:26.395025Z","caller":"traceutil/trace.go:171","msg":"trace[1296895173] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1958; }","duration":"144.202067ms","start":"2026-04-18T09:13:26.250798Z","end":"2026-04-18T09:13:26.395Z","steps":["trace[1296895173] 'agreement among raft nodes before linearized reading' (duration: 143.92763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:26.395139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.727929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"warn","ts":"2026-04-18T09:13:26.39513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.953404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11982"} {"level":"info","ts":"2026-04-18T09:13:26.395169Z","caller":"traceutil/trace.go:171","msg":"trace[333477467] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1958; }","duration":"220.799971ms","start":"2026-04-18T09:13:26.174362Z","end":"2026-04-18T09:13:26.395162Z","steps":["trace[333477467] 'agreement among raft nodes before linearized reading' (duration: 220.37885ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:26.395216Z","caller":"traceutil/trace.go:171","msg":"trace[2033187510] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1958; }","duration":"221.064227ms","start":"2026-04-18T09:13:26.174105Z","end":"2026-04-18T09:13:26.39517Z","steps":["trace[2033187510] 'agreement among raft nodes before linearized reading' (duration: 220.622896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:26.395323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.633203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-18T09:13:26.395394Z","caller":"traceutil/trace.go:171","msg":"trace[1518776089] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1958; }","duration":"495.739696ms","start":"2026-04-18T09:13:25.899637Z","end":"2026-04-18T09:13:26.395376Z","steps":["trace[1518776089] 'agreement among raft nodes before linearized reading' (duration: 495.036649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:26.395446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:25.899616Z","time spent":"495.815617ms","remote":"127.0.0.1:58100","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-04-18T09:13:58.674573Z","caller":"traceutil/trace.go:171","msg":"trace[1311166772] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"120.218819ms","start":"2026-04-18T09:13:58.554313Z","end":"2026-04-18T09:13:58.674532Z","steps":["trace[1311166772] 'process raft request' (duration: 119.997804ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:59.024199Z","caller":"traceutil/trace.go:171","msg":"trace[1264240714] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"469.501151ms","start":"2026-04-18T09:13:58.554665Z","end":"2026-04-18T09:13:59.024166Z","steps":["trace[1264240714] 'process raft request' (duration: 469.294166ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:59.024317Z","caller":"traceutil/trace.go:171","msg":"trace[1460361185] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2215; }","duration":"450.682242ms","start":"2026-04-18T09:13:58.57361Z","end":"2026-04-18T09:13:59.024292Z","steps":["trace[1460361185] 'read index received' (duration: 100.662483ms)","trace[1460361185] 'applied index is now lower than readState.Index' (duration: 350.018069ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:13:59.024342Z","caller":"traceutil/trace.go:171","msg":"trace[776431507] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"469.606572ms","start":"2026-04-18T09:13:58.554713Z","end":"2026-04-18T09:13:59.024319Z","steps":["trace[776431507] 'process raft request' (duration: 469.406977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:59.024418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:58.554705Z","time spent":"469.662824ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:13:59.024417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:58.554655Z","time spent":"469.647654ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:13:59.024533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.926047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-18T09:13:59.024576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.945608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:13:59.024594Z","caller":"traceutil/trace.go:171","msg":"trace[755069972] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2135; }","duration":"450.988689ms","start":"2026-04-18T09:13:58.573597Z","end":"2026-04-18T09:13:59.024586Z","steps":["trace[755069972] 'agreement among raft nodes before linearized reading' (duration: 450.779344ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:59.024606Z","caller":"traceutil/trace.go:171","msg":"trace[606469731] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2135; }","duration":"379.99978ms","start":"2026-04-18T09:13:58.644596Z","end":"2026-04-18T09:13:59.024596Z","steps":["trace[606469731] 'agreement among raft nodes before linearized reading' (duration: 379.947949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:59.024632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:58.573561Z","time spent":"451.05932ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-18T09:13:59.024635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:58.644579Z","time spent":"380.048151ms","remote":"127.0.0.1:58118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-04-18T09:13:59.02472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.498453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-04-18T09:13:59.024822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.062352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-18T09:13:59.024909Z","caller":"traceutil/trace.go:171","msg":"trace[1678932365] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2135; }","duration":"440.198336ms","start":"2026-04-18T09:13:58.584691Z","end":"2026-04-18T09:13:59.024889Z","steps":["trace[1678932365] 'agreement among raft nodes before linearized reading' (duration: 439.836457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:59.02497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:58.584678Z","time spent":"440.281708ms","remote":"127.0.0.1:58100","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-04-18T09:13:59.024856Z","caller":"traceutil/trace.go:171","msg":"trace[743376824] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2135; }","duration":"440.705127ms","start":"2026-04-18T09:13:58.584125Z","end":"2026-04-18T09:13:59.02483Z","steps":["trace[743376824] 'agreement among raft nodes before linearized reading' (duration: 440.312428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:59.02472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.126451ms","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-04-18T09:13:59.025076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:58.584101Z","time spent":"440.962174ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-04-18T09:13:59.02513Z","caller":"traceutil/trace.go:171","msg":"trace[1360216688] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2135; }","duration":"405.530361ms","start":"2026-04-18T09:13:58.61954Z","end":"2026-04-18T09:13:59.02507Z","steps":["trace[1360216688] 'agreement among raft nodes before linearized reading' (duration: 404.964198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:13:59.025284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:13:58.619527Z","time spent":"405.711195ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-18T09:13:59.526571Z","caller":"traceutil/trace.go:171","msg":"trace[371363061] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"162.737635ms","start":"2026-04-18T09:13:59.363803Z","end":"2026-04-18T09:13:59.526541Z","steps":["trace[371363061] 'process raft request' (duration: 162.565101ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:13:59.543671Z","caller":"traceutil/trace.go:171","msg":"trace[1376380901] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"178.776916ms","start":"2026-04-18T09:13:59.364872Z","end":"2026-04-18T09:13:59.543649Z","steps":["trace[1376380901] 'process raft request' (duration: 178.658453ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:14:04.942591Z","caller":"traceutil/trace.go:171","msg":"trace[1549079032] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"239.986277ms","start":"2026-04-18T09:14:04.702565Z","end":"2026-04-18T09:14:04.942551Z","steps":["trace[1549079032] 'process raft request' (duration: 239.742141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:05.456608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.364101ms","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-04-18T09:14:05.456628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.816812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-18T09:14:05.456699Z","caller":"traceutil/trace.go:171","msg":"trace[1788886579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2165; }","duration":"408.523164ms","start":"2026-04-18T09:14:05.048157Z","end":"2026-04-18T09:14:05.45668Z","steps":["trace[1788886579] 'range keys from in-memory index tree' (duration: 408.260058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:05.456717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.814714ms","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-04-18T09:14:05.456751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:05.048136Z","time spent":"408.604416ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-18T09:14:05.456737Z","caller":"traceutil/trace.go:171","msg":"trace[218321611] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2165; }","duration":"335.983626ms","start":"2026-04-18T09:14:05.120728Z","end":"2026-04-18T09:14:05.456711Z","steps":["trace[218321611] 'range keys from in-memory index tree' (duration: 335.518945ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:14:05.456798Z","caller":"traceutil/trace.go:171","msg":"trace[1783506145] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2165; }","duration":"388.928967ms","start":"2026-04-18T09:14:05.06785Z","end":"2026-04-18T09:14:05.456779Z","steps":["trace[1783506145] 'range keys from in-memory index tree' (duration: 388.63473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:05.456817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:05.120707Z","time spent":"336.0976ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-18T09:14:05.456851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:05.067834Z","time spent":"389.006358ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-18T09:14:05.457033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.004172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-18T09:14:05.457077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.303784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-18T09:14:05.457097Z","caller":"traceutil/trace.go:171","msg":"trace[840481402] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2165; }","duration":"408.109274ms","start":"2026-04-18T09:14:05.048974Z","end":"2026-04-18T09:14:05.457084Z","steps":["trace[840481402] 'range keys from in-memory index tree' (duration: 407.829158ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:14:05.457111Z","caller":"traceutil/trace.go:171","msg":"trace[1063390557] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2165; }","duration":"336.383906ms","start":"2026-04-18T09:14:05.120715Z","end":"2026-04-18T09:14:05.457099Z","steps":["trace[1063390557] 'range keys from in-memory index tree' (duration: 336.14134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:05.457092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.958806ms","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-04-18T09:14:05.457127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:05.04895Z","time spent":"408.169965ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-18T09:14:05.45714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:05.12069Z","time spent":"336.443388ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":576,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-04-18T09:14:05.457161Z","caller":"traceutil/trace.go:171","msg":"trace[534480093] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2165; }","duration":"336.085329ms","start":"2026-04-18T09:14:05.121058Z","end":"2026-04-18T09:14:05.457143Z","steps":["trace[534480093] 'range keys from in-memory index tree' (duration: 335.541626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:05.457352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:05.121037Z","time spent":"336.301684ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-18T09:14:05.457438Z","caller":"traceutil/trace.go:171","msg":"trace[176085515] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"262.632009ms","start":"2026-04-18T09:14:05.194791Z","end":"2026-04-18T09:14:05.457423Z","steps":["trace[176085515] 'process raft request' (duration: 185.698965ms)","trace[176085515] 'compare' (duration: 76.769021ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:14:06.109851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.01305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:14:06.109939Z","caller":"traceutil/trace.go:171","msg":"trace[1927472675] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2174; }","duration":"238.161813ms","start":"2026-04-18T09:14:05.871758Z","end":"2026-04-18T09:14:06.10992Z","steps":["trace[1927472675] 'range keys from in-memory index tree' (duration: 237.925817ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:14:07.425242Z","caller":"traceutil/trace.go:171","msg":"trace[524177172] linearizableReadLoop","detail":"{readStateIndex:2260; appliedIndex:2259; }","duration":"420.542328ms","start":"2026-04-18T09:14:07.004675Z","end":"2026-04-18T09:14:07.425218Z","steps":["trace[524177172] 'read index received' (duration: 420.319062ms)","trace[524177172] 'applied index is now lower than readState.Index' (duration: 222.206µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:14:07.425403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.710622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:14:07.425438Z","caller":"traceutil/trace.go:171","msg":"trace[1560323548] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2175; }","duration":"420.817064ms","start":"2026-04-18T09:14:07.004611Z","end":"2026-04-18T09:14:07.425428Z","steps":["trace[1560323548] 'agreement among raft nodes before linearized reading' (duration: 420.708011ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:14:07.425446Z","caller":"traceutil/trace.go:171","msg":"trace[1091060048] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"473.664282ms","start":"2026-04-18T09:14:06.951755Z","end":"2026-04-18T09:14:07.42542Z","steps":["trace[1091060048] 'process raft request' (duration: 473.312082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:07.425481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:07.004583Z","time spent":"420.887586ms","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T09:14:07.425576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:06.951735Z","time spent":"473.765745ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:14:07.973651Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389696175274737805,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T09:14:08.224204Z","caller":"traceutil/trace.go:171","msg":"trace[504979203] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"760.757938ms","start":"2026-04-18T09:14:07.463421Z","end":"2026-04-18T09:14:08.224179Z","steps":["trace[504979203] 'process raft request' (duration: 731.395872ms)","trace[504979203] 'compare' (duration: 28.968986ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:14:08.224361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:07.463392Z","time spent":"760.88191ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:14:08.358494Z","caller":"traceutil/trace.go:171","msg":"trace[1915985399] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"708.665908ms","start":"2026-04-18T09:14:07.649808Z","end":"2026-04-18T09:14:08.358474Z","steps":["trace[1915985399] 'process raft request' (duration: 707.743675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:08.358793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:07.649789Z","time spent":"708.933524ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:14:08.358918Z","caller":"traceutil/trace.go:171","msg":"trace[2116891677] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"693.943849ms","start":"2026-04-18T09:14:07.664839Z","end":"2026-04-18T09:14:08.358783Z","steps":["trace[2116891677] 'process raft request' (duration: 693.593561ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:14:08.358649Z","caller":"traceutil/trace.go:171","msg":"trace[2001771055] linearizableReadLoop","detail":"{readStateIndex:2263; appliedIndex:2260; }","duration":"885.68263ms","start":"2026-04-18T09:14:07.472939Z","end":"2026-04-18T09:14:08.358622Z","steps":["trace[2001771055] 'read index received' (duration: 721.873528ms)","trace[2001771055] 'applied index is now lower than readState.Index' (duration: 163.807692ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:14:08.358818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.878516ms","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-04-18T09:14:08.359206Z","caller":"traceutil/trace.go:171","msg":"trace[266803929] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2178; }","duration":"886.306666ms","start":"2026-04-18T09:14:07.47288Z","end":"2026-04-18T09:14:08.359187Z","steps":["trace[266803929] 'agreement among raft nodes before linearized reading' (duration: 885.808314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:08.359255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:07.472862Z","time spent":"886.380357ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-18T09:14:08.35935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:07.664813Z","time spent":"694.243936ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:14:08.359423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.173226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"warn","ts":"2026-04-18T09:14:08.359428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.802428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-18T09:14:08.359482Z","caller":"traceutil/trace.go:171","msg":"trace[1141693620] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2178; }","duration":"841.260487ms","start":"2026-04-18T09:14:07.518201Z","end":"2026-04-18T09:14:08.359461Z","steps":["trace[1141693620] 'agreement among raft nodes before linearized reading' (duration: 841.106744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:08.359519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:07.518187Z","time spent":"841.32487ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":576,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-18T09:14:08.359609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.375371ms","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":"warn","ts":"2026-04-18T09:14:08.359625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.379902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-18T09:14:08.359613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.021398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-18T09:14:08.359686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.512934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-18T09:14:08.359705Z","caller":"traceutil/trace.go:171","msg":"trace[34345372] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:2178; }","duration":"178.149881ms","start":"2026-04-18T09:14:08.181533Z","end":"2026-04-18T09:14:08.359683Z","steps":["trace[34345372] 'agreement among raft nodes before linearized reading' (duration: 177.891765ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:14:08.35973Z","caller":"traceutil/trace.go:171","msg":"trace[644828441] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2178; }","duration":"841.574176ms","start":"2026-04-18T09:14:07.518146Z","end":"2026-04-18T09:14:08.35972Z","steps":["trace[644828441] 'agreement among raft nodes before linearized reading' (duration: 841.462583ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:08.359737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.850742ms","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-04-18T09:14:08.359765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:07.518138Z","time spent":"841.620857ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-18T09:14:08.359768Z","caller":"traceutil/trace.go:171","msg":"trace[1984476056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2178; }","duration":"841.915324ms","start":"2026-04-18T09:14:07.517845Z","end":"2026-04-18T09:14:08.35976Z","steps":["trace[1984476056] 'agreement among raft nodes before linearized reading' (duration: 841.820071ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:14:08.359646Z","caller":"traceutil/trace.go:171","msg":"trace[1554647654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2178; }","duration":"841.436222ms","start":"2026-04-18T09:14:07.518201Z","end":"2026-04-18T09:14:08.359638Z","steps":["trace[1554647654] 'agreement among raft nodes before linearized reading' (duration: 841.344309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:08.359807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:07.517827Z","time spent":"841.973505ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-18T09:14:08.359892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:07.51819Z","time spent":"841.645197ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-18T09:14:08.35966Z","caller":"traceutil/trace.go:171","msg":"trace[1394058934] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2178; }","duration":"555.453974ms","start":"2026-04-18T09:14:07.804197Z","end":"2026-04-18T09:14:08.359651Z","steps":["trace[1394058934] 'agreement among raft nodes before linearized reading' (duration: 555.402883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:08.360035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:07.804178Z","time spent":"555.840193ms","remote":"127.0.0.1:58192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"info","ts":"2026-04-18T09:14:08.359518Z","caller":"traceutil/trace.go:171","msg":"trace[1625122618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2178; }","duration":"877.984452ms","start":"2026-04-18T09:14:07.481512Z","end":"2026-04-18T09:14:08.359496Z","steps":["trace[1625122618] 'agreement among raft nodes before linearized reading' (duration: 877.722386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:08.360179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:14:07.481492Z","time spent":"878.671659ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-18T09:14:33.940973Z","caller":"traceutil/trace.go:171","msg":"trace[536263648] transaction","detail":"{read_only:false; response_revision:2456; number_of_response:1; }","duration":"191.997328ms","start":"2026-04-18T09:14:33.748948Z","end":"2026-04-18T09:14:33.940945Z","steps":["trace[536263648] 'process raft request' (duration: 191.831254ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:14:36.59786Z","caller":"traceutil/trace.go:171","msg":"trace[59289585] transaction","detail":"{read_only:false; response_revision:2508; number_of_response:1; }","duration":"148.541559ms","start":"2026-04-18T09:14:36.449301Z","end":"2026-04-18T09:14:36.597843Z","steps":["trace[59289585] 'process raft request' (duration: 143.944318ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:14:36.598117Z","caller":"traceutil/trace.go:171","msg":"trace[277422146] linearizableReadLoop","detail":"{readStateIndex:2606; appliedIndex:2604; }","duration":"119.593434ms","start":"2026-04-18T09:14:36.478511Z","end":"2026-04-18T09:14:36.598104Z","steps":["trace[277422146] 'read index received' (duration: 114.832768ms)","trace[277422146] 'applied index is now lower than readState.Index' (duration: 4.759966ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:14:36.598189Z","caller":"traceutil/trace.go:171","msg":"trace[989523946] transaction","detail":"{read_only:false; response_revision:2509; number_of_response:1; }","duration":"146.790357ms","start":"2026-04-18T09:14:36.451363Z","end":"2026-04-18T09:14:36.598153Z","steps":["trace[989523946] 'process raft request' (duration: 146.677014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:36.598246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.727077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-18T09:14:36.598271Z","caller":"traceutil/trace.go:171","msg":"trace[1173272814] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2509; }","duration":"119.789588ms","start":"2026-04-18T09:14:36.478473Z","end":"2026-04-18T09:14:36.598263Z","steps":["trace[1173272814] 'agreement among raft nodes before linearized reading' (duration: 119.696096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:37.146938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.7235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:14:37.147027Z","caller":"traceutil/trace.go:171","msg":"trace[1303041622] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:2514; }","duration":"202.871303ms","start":"2026-04-18T09:14:36.944137Z","end":"2026-04-18T09:14:37.147008Z","steps":["trace[1303041622] 'count revisions from in-memory index tree' (duration: 202.627847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:14:37.146998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.488966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:14:37.147081Z","caller":"traceutil/trace.go:171","msg":"trace[222011230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2514; }","duration":"141.61383ms","start":"2026-04-18T09:14:37.005448Z","end":"2026-04-18T09:14:37.147062Z","steps":["trace[222011230] 'range keys from in-memory index tree' (duration: 141.374744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:15:12.213297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.625538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-18T09:15:12.213527Z","caller":"traceutil/trace.go:171","msg":"trace[197243294] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2723; }","duration":"114.905785ms","start":"2026-04-18T09:15:12.0986Z","end":"2026-04-18T09:15:12.213505Z","steps":["trace[197243294] 'range keys from in-memory index tree' (duration: 114.402274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:15:18.071335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.769889ms","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-04-18T09:15:18.071421Z","caller":"traceutil/trace.go:171","msg":"trace[1430395999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2755; }","duration":"104.902002ms","start":"2026-04-18T09:15:17.966502Z","end":"2026-04-18T09:15:18.071404Z","steps":["trace[1430395999] 'range keys from in-memory index tree' (duration: 104.612855ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:17:37.732796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.032112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-18T09:17:37.732884Z","caller":"traceutil/trace.go:171","msg":"trace[1998183775] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3692; }","duration":"129.174925ms","start":"2026-04-18T09:17:37.603691Z","end":"2026-04-18T09:17:37.732866Z","steps":["trace[1998183775] 'range keys from in-memory index tree' (duration: 128.836587ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:00.603118Z","caller":"traceutil/trace.go:171","msg":"trace[1296361087] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"119.914172ms","start":"2026-04-18T09:19:00.483177Z","end":"2026-04-18T09:19:00.603091Z","steps":["trace[1296361087] 'process raft request' (duration: 116.10775ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:00.772589Z","caller":"traceutil/trace.go:171","msg":"trace[137230569] transaction","detail":"{read_only:false; response_revision:4630; number_of_response:1; }","duration":"117.010212ms","start":"2026-04-18T09:19:00.655551Z","end":"2026-04-18T09:19:00.772561Z","steps":["trace[137230569] 'process raft request' (duration: 116.928381ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:00.772656Z","caller":"traceutil/trace.go:171","msg":"trace[536135106] transaction","detail":"{read_only:false; response_revision:4629; number_of_response:1; }","duration":"124.919534ms","start":"2026-04-18T09:19:00.647668Z","end":"2026-04-18T09:19:00.772587Z","steps":["trace[536135106] 'process raft request' (duration: 93.008522ms)","trace[536135106] 'compare' (duration: 31.642196ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:19:04.41945Z","caller":"traceutil/trace.go:171","msg":"trace[921492179] linearizableReadLoop","detail":"{readStateIndex:5009; appliedIndex:5008; }","duration":"129.939516ms","start":"2026-04-18T09:19:04.289462Z","end":"2026-04-18T09:19:04.419402Z","steps":["trace[921492179] 'read index received' (duration: 129.659489ms)","trace[921492179] 'applied index is now lower than readState.Index' (duration: 278.627µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:19:04.419613Z","caller":"traceutil/trace.go:171","msg":"trace[1074236335] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"154.833527ms","start":"2026-04-18T09:19:04.264766Z","end":"2026-04-18T09:19:04.4196Z","steps":["trace[1074236335] 'process raft request' (duration: 154.398316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:04.41993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.443868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/loki\" ","response":"range_response_count:1 size:800"} {"level":"info","ts":"2026-04-18T09:19:04.420027Z","caller":"traceutil/trace.go:171","msg":"trace[601424030] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/loki; range_end:; response_count:1; response_revision:4827; }","duration":"130.609451ms","start":"2026-04-18T09:19:04.289394Z","end":"2026-04-18T09:19:04.420003Z","steps":["trace[601424030] 'agreement among raft nodes before linearized reading' (duration: 130.375656ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:07.679338Z","caller":"traceutil/trace.go:171","msg":"trace[1704830681] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"168.387055ms","start":"2026-04-18T09:19:07.510921Z","end":"2026-04-18T09:19:07.679308Z","steps":["trace[1704830681] 'process raft request' (duration: 168.19315ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:07.686192Z","caller":"traceutil/trace.go:171","msg":"trace[1983089263] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"139.64992ms","start":"2026-04-18T09:19:07.546511Z","end":"2026-04-18T09:19:07.686161Z","steps":["trace[1983089263] 'process raft request' (duration: 139.543778ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:07.686263Z","caller":"traceutil/trace.go:171","msg":"trace[37448800] transaction","detail":"{read_only:false; response_revision:4900; number_of_response:1; }","duration":"140.281815ms","start":"2026-04-18T09:19:07.545953Z","end":"2026-04-18T09:19:07.686235Z","steps":["trace[37448800] 'process raft request' (duration: 139.978218ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:07.68639Z","caller":"traceutil/trace.go:171","msg":"trace[454640483] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"108.766063ms","start":"2026-04-18T09:19:07.577589Z","end":"2026-04-18T09:19:07.686355Z","steps":["trace[454640483] 'process raft request' (duration: 108.505157ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:16.579602Z","caller":"traceutil/trace.go:171","msg":"trace[622317458] transaction","detail":"{read_only:false; response_revision:5090; number_of_response:1; }","duration":"114.611746ms","start":"2026-04-18T09:19:16.464957Z","end":"2026-04-18T09:19:16.579569Z","steps":["trace[622317458] 'process raft request' (duration: 114.37528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:16.592041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.773702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-18T09:19:16.592317Z","caller":"traceutil/trace.go:171","msg":"trace[1312954852] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5090; }","duration":"112.906815ms","start":"2026-04-18T09:19:16.479196Z","end":"2026-04-18T09:19:16.592103Z","steps":["trace[1312954852] 'agreement among raft nodes before linearized reading' (duration: 100.373121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:17.064439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.676566ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:19:17.064681Z","caller":"traceutil/trace.go:171","msg":"trace[461874005] transaction","detail":"{read_only:false; response_revision:5091; number_of_response:1; }","duration":"488.603729ms","start":"2026-04-18T09:19:16.576025Z","end":"2026-04-18T09:19:17.064629Z","steps":["trace[461874005] 'process raft request' (duration: 123.628046ms)","trace[461874005] 'compare' (duration: 364.419228ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:19:17.064749Z","caller":"traceutil/trace.go:171","msg":"trace[2027871233] linearizableReadLoop","detail":"{readStateIndex:5282; appliedIndex:5281; }","duration":"485.061733ms","start":"2026-04-18T09:19:16.579509Z","end":"2026-04-18T09:19:17.064571Z","steps":["trace[2027871233] 'read index received' (duration: 120.153622ms)","trace[2027871233] 'applied index is now lower than readState.Index' (duration: 364.906631ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:19:17.064886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:16.575993Z","time spent":"488.765692ms","remote":"127.0.0.1:42944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1565,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T09:19:17.065125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.133841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-05561b77-03b2-4eee-850e-37d64f48ab53\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-04-18T09:19:17.065172Z","caller":"traceutil/trace.go:171","msg":"trace[1709728851] range","detail":"{range_begin:/registry/persistentvolumes/pvc-05561b77-03b2-4eee-850e-37d64f48ab53; range_end:; response_count:1; response_revision:5091; }","duration":"567.233873ms","start":"2026-04-18T09:19:16.497921Z","end":"2026-04-18T09:19:17.065155Z","steps":["trace[1709728851] 'agreement among raft nodes before linearized reading' (duration: 566.978197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:17.065241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:16.497905Z","time spent":"567.307996ms","remote":"127.0.0.1:58000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1472,"request content":"key:\"/registry/persistentvolumes/pvc-05561b77-03b2-4eee-850e-37d64f48ab53\" "} {"level":"info","ts":"2026-04-18T09:19:17.071694Z","caller":"traceutil/trace.go:171","msg":"trace[27860511] transaction","detail":"{read_only:false; response_revision:5092; number_of_response:1; }","duration":"480.977154ms","start":"2026-04-18T09:19:16.590686Z","end":"2026-04-18T09:19:17.071663Z","steps":["trace[27860511] 'process raft request' (duration: 480.641686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:17.071782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:16.590661Z","time spent":"481.072566ms","remote":"127.0.0.1:58006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1273,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:19:17.071849Z","caller":"traceutil/trace.go:171","msg":"trace[363325825] transaction","detail":"{read_only:false; response_revision:5093; number_of_response:1; }","duration":"480.739476ms","start":"2026-04-18T09:19:16.590985Z","end":"2026-04-18T09:19:17.071725Z","steps":["trace[363325825] 'process raft request' (duration: 480.593583ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:17.072003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:16.590974Z","time spent":"480.946652ms","remote":"127.0.0.1:58006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":850,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:19:17.072128Z","caller":"traceutil/trace.go:171","msg":"trace[1048163197] transaction","detail":"{read_only:false; response_revision:5094; number_of_response:1; }","duration":"481.122916ms","start":"2026-04-18T09:19:16.590994Z","end":"2026-04-18T09:19:17.072117Z","steps":["trace[1048163197] 'process raft request' (duration: 480.656785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:17.072184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:16.590775Z","time spent":"481.378063ms","remote":"127.0.0.1:58102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1853,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:19:17.072217Z","caller":"traceutil/trace.go:171","msg":"trace[1202889854] transaction","detail":"{read_only:false; response_revision:5095; number_of_response:1; }","duration":"479.768883ms","start":"2026-04-18T09:19:16.592416Z","end":"2026-04-18T09:19:17.072185Z","steps":["trace[1202889854] 'process raft request' (duration: 479.580939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:17.07238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:16.592394Z","time spent":"479.905297ms","remote":"127.0.0.1:58102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:19:17.072529Z","caller":"traceutil/trace.go:171","msg":"trace[1805767721] transaction","detail":"{read_only:false; response_revision:5096; number_of_response:1; }","duration":"475.886909ms","start":"2026-04-18T09:19:16.59662Z","end":"2026-04-18T09:19:17.072507Z","steps":["trace[1805767721] 'process raft request' (duration: 475.50561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:17.072615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:16.596612Z","time spent":"475.95952ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:19:23.931946Z","caller":"traceutil/trace.go:171","msg":"trace[1909305193] linearizableReadLoop","detail":"{readStateIndex:5403; appliedIndex:5401; }","duration":"157.192048ms","start":"2026-04-18T09:19:23.77473Z","end":"2026-04-18T09:19:23.931922Z","steps":["trace[1909305193] 'read index received' (duration: 58.377655ms)","trace[1909305193] 'applied index is now lower than readState.Index' (duration: 98.813423ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:19:23.932127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.387493ms","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-04-18T09:19:23.932135Z","caller":"traceutil/trace.go:171","msg":"trace[535148809] transaction","detail":"{read_only:false; response_revision:5210; number_of_response:1; }","duration":"160.929218ms","start":"2026-04-18T09:19:23.771188Z","end":"2026-04-18T09:19:23.932117Z","steps":["trace[535148809] 'process raft request' (duration: 160.651291ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:23.932125Z","caller":"traceutil/trace.go:171","msg":"trace[795801334] transaction","detail":"{read_only:false; response_revision:5209; number_of_response:1; }","duration":"161.562094ms","start":"2026-04-18T09:19:23.770534Z","end":"2026-04-18T09:19:23.932096Z","steps":["trace[795801334] 'process raft request' (duration: 62.559796ms)","trace[795801334] 'compare' (duration: 98.508006ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:19:23.932163Z","caller":"traceutil/trace.go:171","msg":"trace[1718444364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5210; }","duration":"157.470035ms","start":"2026-04-18T09:19:23.774684Z","end":"2026-04-18T09:19:23.932154Z","steps":["trace[1718444364] 'agreement among raft nodes before linearized reading' (duration: 157.326061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:25.355797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.276178ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:19:25.356572Z","caller":"traceutil/trace.go:171","msg":"trace[320028919] transaction","detail":"{read_only:false; response_revision:5275; number_of_response:1; }","duration":"233.343624ms","start":"2026-04-18T09:19:25.123203Z","end":"2026-04-18T09:19:25.356547Z","steps":["trace[320028919] 'process raft request' (duration: 90.214557ms)","trace[320028919] 'compare' (duration: 142.168093ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:19:25.732074Z","caller":"traceutil/trace.go:171","msg":"trace[988971258] linearizableReadLoop","detail":"{readStateIndex:5469; appliedIndex:5468; }","duration":"149.342539ms","start":"2026-04-18T09:19:25.582714Z","end":"2026-04-18T09:19:25.732056Z","steps":["trace[988971258] 'read index received' (duration: 149.304328ms)","trace[988971258] 'applied index is now lower than readState.Index' (duration: 37.541µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:19:25.732273Z","caller":"traceutil/trace.go:171","msg":"trace[1010913728] transaction","detail":"{read_only:false; response_revision:5276; number_of_response:1; }","duration":"220.511583ms","start":"2026-04-18T09:19:25.511753Z","end":"2026-04-18T09:19:25.732265Z","steps":["trace[1010913728] 'process raft request' (duration: 220.190745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:25.732476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.751068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:19:25.732506Z","caller":"traceutil/trace.go:171","msg":"trace[1874092478] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:5276; }","duration":"149.83242ms","start":"2026-04-18T09:19:25.582667Z","end":"2026-04-18T09:19:25.732499Z","steps":["trace[1874092478] 'agreement among raft nodes before linearized reading' (duration: 149.759069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:26.233158Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389696175274745109,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T09:19:26.441601Z","caller":"traceutil/trace.go:171","msg":"trace[280547932] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"848.224741ms","start":"2026-04-18T09:19:25.593352Z","end":"2026-04-18T09:19:26.441576Z","steps":["trace[280547932] 'process raft request' (duration: 847.992695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:26.441789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:25.593333Z","time spent":"848.346064ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:19:26.442017Z","caller":"traceutil/trace.go:171","msg":"trace[339570223] transaction","detail":"{read_only:false; response_revision:5278; number_of_response:1; }","duration":"788.38045ms","start":"2026-04-18T09:19:25.653604Z","end":"2026-04-18T09:19:26.441985Z","steps":["trace[339570223] 'process raft request' (duration: 787.920349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:26.442221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:25.653591Z","time spent":"788.501533ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:19:26.614177Z","caller":"traceutil/trace.go:171","msg":"trace[1371949531] transaction","detail":"{read_only:false; response_revision:5279; number_of_response:1; }","duration":"676.874199ms","start":"2026-04-18T09:19:25.937272Z","end":"2026-04-18T09:19:26.614146Z","steps":["trace[1371949531] 'process raft request' (duration: 649.165278ms)","trace[1371949531] 'compare' (duration: 27.519225ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:19:26.614434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:25.937223Z","time spent":"677.041784ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:19:26.614488Z","caller":"traceutil/trace.go:171","msg":"trace[1440248290] linearizableReadLoop","detail":"{readStateIndex:5473; appliedIndex:5469; }","duration":"882.309547ms","start":"2026-04-18T09:19:25.732126Z","end":"2026-04-18T09:19:26.614436Z","steps":["trace[1440248290] 'read index received' (duration: 709.205113ms)","trace[1440248290] 'applied index is now lower than readState.Index' (duration: 173.101484ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:19:26.614553Z","caller":"traceutil/trace.go:171","msg":"trace[1800258881] transaction","detail":"{read_only:false; response_revision:5280; number_of_response:1; }","duration":"676.92409ms","start":"2026-04-18T09:19:25.93758Z","end":"2026-04-18T09:19:26.614504Z","steps":["trace[1800258881] 'process raft request' (duration: 676.52409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:26.61475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:25.937569Z","time spent":"677.073874ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:19:26.614922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.213735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T09:19:26.614987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.734843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e56d4647-0bf5-4ea0-90b6-14f9e7f67a45\" ","response":"range_response_count:1 size:3766"} {"level":"warn","ts":"2026-04-18T09:19:26.614992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.580915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-18T09:19:26.615017Z","caller":"traceutil/trace.go:171","msg":"trace[512027462] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:5280; }","duration":"958.532363ms","start":"2026-04-18T09:19:25.656461Z","end":"2026-04-18T09:19:26.614994Z","steps":["trace[512027462] 'agreement among raft nodes before linearized reading' (duration: 958.194115ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:26.615025Z","caller":"traceutil/trace.go:171","msg":"trace[1192537983] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e56d4647-0bf5-4ea0-90b6-14f9e7f67a45; range_end:; response_count:1; response_revision:5280; }","duration":"252.828056ms","start":"2026-04-18T09:19:26.362185Z","end":"2026-04-18T09:19:26.615013Z","steps":["trace[1192537983] 'agreement among raft nodes before linearized reading' (duration: 252.716223ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:26.61505Z","caller":"traceutil/trace.go:171","msg":"trace[1984136257] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5280; }","duration":"563.670756ms","start":"2026-04-18T09:19:26.051366Z","end":"2026-04-18T09:19:26.615037Z","steps":["trace[1984136257] 'agreement among raft nodes before linearized reading' (duration: 563.444851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:26.61507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:25.656438Z","time spent":"958.618475ms","remote":"127.0.0.1:40968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-18T09:19:26.615085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:26.051358Z","time spent":"563.718667ms","remote":"127.0.0.1:58100","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":"warn","ts":"2026-04-18T09:19:26.614988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.41305ms","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-04-18T09:19:26.615182Z","caller":"traceutil/trace.go:171","msg":"trace[50926916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5280; }","duration":"674.667395ms","start":"2026-04-18T09:19:25.940503Z","end":"2026-04-18T09:19:26.61517Z","steps":["trace[50926916] 'agreement among raft nodes before linearized reading' (duration: 674.213784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:26.615216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:25.940495Z","time spent":"674.710197ms","remote":"127.0.0.1:58100","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-04-18T09:19:26.615269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.315355ms","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-04-18T09:19:26.615132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.877664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-18T09:19:26.615325Z","caller":"traceutil/trace.go:171","msg":"trace[1101970961] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5280; }","duration":"567.396368ms","start":"2026-04-18T09:19:26.04791Z","end":"2026-04-18T09:19:26.615306Z","steps":["trace[1101970961] 'agreement among raft nodes before linearized reading' (duration: 567.255664ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:26.615333Z","caller":"traceutil/trace.go:171","msg":"trace[1317936921] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5280; }","duration":"567.09558ms","start":"2026-04-18T09:19:26.048222Z","end":"2026-04-18T09:19:26.615317Z","steps":["trace[1317936921] 'agreement among raft nodes before linearized reading' (duration: 566.812003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:26.615389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:26.048213Z","time spent":"567.161152ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-18T09:19:26.615386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:26.047896Z","time spent":"567.477509ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-18T09:19:26.615406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.350224ms","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-04-18T09:19:26.61544Z","caller":"traceutil/trace.go:171","msg":"trace[873562856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5280; }","duration":"569.426676ms","start":"2026-04-18T09:19:26.046005Z","end":"2026-04-18T09:19:26.615431Z","steps":["trace[873562856] 'agreement among raft nodes before linearized reading' (duration: 569.332813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:26.615471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:19:26.045983Z","time spent":"569.481497ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-18T09:19:28.763105Z","caller":"traceutil/trace.go:171","msg":"trace[1725953158] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"142.181496ms","start":"2026-04-18T09:19:28.620899Z","end":"2026-04-18T09:19:28.763081Z","steps":["trace[1725953158] 'process raft request' (duration: 141.972291ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:28.770339Z","caller":"traceutil/trace.go:171","msg":"trace[595609598] linearizableReadLoop","detail":"{readStateIndex:5539; appliedIndex:5537; }","duration":"144.822459ms","start":"2026-04-18T09:19:28.625489Z","end":"2026-04-18T09:19:28.770311Z","steps":["trace[595609598] 'read index received' (duration: 137.379799ms)","trace[595609598] 'applied index is now lower than readState.Index' (duration: 7.44156ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:19:28.770791Z","caller":"traceutil/trace.go:171","msg":"trace[965478158] transaction","detail":"{read_only:false; response_revision:5343; number_of_response:1; }","duration":"147.682647ms","start":"2026-04-18T09:19:28.62308Z","end":"2026-04-18T09:19:28.770762Z","steps":["trace[965478158] 'process raft request' (duration: 146.774255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:28.770912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.368232ms","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-04-18T09:19:28.771009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.78714ms","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-04-18T09:19:28.771078Z","caller":"traceutil/trace.go:171","msg":"trace[394566897] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5343; }","duration":"145.586818ms","start":"2026-04-18T09:19:28.625452Z","end":"2026-04-18T09:19:28.771039Z","steps":["trace[394566897] 'agreement among raft nodes before linearized reading' (duration: 145.151467ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:28.771128Z","caller":"traceutil/trace.go:171","msg":"trace[1390513949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5343; }","duration":"142.968044ms","start":"2026-04-18T09:19:28.62813Z","end":"2026-04-18T09:19:28.771099Z","steps":["trace[1390513949] 'agreement among raft nodes before linearized reading' (duration: 142.615666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:28.771146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.868815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-18T09:19:28.771237Z","caller":"traceutil/trace.go:171","msg":"trace[473399873] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5343; }","duration":"144.001149ms","start":"2026-04-18T09:19:28.627216Z","end":"2026-04-18T09:19:28.771217Z","steps":["trace[473399873] 'agreement among raft nodes before linearized reading' (duration: 143.698841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:28.771316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.045947ms","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-04-18T09:19:28.771401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.414359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-18T09:19:28.7714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.748371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e56d4647-0bf5-4ea0-90b6-14f9e7f67a45\" ","response":"range_response_count:1 size:3952"} {"level":"info","ts":"2026-04-18T09:19:28.77146Z","caller":"traceutil/trace.go:171","msg":"trace[1111637057] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5343; }","duration":"144.511332ms","start":"2026-04-18T09:19:28.626919Z","end":"2026-04-18T09:19:28.771431Z","steps":["trace[1111637057] 'agreement among raft nodes before linearized reading' (duration: 144.349208ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:28.77147Z","caller":"traceutil/trace.go:171","msg":"trace[19170773] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e56d4647-0bf5-4ea0-90b6-14f9e7f67a45; range_end:; response_count:1; response_revision:5343; }","duration":"145.850634ms","start":"2026-04-18T09:19:28.6256Z","end":"2026-04-18T09:19:28.771451Z","steps":["trace[19170773] 'agreement among raft nodes before linearized reading' (duration: 145.133245ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:28.771423Z","caller":"traceutil/trace.go:171","msg":"trace[1210138237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5343; }","duration":"143.22246ms","start":"2026-04-18T09:19:28.628181Z","end":"2026-04-18T09:19:28.771403Z","steps":["trace[1210138237] 'agreement among raft nodes before linearized reading' (duration: 142.676866ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:32.569371Z","caller":"traceutil/trace.go:171","msg":"trace[358165434] transaction","detail":"{read_only:false; response_revision:5387; number_of_response:1; }","duration":"105.69347ms","start":"2026-04-18T09:19:32.463652Z","end":"2026-04-18T09:19:32.569346Z","steps":["trace[358165434] 'process raft request' (duration: 105.500065ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:36.702132Z","caller":"traceutil/trace.go:171","msg":"trace[1039976633] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"119.479706ms","start":"2026-04-18T09:19:36.582593Z","end":"2026-04-18T09:19:36.702073Z","steps":["trace[1039976633] 'process raft request' (duration: 119.145947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:36.958142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.832699ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:19:36.958368Z","caller":"traceutil/trace.go:171","msg":"trace[1752383996] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"143.073016ms","start":"2026-04-18T09:19:36.815273Z","end":"2026-04-18T09:19:36.958346Z","steps":["trace[1752383996] 'process raft request' (duration: 142.972773ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:19:36.958359Z","caller":"traceutil/trace.go:171","msg":"trace[1094003068] transaction","detail":"{read_only:false; response_revision:5425; number_of_response:1; }","duration":"143.65711ms","start":"2026-04-18T09:19:36.814665Z","end":"2026-04-18T09:19:36.958323Z","steps":["trace[1094003068] 'process raft request' (duration: 31.543534ms)","trace[1094003068] 'compare' (duration: 111.634375ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:19:36.958497Z","caller":"traceutil/trace.go:171","msg":"trace[286386140] linearizableReadLoop","detail":"{readStateIndex:5622; appliedIndex:5620; }","duration":"143.199679ms","start":"2026-04-18T09:19:36.815274Z","end":"2026-04-18T09:19:36.958474Z","steps":["trace[286386140] 'read index received' (duration: 6.255281ms)","trace[286386140] 'applied index is now lower than readState.Index' (duration: 136.943298ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:19:36.9586Z","caller":"traceutil/trace.go:171","msg":"trace[830392304] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"141.694502ms","start":"2026-04-18T09:19:36.816857Z","end":"2026-04-18T09:19:36.958552Z","steps":["trace[830392304] 'process raft request' (duration: 141.446716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:19:36.958683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.394853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-18T09:19:36.958734Z","caller":"traceutil/trace.go:171","msg":"trace[320469892] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5427; }","duration":"143.478826ms","start":"2026-04-18T09:19:36.815239Z","end":"2026-04-18T09:19:36.958718Z","steps":["trace[320469892] 'agreement among raft nodes before linearized reading' (duration: 143.327322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:20:28.388404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.113454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T09:20:28.388614Z","caller":"traceutil/trace.go:171","msg":"trace[44851105] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:5873; }","duration":"181.399789ms","start":"2026-04-18T09:20:28.207176Z","end":"2026-04-18T09:20:28.388576Z","steps":["trace[44851105] 'range keys from in-memory index tree' (duration: 180.864507ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:20:55.305388Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2964} {"level":"info","ts":"2026-04-18T09:20:55.381951Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2964,"took":"74.777664ms","hash":2668564592,"current-db-size-bytes":58126336,"current-db-size":"58 MB","current-db-size-in-use-bytes":33972224,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-18T09:20:55.382021Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2668564592,"revision":2964,"compact-revision":-1} {"level":"warn","ts":"2026-04-18T09:25:28.882985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.832724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:25:28.883364Z","caller":"traceutil/trace.go:171","msg":"trace[313960678] transaction","detail":"{read_only:false; response_revision:8096; number_of_response:1; }","duration":"621.686168ms","start":"2026-04-18T09:25:28.261653Z","end":"2026-04-18T09:25:28.883339Z","steps":["trace[313960678] 'process raft request' (duration: 621.600065ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:25:28.883394Z","caller":"traceutil/trace.go:171","msg":"trace[1162732454] transaction","detail":"{read_only:false; response_revision:8095; number_of_response:1; }","duration":"631.160308ms","start":"2026-04-18T09:25:28.252212Z","end":"2026-04-18T09:25:28.883372Z","steps":["trace[1162732454] 'process raft request' (duration: 630.971364ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:25:28.883372Z","caller":"traceutil/trace.go:171","msg":"trace[955686132] transaction","detail":"{read_only:false; response_revision:8094; number_of_response:1; }","duration":"644.660986ms","start":"2026-04-18T09:25:28.238646Z","end":"2026-04-18T09:25:28.883307Z","steps":["trace[955686132] 'process raft request' (duration: 237.387341ms)","trace[955686132] 'compare' (duration: 406.66574ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:25:28.883456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:25:28.261609Z","time spent":"621.80836ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:25:28.883502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:25:28.252188Z","time spent":"631.260171ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:25:28.883624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:25:28.238614Z","time spent":"644.866931ms","remote":"127.0.0.1:57874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T09:25:28.883618Z","caller":"traceutil/trace.go:171","msg":"trace[1226382113] transaction","detail":"{read_only:false; response_revision:8097; number_of_response:1; }","duration":"597.417337ms","start":"2026-04-18T09:25:28.286143Z","end":"2026-04-18T09:25:28.88356Z","steps":["trace[1226382113] 'process raft request' (duration: 597.152431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:25:28.88383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:25:28.286129Z","time spent":"597.58204ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:25:41.260975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.560526ms","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-04-18T09:25:41.261725Z","caller":"traceutil/trace.go:171","msg":"trace[947256133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8159; }","duration":"103.349964ms","start":"2026-04-18T09:25:41.158317Z","end":"2026-04-18T09:25:41.261667Z","steps":["trace[947256133] 'range keys from in-memory index tree' (duration: 102.408632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:25:41.261365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.101399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-18T09:25:41.262064Z","caller":"traceutil/trace.go:171","msg":"trace[1641415787] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8159; }","duration":"110.866829ms","start":"2026-04-18T09:25:41.151164Z","end":"2026-04-18T09:25:41.262031Z","steps":["trace[1641415787] 'range keys from in-memory index tree' (duration: 109.919384ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:25:41.445035Z","caller":"traceutil/trace.go:171","msg":"trace[1223618618] transaction","detail":"{read_only:false; response_revision:8161; number_of_response:1; }","duration":"178.815753ms","start":"2026-04-18T09:25:41.266158Z","end":"2026-04-18T09:25:41.444974Z","steps":["trace[1223618618] 'process raft request' (duration: 166.633566ms)","trace[1223618618] 'compare' (duration: 11.353477ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:25:41.445213Z","caller":"traceutil/trace.go:171","msg":"trace[1883203832] transaction","detail":"{read_only:false; response_revision:8162; number_of_response:1; }","duration":"179.018908ms","start":"2026-04-18T09:25:41.26616Z","end":"2026-04-18T09:25:41.445179Z","steps":["trace[1883203832] 'process raft request' (duration: 178.859794ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:25:41.445546Z","caller":"traceutil/trace.go:171","msg":"trace[36140561] transaction","detail":"{read_only:false; response_revision:8163; number_of_response:1; }","duration":"178.850893ms","start":"2026-04-18T09:25:41.266654Z","end":"2026-04-18T09:25:41.445505Z","steps":["trace[36140561] 'process raft request' (duration: 178.463544ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:25:41.445623Z","caller":"traceutil/trace.go:171","msg":"trace[716980639] transaction","detail":"{read_only:false; response_revision:8164; number_of_response:1; }","duration":"178.833024ms","start":"2026-04-18T09:25:41.266759Z","end":"2026-04-18T09:25:41.445592Z","steps":["trace[716980639] 'process raft request' (duration: 178.598988ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:25:41.445578Z","caller":"traceutil/trace.go:171","msg":"trace[1711807905] linearizableReadLoop","detail":"{readStateIndex:8450; appliedIndex:8446; }","duration":"154.403928ms","start":"2026-04-18T09:25:41.291135Z","end":"2026-04-18T09:25:41.445539Z","steps":["trace[1711807905] 'read index received' (duration: 141.768591ms)","trace[1711807905] 'applied index is now lower than readState.Index' (duration: 12.633817ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:25:41.445826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.655705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:25:41.445932Z","caller":"traceutil/trace.go:171","msg":"trace[239197948] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8164; }","duration":"154.826658ms","start":"2026-04-18T09:25:41.291079Z","end":"2026-04-18T09:25:41.445906Z","steps":["trace[239197948] 'agreement among raft nodes before linearized reading' (duration: 154.644104ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:25:43.072017Z","caller":"traceutil/trace.go:171","msg":"trace[142223735] transaction","detail":"{read_only:false; response_revision:8168; number_of_response:1; }","duration":"119.12225ms","start":"2026-04-18T09:25:42.952858Z","end":"2026-04-18T09:25:43.07198Z","steps":["trace[142223735] 'process raft request' (duration: 86.450775ms)","trace[142223735] 'compare' (duration: 32.48681ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:25:43.072196Z","caller":"traceutil/trace.go:171","msg":"trace[2099364748] transaction","detail":"{read_only:false; response_revision:8169; number_of_response:1; }","duration":"118.255459ms","start":"2026-04-18T09:25:42.953907Z","end":"2026-04-18T09:25:43.072162Z","steps":["trace[2099364748] 'process raft request' (duration: 118.027154ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:25:43.71411Z","caller":"traceutil/trace.go:171","msg":"trace[740387706] transaction","detail":"{read_only:false; response_revision:8178; number_of_response:1; }","duration":"115.670795ms","start":"2026-04-18T09:25:43.598385Z","end":"2026-04-18T09:25:43.714055Z","steps":["trace[740387706] 'process raft request' (duration: 115.150152ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:25:55.312471Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6069} {"level":"info","ts":"2026-04-18T09:25:55.416128Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6069,"took":"101.402748ms","hash":3572163580,"current-db-size-bytes":58126336,"current-db-size":"58 MB","current-db-size-in-use-bytes":22913024,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-18T09:25:55.416219Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3572163580,"revision":6069,"compact-revision":2964} {"level":"warn","ts":"2026-04-18T09:26:10.107973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.042292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:26:10.108096Z","caller":"traceutil/trace.go:171","msg":"trace[1651193895] linearizableReadLoop","detail":"{readStateIndex:8667; appliedIndex:8666; }","duration":"354.435967ms","start":"2026-04-18T09:26:09.753642Z","end":"2026-04-18T09:26:10.108078Z","steps":["trace[1651193895] 'read index received' (duration: 158.216601ms)","trace[1651193895] 'applied index is now lower than readState.Index' (duration: 196.218476ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:26:10.108349Z","caller":"traceutil/trace.go:171","msg":"trace[758437685] transaction","detail":"{read_only:false; response_revision:8372; number_of_response:1; }","duration":"403.336167ms","start":"2026-04-18T09:26:09.704996Z","end":"2026-04-18T09:26:10.108332Z","steps":["trace[758437685] 'process raft request' (duration: 206.825885ms)","trace[758437685] 'compare' (duration: 195.798474ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:26:10.108417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:26:09.704983Z","time spent":"403.399749ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:26:10.108638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.98565ms","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-04-18T09:26:10.108672Z","caller":"traceutil/trace.go:171","msg":"trace[2141274139] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:8372; }","duration":"355.075143ms","start":"2026-04-18T09:26:09.753584Z","end":"2026-04-18T09:26:10.108659Z","steps":["trace[2141274139] 'agreement among raft nodes before linearized reading' (duration: 355.012072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:10.108704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:26:09.753554Z","time spent":"355.141144ms","remote":"127.0.0.1:41038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-18T09:26:10.108952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.154495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-18T09:26:10.109005Z","caller":"traceutil/trace.go:171","msg":"trace[728704140] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8372; }","duration":"249.262567ms","start":"2026-04-18T09:26:09.859733Z","end":"2026-04-18T09:26:10.108995Z","steps":["trace[728704140] 'agreement among raft nodes before linearized reading' (duration: 249.119694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:10.109268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.84308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-48sdm\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-18T09:26:10.109302Z","caller":"traceutil/trace.go:171","msg":"trace[408968596] range","detail":"{range_begin:/registry/pods/openstack/keepalived-48sdm; range_end:; response_count:1; response_revision:8372; }","duration":"205.900191ms","start":"2026-04-18T09:26:09.903394Z","end":"2026-04-18T09:26:10.109294Z","steps":["trace[408968596] 'agreement among raft nodes before linearized reading' (duration: 205.809259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:10.109497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.423089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-18T09:26:10.109528Z","caller":"traceutil/trace.go:171","msg":"trace[1910674361] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8372; }","duration":"221.496551ms","start":"2026-04-18T09:26:09.888024Z","end":"2026-04-18T09:26:10.109521Z","steps":["trace[1910674361] 'agreement among raft nodes before linearized reading' (duration: 221.413059ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:10.353554Z","caller":"traceutil/trace.go:171","msg":"trace[1052005472] transaction","detail":"{read_only:false; response_revision:8373; number_of_response:1; }","duration":"239.413357ms","start":"2026-04-18T09:26:10.11411Z","end":"2026-04-18T09:26:10.353524Z","steps":["trace[1052005472] 'process raft request' (duration: 238.173707ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:10.353917Z","caller":"traceutil/trace.go:171","msg":"trace[127739667] linearizableReadLoop","detail":"{readStateIndex:8669; appliedIndex:8667; }","duration":"238.215198ms","start":"2026-04-18T09:26:10.115695Z","end":"2026-04-18T09:26:10.35391Z","steps":["trace[127739667] 'read index received' (duration: 236.805744ms)","trace[127739667] 'applied index is now lower than readState.Index' (duration: 1.409034ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:26:10.353965Z","caller":"traceutil/trace.go:171","msg":"trace[1993132073] transaction","detail":"{read_only:false; response_revision:8374; number_of_response:1; }","duration":"239.758025ms","start":"2026-04-18T09:26:10.114202Z","end":"2026-04-18T09:26:10.35396Z","steps":["trace[1993132073] 'process raft request' (duration: 239.670923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:10.354315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.592828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228585"} {"level":"info","ts":"2026-04-18T09:26:10.354341Z","caller":"traceutil/trace.go:171","msg":"trace[1078516400] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8374; }","duration":"238.6645ms","start":"2026-04-18T09:26:10.115671Z","end":"2026-04-18T09:26:10.354335Z","steps":["trace[1078516400] 'agreement among raft nodes before linearized reading' (duration: 238.340202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:10.354472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.74972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T09:26:10.354581Z","caller":"traceutil/trace.go:171","msg":"trace[1291280697] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:8374; }","duration":"219.898933ms","start":"2026-04-18T09:26:10.134656Z","end":"2026-04-18T09:26:10.354555Z","steps":["trace[1291280697] 'agreement among raft nodes before linearized reading' (duration: 219.686858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:13.534025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.173784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:26:13.53422Z","caller":"traceutil/trace.go:171","msg":"trace[313265149] linearizableReadLoop","detail":"{readStateIndex:8682; appliedIndex:8681; }","duration":"244.02563ms","start":"2026-04-18T09:26:13.290169Z","end":"2026-04-18T09:26:13.534195Z","steps":["trace[313265149] 'read index received' (duration: 52.509717ms)","trace[313265149] 'applied index is now lower than readState.Index' (duration: 191.513873ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:26:13.534294Z","caller":"traceutil/trace.go:171","msg":"trace[1884219985] transaction","detail":"{read_only:false; response_revision:8387; number_of_response:1; }","duration":"362.188147ms","start":"2026-04-18T09:26:13.172061Z","end":"2026-04-18T09:26:13.53425Z","steps":["trace[1884219985] 'process raft request' (duration: 170.645164ms)","trace[1884219985] 'compare' (duration: 190.915977ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:26:13.534498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:26:13.172034Z","time spent":"362.34086ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:26:13.534335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.146572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:26:13.534799Z","caller":"traceutil/trace.go:171","msg":"trace[906317391] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8387; }","duration":"244.653414ms","start":"2026-04-18T09:26:13.290106Z","end":"2026-04-18T09:26:13.53476Z","steps":["trace[906317391] 'agreement among raft nodes before linearized reading' (duration: 244.147062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:13.579567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.636739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"} {"level":"info","ts":"2026-04-18T09:26:13.579623Z","caller":"traceutil/trace.go:171","msg":"trace[1574611962] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8387; }","duration":"116.754792ms","start":"2026-04-18T09:26:13.462853Z","end":"2026-04-18T09:26:13.579607Z","steps":["trace[1574611962] 'agreement among raft nodes before linearized reading' (duration: 116.528907ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:22.991455Z","caller":"traceutil/trace.go:171","msg":"trace[66125471] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8476; }","duration":"103.335306ms","start":"2026-04-18T09:26:22.888092Z","end":"2026-04-18T09:26:22.991427Z","steps":["trace[66125471] 'process raft request' (duration: 87.50636ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:23.724495Z","caller":"traceutil/trace.go:171","msg":"trace[233283461] linearizableReadLoop","detail":"{readStateIndex:8781; appliedIndex:8780; }","duration":"100.26914ms","start":"2026-04-18T09:26:23.624193Z","end":"2026-04-18T09:26:23.724462Z","steps":["trace[233283461] 'read index received' (duration: 99.947883ms)","trace[233283461] 'applied index is now lower than readState.Index' (duration: 319.937µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:26:23.724586Z","caller":"traceutil/trace.go:171","msg":"trace[561542552] transaction","detail":"{read_only:false; response_revision:8481; number_of_response:1; }","duration":"155.457763ms","start":"2026-04-18T09:26:23.569073Z","end":"2026-04-18T09:26:23.724531Z","steps":["trace[561542552] 'process raft request' (duration: 155.154186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:23.724823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.589549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-18T09:26:23.724937Z","caller":"traceutil/trace.go:171","msg":"trace[136156563] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8481; }","duration":"100.770563ms","start":"2026-04-18T09:26:23.624142Z","end":"2026-04-18T09:26:23.724912Z","steps":["trace[136156563] 'agreement among raft nodes before linearized reading' (duration: 100.442255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:24.030842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.293348ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:26:24.03096Z","caller":"traceutil/trace.go:171","msg":"trace[233738763] linearizableReadLoop","detail":"{readStateIndex:8782; appliedIndex:8781; }","duration":"298.891766ms","start":"2026-04-18T09:26:23.732045Z","end":"2026-04-18T09:26:24.030937Z","steps":["trace[233738763] 'read index received' (duration: 102.358621ms)","trace[233738763] 'applied index is now lower than readState.Index' (duration: 196.531735ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:26:24.031155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.104171ms","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-04-18T09:26:24.031184Z","caller":"traceutil/trace.go:171","msg":"trace[1506821241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8482; }","duration":"299.162851ms","start":"2026-04-18T09:26:23.732013Z","end":"2026-04-18T09:26:24.031176Z","steps":["trace[1506821241] 'agreement among raft nodes before linearized reading' (duration: 299.001638ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:24.031219Z","caller":"traceutil/trace.go:171","msg":"trace[147922771] transaction","detail":"{read_only:false; response_revision:8482; number_of_response:1; }","duration":"301.493799ms","start":"2026-04-18T09:26:23.729613Z","end":"2026-04-18T09:26:24.031107Z","steps":["trace[147922771] 'process raft request' (duration: 104.77717ms)","trace[147922771] 'compare' (duration: 195.96573ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:26:24.031731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:26:23.72959Z","time spent":"301.955809ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T09:26:24.090169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.725371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"} {"level":"warn","ts":"2026-04-18T09:26:24.090209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.773564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T09:26:24.090278Z","caller":"traceutil/trace.go:171","msg":"trace[1391537313] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8483; }","duration":"298.867004ms","start":"2026-04-18T09:26:23.791378Z","end":"2026-04-18T09:26:24.090245Z","steps":["trace[1391537313] 'agreement among raft nodes before linearized reading' (duration: 298.584517ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:24.090313Z","caller":"traceutil/trace.go:171","msg":"trace[1057462597] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:8483; }","duration":"114.964778ms","start":"2026-04-18T09:26:23.975326Z","end":"2026-04-18T09:26:24.090291Z","steps":["trace[1057462597] 'agreement among raft nodes before linearized reading' (duration: 114.667511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:24.09034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.490964ms","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-04-18T09:26:24.090245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.63804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-18T09:26:24.090407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.790365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"} {"level":"warn","ts":"2026-04-18T09:26:24.090423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.694358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-18T09:26:24.090457Z","caller":"traceutil/trace.go:171","msg":"trace[1754770174] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8483; }","duration":"220.883697ms","start":"2026-04-18T09:26:23.869559Z","end":"2026-04-18T09:26:24.090443Z","steps":["trace[1754770174] 'agreement among raft nodes before linearized reading' (duration: 220.732433ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:24.090466Z","caller":"traceutil/trace.go:171","msg":"trace[1168755645] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8483; }","duration":"353.7435ms","start":"2026-04-18T09:26:23.73671Z","end":"2026-04-18T09:26:24.090453Z","steps":["trace[1168755645] 'agreement among raft nodes before linearized reading' (duration: 353.667308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:24.090507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:26:23.736703Z","time spent":"353.795961ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-18T09:26:24.090511Z","caller":"traceutil/trace.go:171","msg":"trace[842454166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8483; }","duration":"353.561685ms","start":"2026-04-18T09:26:23.736812Z","end":"2026-04-18T09:26:24.090373Z","steps":["trace[842454166] 'agreement among raft nodes before linearized reading' (duration: 353.467233ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:24.090472Z","caller":"traceutil/trace.go:171","msg":"trace[2046882464] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8483; }","duration":"351.853355ms","start":"2026-04-18T09:26:23.738577Z","end":"2026-04-18T09:26:24.09043Z","steps":["trace[2046882464] 'agreement among raft nodes before linearized reading' (duration: 351.570058ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:24.090425Z","caller":"traceutil/trace.go:171","msg":"trace[223644153] transaction","detail":"{read_only:false; response_revision:8483; number_of_response:1; }","duration":"257.658311ms","start":"2026-04-18T09:26:23.832713Z","end":"2026-04-18T09:26:24.090372Z","steps":["trace[223644153] 'process raft request' (duration: 256.994495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:24.090623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:26:23.738569Z","time spent":"352.007378ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-18T09:26:24.09063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:26:23.73679Z","time spent":"353.784551ms","remote":"127.0.0.1:58100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-18T09:26:24.365612Z","caller":"traceutil/trace.go:171","msg":"trace[340796802] transaction","detail":"{read_only:false; response_revision:8486; number_of_response:1; }","duration":"269.405138ms","start":"2026-04-18T09:26:24.096172Z","end":"2026-04-18T09:26:24.365577Z","steps":["trace[340796802] 'process raft request' (duration: 269.233953ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:24.365777Z","caller":"traceutil/trace.go:171","msg":"trace[145658678] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"270.071493ms","start":"2026-04-18T09:26:24.095653Z","end":"2026-04-18T09:26:24.365724Z","steps":["trace[145658678] 'process raft request' (duration: 261.074724ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:24.365846Z","caller":"traceutil/trace.go:171","msg":"trace[112832341] linearizableReadLoop","detail":"{readStateIndex:8788; appliedIndex:8784; }","duration":"256.692707ms","start":"2026-04-18T09:26:24.109118Z","end":"2026-04-18T09:26:24.365811Z","steps":["trace[112832341] 'read index received' (duration: 247.527284ms)","trace[112832341] 'applied index is now lower than readState.Index' (duration: 9.164153ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:26:24.36595Z","caller":"traceutil/trace.go:171","msg":"trace[1644183193] transaction","detail":"{read_only:false; response_revision:8487; number_of_response:1; }","duration":"268.976137ms","start":"2026-04-18T09:26:24.096939Z","end":"2026-04-18T09:26:24.365915Z","steps":["trace[1644183193] 'process raft request' (duration: 268.588507ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:24.366002Z","caller":"traceutil/trace.go:171","msg":"trace[371085599] transaction","detail":"{read_only:false; response_revision:8488; number_of_response:1; }","duration":"259.365482ms","start":"2026-04-18T09:26:24.106573Z","end":"2026-04-18T09:26:24.365938Z","steps":["trace[371085599] 'process raft request' (duration: 259.085945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:24.366455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.98683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"} {"level":"info","ts":"2026-04-18T09:26:24.366521Z","caller":"traceutil/trace.go:171","msg":"trace[1739188066] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8488; }","duration":"272.111303ms","start":"2026-04-18T09:26:24.094396Z","end":"2026-04-18T09:26:24.366507Z","steps":["trace[1739188066] 'agreement among raft nodes before linearized reading' (duration: 271.691713ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:25.241728Z","caller":"traceutil/trace.go:171","msg":"trace[1637576152] linearizableReadLoop","detail":"{readStateIndex:8792; appliedIndex:8791; }","duration":"206.902476ms","start":"2026-04-18T09:26:25.034775Z","end":"2026-04-18T09:26:25.241678Z","steps":["trace[1637576152] 'read index received' (duration: 206.620829ms)","trace[1637576152] 'applied index is now lower than readState.Index' (duration: 280.547µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:26:25.241865Z","caller":"traceutil/trace.go:171","msg":"trace[1878798431] transaction","detail":"{read_only:false; response_revision:8492; number_of_response:1; }","duration":"254.235208ms","start":"2026-04-18T09:26:24.987582Z","end":"2026-04-18T09:26:25.241817Z","steps":["trace[1878798431] 'process raft request' (duration: 253.9084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:25.24194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.135682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T09:26:25.241985Z","caller":"traceutil/trace.go:171","msg":"trace[105204854] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:8492; }","duration":"207.271725ms","start":"2026-04-18T09:26:25.034702Z","end":"2026-04-18T09:26:25.241974Z","steps":["trace[105204854] 'agreement among raft nodes before linearized reading' (duration: 207.149382ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:25.386916Z","caller":"traceutil/trace.go:171","msg":"trace[398039885] linearizableReadLoop","detail":"{readStateIndex:8793; appliedIndex:8792; }","duration":"145.071581ms","start":"2026-04-18T09:26:25.241812Z","end":"2026-04-18T09:26:25.386884Z","steps":["trace[398039885] 'read index received' (duration: 136.239226ms)","trace[398039885] 'applied index is now lower than readState.Index' (duration: 8.831105ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T09:26:25.387087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.69411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:26:25.387138Z","caller":"traceutil/trace.go:171","msg":"trace[1601101658] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:8493; }","duration":"337.792543ms","start":"2026-04-18T09:26:25.049327Z","end":"2026-04-18T09:26:25.387119Z","steps":["trace[1601101658] 'agreement among raft nodes before linearized reading' (duration: 337.68172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:25.387118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.638171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-18T09:26:25.387232Z","caller":"traceutil/trace.go:171","msg":"trace[1277516106] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8493; }","duration":"273.803245ms","start":"2026-04-18T09:26:25.113402Z","end":"2026-04-18T09:26:25.387205Z","steps":["trace[1277516106] 'agreement among raft nodes before linearized reading' (duration: 273.489158ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:25.386941Z","caller":"traceutil/trace.go:171","msg":"trace[1002434616] transaction","detail":"{read_only:false; response_revision:8493; number_of_response:1; }","duration":"227.493628ms","start":"2026-04-18T09:26:25.159407Z","end":"2026-04-18T09:26:25.386901Z","steps":["trace[1002434616] 'process raft request' (duration: 218.596241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:25.387168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:26:25.049311Z","time spent":"337.849404ms","remote":"127.0.0.1:57938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-18T09:26:25.45575Z","caller":"traceutil/trace.go:171","msg":"trace[32690907] transaction","detail":"{read_only:false; response_revision:8494; number_of_response:1; }","duration":"197.61859ms","start":"2026-04-18T09:26:25.258077Z","end":"2026-04-18T09:26:25.455696Z","steps":["trace[32690907] 'process raft request' (duration: 197.341523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:26:25.598836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.100069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T09:26:25.5992Z","caller":"traceutil/trace.go:171","msg":"trace[988485241] transaction","detail":"{read_only:false; response_revision:8495; number_of_response:1; }","duration":"208.700819ms","start":"2026-04-18T09:26:25.390459Z","end":"2026-04-18T09:26:25.599159Z","steps":["trace[988485241] 'process raft request' (duration: 105.144049ms)","trace[988485241] 'compare' (duration: 102.734281ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:26:25.599455Z","caller":"traceutil/trace.go:171","msg":"trace[1099363593] transaction","detail":"{read_only:false; response_revision:8496; number_of_response:1; }","duration":"138.804449ms","start":"2026-04-18T09:26:25.460625Z","end":"2026-04-18T09:26:25.599429Z","steps":["trace[1099363593] 'process raft request' (duration: 138.4862ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:25.784333Z","caller":"traceutil/trace.go:171","msg":"trace[445848252] transaction","detail":"{read_only:false; response_revision:8497; number_of_response:1; }","duration":"110.004968ms","start":"2026-04-18T09:26:25.674287Z","end":"2026-04-18T09:26:25.784291Z","steps":["trace[445848252] 'process raft request' (duration: 41.861339ms)","trace[445848252] 'compare' (duration: 67.944224ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T09:26:37.542944Z","caller":"traceutil/trace.go:171","msg":"trace[1721367376] transaction","detail":"{read_only:false; response_revision:8594; number_of_response:1; }","duration":"200.518991ms","start":"2026-04-18T09:26:37.342393Z","end":"2026-04-18T09:26:37.542912Z","steps":["trace[1721367376] 'process raft request' (duration: 200.324776ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:26:37.54451Z","caller":"traceutil/trace.go:171","msg":"trace[385489072] transaction","detail":"{read_only:false; response_revision:8595; number_of_response:1; }","duration":"116.470115ms","start":"2026-04-18T09:26:37.428005Z","end":"2026-04-18T09:26:37.544476Z","steps":["trace[385489072] 'process raft request' (duration: 116.205328ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:27:13.940043Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000244b.wal"} {"level":"warn","ts":"2026-04-18T09:27:28.310886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.465253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T09:27:28.311047Z","caller":"traceutil/trace.go:171","msg":"trace[391848949] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:9164; }","duration":"229.70709ms","start":"2026-04-18T09:27:28.081307Z","end":"2026-04-18T09:27:28.311014Z","steps":["trace[391848949] 'count revisions from in-memory index tree' (duration: 229.32599ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:27:28.31126Z","caller":"traceutil/trace.go:171","msg":"trace[1315421538] transaction","detail":"{read_only:false; response_revision:9165; number_of_response:1; }","duration":"199.480545ms","start":"2026-04-18T09:27:28.11175Z","end":"2026-04-18T09:27:28.311231Z","steps":["trace[1315421538] 'process raft request' (duration: 198.154592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:27:41.1158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.722261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-04-18T09:27:41.115847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.146916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-48sdm\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-18T09:27:41.115957Z","caller":"traceutil/trace.go:171","msg":"trace[1893157355] range","detail":"{range_begin:/registry/pods/openstack/keepalived-48sdm; range_end:; response_count:1; response_revision:9237; }","duration":"176.329581ms","start":"2026-04-18T09:27:40.939603Z","end":"2026-04-18T09:27:41.115932Z","steps":["trace[1893157355] 'range keys from in-memory index tree' (duration: 175.835359ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:27:41.11596Z","caller":"traceutil/trace.go:171","msg":"trace[19640479] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9237; }","duration":"130.963776ms","start":"2026-04-18T09:27:40.984961Z","end":"2026-04-18T09:27:41.115924Z","steps":["trace[19640479] 'range keys from in-memory index tree' (duration: 130.448774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:27:41.115962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.679969ms","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-04-18T09:27:41.116027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.164889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"} {"level":"info","ts":"2026-04-18T09:27:41.116103Z","caller":"traceutil/trace.go:171","msg":"trace[2081821662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9237; }","duration":"273.877375ms","start":"2026-04-18T09:27:40.842198Z","end":"2026-04-18T09:27:41.116075Z","steps":["trace[2081821662] 'range keys from in-memory index tree' (duration: 273.345681ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:27:41.116143Z","caller":"traceutil/trace.go:171","msg":"trace[1186025975] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9237; }","duration":"195.332834ms","start":"2026-04-18T09:27:40.920785Z","end":"2026-04-18T09:27:41.116118Z","steps":["trace[1186025975] 'range keys from in-memory index tree' (duration: 194.642556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:27:41.116481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.57349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-18T09:27:41.116581Z","caller":"traceutil/trace.go:171","msg":"trace[1447421791] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9237; }","duration":"294.750284ms","start":"2026-04-18T09:27:40.821808Z","end":"2026-04-18T09:27:41.116558Z","steps":["trace[1447421791] 'range keys from in-memory index tree' (duration: 293.729198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T09:27:41.116962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.043146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-18T09:27:41.117062Z","caller":"traceutil/trace.go:171","msg":"trace[1120519204] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9237; }","duration":"271.20302ms","start":"2026-04-18T09:27:40.845845Z","end":"2026-04-18T09:27:41.117048Z","steps":["trace[1120519204] 'range keys from in-memory index tree' (duration: 269.631041ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T09:28:40.72973Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"344940fc142d902f","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-18T09:28:40.736321Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-18T09:28:40.73645Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-18T09:30:55.319187Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8241} {"level":"info","ts":"2026-04-18T09:30:55.402249Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8241,"took":"80.671241ms","hash":737826547,"current-db-size-bytes":58126336,"current-db-size":"58 MB","current-db-size-in-use-bytes":24866816,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-18T09:30:55.402305Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":737826547,"revision":8241,"compact-revision":6069} {"level":"info","ts":"2026-04-18T09:35:55.324349Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10629} {"level":"info","ts":"2026-04-18T09:35:55.406975Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10629,"took":"80.010597ms","hash":2948540169,"current-db-size-bytes":58126336,"current-db-size":"58 MB","current-db-size-in-use-bytes":20426752,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-18T09:35:55.407061Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2948540169,"revision":10629,"compact-revision":8241}