{"level":"warn","ts":"2026-04-07T09:36:33.033253Z","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-07T09:36:33.033337Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-07T09:36:33.0334Z","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-07T09:36:33.03341Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-04-07T09:36:33.033427Z","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-07T09:36:33.034136Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-04-07T09:36:33.034227Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-07T09:36:33.044019Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.545786ms"} {"level":"info","ts":"2026-04-07T09:36:33.062822Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-04-07T09:36:33.062915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T09:36:33.062937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-04-07T09:36:33.06295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T09:36:33.062961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-04-07T09:36:33.063002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-04-07T09:36:33.078011Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T09:36:33.07933Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T09:36:33.080248Z","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-07T09:36:33.081954Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T09:36:33.082114Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T09:36:33.08319Z","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-07T09:36:33.083391Z","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-07T09:36:33.083539Z","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-07T09:36:33.085214Z","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-07T09:36:33.085338Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-04-07T09:36:33.085421Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T09:36:33.085439Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-04-07T09:36:33.085405Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T09:36:33.085813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-04-07T09:36:33.085938Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-04-07T09:36:33.266008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T09:36:33.266076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T09:36:33.266093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-04-07T09:36:33.266104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-04-07T09:36:33.266109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-04-07T09:36:33.266119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-04-07T09:36:33.266125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-04-07T09:36:33.271195Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:36:33.272025Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T09:36:33.272287Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T09:36:33.272344Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T09:36:33.272374Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T09:36:33.272277Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T09:36:33.274909Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:36:33.275333Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:36:33.275435Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:36:33.277131Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T09:36:33.279098Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-04-07T09:36:44.753787Z","caller":"traceutil/trace.go:171","msg":"trace[1728098582] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"140.819513ms","start":"2026-04-07T09:36:44.612945Z","end":"2026-04-07T09:36:44.753764Z","steps":["trace[1728098582] 'process raft request' (duration: 140.689595ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:36:50.259906Z","caller":"traceutil/trace.go:171","msg":"trace[1644365075] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"100.999145ms","start":"2026-04-07T09:36:50.158883Z","end":"2026-04-07T09:36:50.259882Z","steps":["trace[1644365075] 'process raft request' (duration: 100.878157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:36:51.498956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.416497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-04-07T09:36:51.499051Z","caller":"traceutil/trace.go:171","msg":"trace[291896169] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:380; }","duration":"534.543425ms","start":"2026-04-07T09:36:50.964491Z","end":"2026-04-07T09:36:51.499034Z","steps":["trace[291896169] 'range keys from in-memory index tree' (duration: 534.350322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:36:51.499084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:36:50.964474Z","time spent":"534.601519ms","remote":"127.0.0.1:60558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4078,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-04-07T09:36:51.799037Z","caller":"traceutil/trace.go:171","msg":"trace[1980842164] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"296.516071ms","start":"2026-04-07T09:36:51.50249Z","end":"2026-04-07T09:36:51.799006Z","steps":["trace[1980842164] 'process raft request' (duration: 296.363791ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:36:51.829452Z","caller":"traceutil/trace.go:171","msg":"trace[536488637] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"319.652718ms","start":"2026-04-07T09:36:51.509769Z","end":"2026-04-07T09:36:51.829422Z","steps":["trace[536488637] 'process raft request' (duration: 319.437394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:36:51.83013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:36:51.509749Z","time spent":"319.785346ms","remote":"127.0.0.1:60558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:36:51.858658Z","caller":"traceutil/trace.go:171","msg":"trace[1122244113] linearizableReadLoop","detail":"{readStateIndex:395; appliedIndex:393; }","duration":"314.876396ms","start":"2026-04-07T09:36:51.543756Z","end":"2026-04-07T09:36:51.858632Z","steps":["trace[1122244113] 'read index received' (duration: 255.127335ms)","trace[1122244113] 'applied index is now lower than readState.Index' (duration: 59.748041ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:36:51.859137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.006648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T09:36:51.859205Z","caller":"traceutil/trace.go:171","msg":"trace[1889204505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:382; }","duration":"306.103095ms","start":"2026-04-07T09:36:51.553069Z","end":"2026-04-07T09:36:51.859172Z","steps":["trace[1889204505] 'agreement among raft nodes before linearized reading' (duration: 305.986918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:36:51.859247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:36:51.55305Z","time spent":"306.189761ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T09:36:51.859362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.603244ms","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-07T09:36:51.85946Z","caller":"traceutil/trace.go:171","msg":"trace[881604622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:382; }","duration":"315.728512ms","start":"2026-04-07T09:36:51.543697Z","end":"2026-04-07T09:36:51.859426Z","steps":["trace[881604622] 'agreement among raft nodes before linearized reading' (duration: 315.035207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:36:51.859509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:36:51.543676Z","time spent":"315.821848ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T09:36:51.859514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.018104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-04-07T09:36:51.859553Z","caller":"traceutil/trace.go:171","msg":"trace[1020693081] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:382; }","duration":"184.080029ms","start":"2026-04-07T09:36:51.675463Z","end":"2026-04-07T09:36:51.859543Z","steps":["trace[1020693081] 'agreement among raft nodes before linearized reading' (duration: 184.009914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:36:51.859986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.248924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:36:51.860026Z","caller":"traceutil/trace.go:171","msg":"trace[553553225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:382; }","duration":"296.322648ms","start":"2026-04-07T09:36:51.563685Z","end":"2026-04-07T09:36:51.860008Z","steps":["trace[553553225] 'agreement among raft nodes before linearized reading' (duration: 296.19716ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:37:11.299765Z","caller":"traceutil/trace.go:171","msg":"trace[461879414] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"172.768161ms","start":"2026-04-07T09:37:11.126974Z","end":"2026-04-07T09:37:11.299742Z","steps":["trace[461879414] 'process raft request' (duration: 172.592459ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:37:11.78483Z","caller":"traceutil/trace.go:171","msg":"trace[1881899843] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"220.376284ms","start":"2026-04-07T09:37:11.564434Z","end":"2026-04-07T09:37:11.78481Z","steps":["trace[1881899843] 'read index received' (duration: 218.456778ms)","trace[1881899843] 'applied index is now lower than readState.Index' (duration: 1.918656ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:37:11.784945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.493523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:37:11.784947Z","caller":"traceutil/trace.go:171","msg":"trace[479992657] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"628.648678ms","start":"2026-04-07T09:37:11.156266Z","end":"2026-04-07T09:37:11.784915Z","steps":["trace[479992657] 'process raft request' (duration: 626.953077ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:37:11.784984Z","caller":"traceutil/trace.go:171","msg":"trace[415812669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"220.59512ms","start":"2026-04-07T09:37:11.564365Z","end":"2026-04-07T09:37:11.78496Z","steps":["trace[415812669] 'agreement among raft nodes before linearized reading' (duration: 220.539206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:37:11.78511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:37:11.15622Z","time spent":"628.80994ms","remote":"127.0.0.1:60158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:37:12.330903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.812689ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-07T09:37:12.331273Z","caller":"traceutil/trace.go:171","msg":"trace[375484823] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"545.025251ms","start":"2026-04-07T09:37:11.786186Z","end":"2026-04-07T09:37:12.331211Z","steps":["trace[375484823] 'read index received' (duration: 4.765179ms)","trace[375484823] 'applied index is now lower than readState.Index' (duration: 540.257492ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:37:12.331306Z","caller":"traceutil/trace.go:171","msg":"trace[771580518] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"487.023508ms","start":"2026-04-07T09:37:11.844269Z","end":"2026-04-07T09:37:12.331292Z","steps":["trace[771580518] 'process raft request' (duration: 486.810032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:37:12.33142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.229205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:37:12.331457Z","caller":"traceutil/trace.go:171","msg":"trace[499982240] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"545.304262ms","start":"2026-04-07T09:37:11.786142Z","end":"2026-04-07T09:37:12.331446Z","steps":["trace[499982240] 'agreement among raft nodes before linearized reading' (duration: 545.219796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:37:12.331489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:37:11.786126Z","time spent":"545.356865ms","remote":"127.0.0.1:60086","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-07T09:37:12.331541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:37:11.84423Z","time spent":"487.186489ms","remote":"127.0.0.1:60610","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-07T09:37:12.331628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.241495ms","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-07T09:37:12.331704Z","caller":"traceutil/trace.go:171","msg":"trace[1843574168] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:586; }","duration":"441.367905ms","start":"2026-04-07T09:37:11.890318Z","end":"2026-04-07T09:37:12.331686Z","steps":["trace[1843574168] 'agreement among raft nodes before linearized reading' (duration: 441.141238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:37:12.331747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:37:11.890297Z","time spent":"441.441149ms","remote":"127.0.0.1:60338","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-07T09:37:12.331745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.280396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T09:37:12.33183Z","caller":"traceutil/trace.go:171","msg":"trace[751292715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"352.405015ms","start":"2026-04-07T09:37:11.979407Z","end":"2026-04-07T09:37:12.331812Z","steps":["trace[751292715] 'agreement among raft nodes before linearized reading' (duration: 352.148636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:37:12.331879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:37:11.979396Z","time spent":"352.47454ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T09:37:12.331974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.71664ms","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-07T09:37:12.332015Z","caller":"traceutil/trace.go:171","msg":"trace[2146784470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"355.817888ms","start":"2026-04-07T09:37:11.976187Z","end":"2026-04-07T09:37:12.332005Z","steps":["trace[2146784470] 'agreement among raft nodes before linearized reading' (duration: 355.576781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:37:12.332045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:37:11.976164Z","time spent":"355.874562ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T09:37:12.5829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.084095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:37:12.583099Z","caller":"traceutil/trace.go:171","msg":"trace[102788466] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"245.924119ms","start":"2026-04-07T09:37:12.337147Z","end":"2026-04-07T09:37:12.583071Z","steps":["trace[102788466] 'process raft request' (duration: 111.556504ms)","trace[102788466] 'compare' (duration: 133.903521ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:37:12.58378Z","caller":"traceutil/trace.go:171","msg":"trace[1787017891] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:610; }","duration":"239.450336ms","start":"2026-04-07T09:37:12.344256Z","end":"2026-04-07T09:37:12.583706Z","steps":["trace[1787017891] 'read index received' (duration: 60.43084ms)","trace[1787017891] 'applied index is now lower than readState.Index' (duration: 179.018196ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:37:12.583892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.628408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:37:12.583872Z","caller":"traceutil/trace.go:171","msg":"trace[1323810683] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"246.622258ms","start":"2026-04-07T09:37:12.337228Z","end":"2026-04-07T09:37:12.58385Z","steps":["trace[1323810683] 'process raft request' (duration: 245.777988ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:37:12.58393Z","caller":"traceutil/trace.go:171","msg":"trace[1888949144] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:589; }","duration":"239.690813ms","start":"2026-04-07T09:37:12.344226Z","end":"2026-04-07T09:37:12.583917Z","steps":["trace[1888949144] 'agreement among raft nodes before linearized reading' (duration: 239.631139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:37:12.584469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.765835ms","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-07T09:37:12.584516Z","caller":"traceutil/trace.go:171","msg":"trace[1479762802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"223.890393ms","start":"2026-04-07T09:37:12.360616Z","end":"2026-04-07T09:37:12.584506Z","steps":["trace[1479762802] 'agreement among raft nodes before linearized reading' (duration: 223.532087ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:37:17.274279Z","caller":"traceutil/trace.go:171","msg":"trace[70580836] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"106.729683ms","start":"2026-04-07T09:37:17.167524Z","end":"2026-04-07T09:37:17.274254Z","steps":["trace[70580836] 'process raft request' (duration: 106.665529ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:37:17.274309Z","caller":"traceutil/trace.go:171","msg":"trace[59724874] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"176.643981ms","start":"2026-04-07T09:37:17.097629Z","end":"2026-04-07T09:37:17.274273Z","steps":["trace[59724874] 'process raft request' (duration: 166.01782ms)","trace[59724874] 'compare' (duration: 10.396254ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:37:17.274316Z","caller":"traceutil/trace.go:171","msg":"trace[892266001] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"108.070991ms","start":"2026-04-07T09:37:17.166211Z","end":"2026-04-07T09:37:17.274282Z","steps":["trace[892266001] 'read index received' (duration: 97.451552ms)","trace[892266001] 'applied index is now lower than readState.Index' (duration: 10.615239ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:37:17.274609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.370083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2pzcl\" ","response":"range_response_count:1 size:18067"} {"level":"info","ts":"2026-04-07T09:37:17.274669Z","caller":"traceutil/trace.go:171","msg":"trace[662997052] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2pzcl; range_end:; response_count:1; response_revision:661; }","duration":"108.47255ms","start":"2026-04-07T09:37:17.166185Z","end":"2026-04-07T09:37:17.274658Z","steps":["trace[662997052] 'agreement among raft nodes before linearized reading' (duration: 108.19278ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:37:17.52657Z","caller":"traceutil/trace.go:171","msg":"trace[208130114] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"235.809407ms","start":"2026-04-07T09:37:17.290734Z","end":"2026-04-07T09:37:17.526543Z","steps":["trace[208130114] 'process raft request' (duration: 191.071115ms)","trace[208130114] 'compare' (duration: 44.604512ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:37:17.989803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.691425ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:37:17.990089Z","caller":"traceutil/trace.go:171","msg":"trace[1414784654] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"329.987342ms","start":"2026-04-07T09:37:17.659925Z","end":"2026-04-07T09:37:17.989913Z","steps":["trace[1414784654] 'process raft request' (duration: 188.938661ms)","trace[1414784654] 'compare' (duration: 140.575557ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:37:17.990264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:37:17.659908Z","time spent":"330.227359ms","remote":"127.0.0.1:60144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:37:18.020058Z","caller":"traceutil/trace.go:171","msg":"trace[735901482] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"243.433983ms","start":"2026-04-07T09:37:17.776587Z","end":"2026-04-07T09:37:18.020021Z","steps":["trace[735901482] 'process raft request' (duration: 242.98212ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:37:18.045468Z","caller":"traceutil/trace.go:171","msg":"trace[1774620845] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:691; }","duration":"127.916267ms","start":"2026-04-07T09:37:17.917529Z","end":"2026-04-07T09:37:18.045445Z","steps":["trace[1774620845] 'read index received' (duration: 101.897917ms)","trace[1774620845] 'applied index is now lower than readState.Index' (duration: 26.01723ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:37:18.045678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.142764ms","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-07T09:37:18.045716Z","caller":"traceutil/trace.go:171","msg":"trace[1058683213] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:669; }","duration":"128.331907ms","start":"2026-04-07T09:37:17.917374Z","end":"2026-04-07T09:37:18.045706Z","steps":["trace[1058683213] 'agreement among raft nodes before linearized reading' (duration: 128.157484ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:37:18.045946Z","caller":"traceutil/trace.go:171","msg":"trace[1041346481] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"166.438648ms","start":"2026-04-07T09:37:17.87948Z","end":"2026-04-07T09:37:18.045919Z","steps":["trace[1041346481] 'process raft request' (duration: 165.782371ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:37:53.235006Z","caller":"traceutil/trace.go:171","msg":"trace[966196027] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"104.086975ms","start":"2026-04-07T09:37:53.130891Z","end":"2026-04-07T09:37:53.234978Z","steps":["trace[966196027] 'process raft request' (duration: 46.086853ms)","trace[966196027] 'compare' (duration: 57.826477ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:37:53.244703Z","caller":"traceutil/trace.go:171","msg":"trace[863816730] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"113.60721ms","start":"2026-04-07T09:37:53.131068Z","end":"2026-04-07T09:37:53.244675Z","steps":["trace[863816730] 'process raft request' (duration: 113.309538ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:00.296919Z","caller":"traceutil/trace.go:171","msg":"trace[1398879052] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"278.877503ms","start":"2026-04-07T09:38:00.018016Z","end":"2026-04-07T09:38:00.296894Z","steps":["trace[1398879052] 'process raft request' (duration: 278.682436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:47.309652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.093007ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:38:47.309778Z","caller":"traceutil/trace.go:171","msg":"trace[142384036] linearizableReadLoop","detail":"{readStateIndex:1900; appliedIndex:1899; }","duration":"345.383635ms","start":"2026-04-07T09:38:46.964373Z","end":"2026-04-07T09:38:47.309756Z","steps":["trace[142384036] 'read index received' (duration: 7.012561ms)","trace[142384036] 'applied index is now lower than readState.Index' (duration: 338.369664ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:38:47.309954Z","caller":"traceutil/trace.go:171","msg":"trace[1533063283] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"384.951084ms","start":"2026-04-07T09:38:46.924987Z","end":"2026-04-07T09:38:47.309938Z","steps":["trace[1533063283] 'process raft request' (duration: 46.482118ms)","trace[1533063283] 'compare' (duration: 337.959154ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:38:47.310011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:46.924956Z","time spent":"385.028437ms","remote":"127.0.0.1:60338","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-07T09:38:47.310418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.033211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T09:38:47.310518Z","caller":"traceutil/trace.go:171","msg":"trace[1772791037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1827; }","duration":"346.170024ms","start":"2026-04-07T09:38:46.964324Z","end":"2026-04-07T09:38:47.310494Z","steps":["trace[1772791037] 'agreement among raft nodes before linearized reading' (duration: 345.705863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:47.310559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:46.964298Z","time spent":"346.252636ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T09:38:47.440977Z","caller":"traceutil/trace.go:171","msg":"trace[377594432] linearizableReadLoop","detail":"{readStateIndex:1901; appliedIndex:1900; }","duration":"131.140013ms","start":"2026-04-07T09:38:47.309815Z","end":"2026-04-07T09:38:47.440955Z","steps":["trace[377594432] 'read index received' (duration: 131.00972ms)","trace[377594432] 'applied index is now lower than readState.Index' (duration: 129.353µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:38:47.441082Z","caller":"traceutil/trace.go:171","msg":"trace[717043245] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"359.590462ms","start":"2026-04-07T09:38:47.081466Z","end":"2026-04-07T09:38:47.441056Z","steps":["trace[717043245] 'process raft request' (duration: 359.338996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:47.44112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.050205ms","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-07T09:38:47.441156Z","caller":"traceutil/trace.go:171","msg":"trace[1887141865] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1828; }","duration":"469.151479ms","start":"2026-04-07T09:38:46.971994Z","end":"2026-04-07T09:38:47.441146Z","steps":["trace[1887141865] 'agreement among raft nodes before linearized reading' (duration: 469.054606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:47.441218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:47.081437Z","time spent":"359.708035ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:38:47.441222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:46.971966Z","time spent":"469.22124ms","remote":"127.0.0.1:35924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:38:47.441237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.972211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-07T09:38:47.441429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.775971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-04-07T09:38:47.441477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.189219ms","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-07T09:38:47.441508Z","caller":"traceutil/trace.go:171","msg":"trace[485582161] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1828; }","duration":"185.888454ms","start":"2026-04-07T09:38:47.255603Z","end":"2026-04-07T09:38:47.441492Z","steps":["trace[485582161] 'agreement among raft nodes before linearized reading' (duration: 185.654568ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:47.441513Z","caller":"traceutil/trace.go:171","msg":"trace[2108061531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1828; }","duration":"311.262891ms","start":"2026-04-07T09:38:47.13024Z","end":"2026-04-07T09:38:47.441503Z","steps":["trace[2108061531] 'agreement among raft nodes before linearized reading' (duration: 311.161129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:47.441558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:47.130219Z","time spent":"311.328383ms","remote":"127.0.0.1:60338","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-07T09:38:47.441577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.838785ms","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-07T09:38:47.44166Z","caller":"traceutil/trace.go:171","msg":"trace[563642154] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1828; }","duration":"278.959678ms","start":"2026-04-07T09:38:47.162686Z","end":"2026-04-07T09:38:47.441646Z","steps":["trace[563642154] 'agreement among raft nodes before linearized reading' (duration: 278.732272ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:47.441696Z","caller":"traceutil/trace.go:171","msg":"trace[181978242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1828; }","duration":"187.109685ms","start":"2026-04-07T09:38:47.254198Z","end":"2026-04-07T09:38:47.441307Z","steps":["trace[181978242] 'agreement among raft nodes before linearized reading' (duration: 186.828878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:47.441714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.446327ms","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-07T09:38:47.441791Z","caller":"traceutil/trace.go:171","msg":"trace[1129090409] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1828; }","duration":"369.524819ms","start":"2026-04-07T09:38:47.072251Z","end":"2026-04-07T09:38:47.441776Z","steps":["trace[1129090409] 'agreement among raft nodes before linearized reading' (duration: 369.254972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:38:47.44187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:38:47.072202Z","time spent":"369.646772ms","remote":"127.0.0.1:60338","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-07T09:38:47.44524Z","caller":"traceutil/trace.go:171","msg":"trace[1303862620] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"131.018049ms","start":"2026-04-07T09:38:47.314208Z","end":"2026-04-07T09:38:47.445226Z","steps":["trace[1303862620] 'process raft request' (duration: 130.920186ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:38:47.92904Z","caller":"traceutil/trace.go:171","msg":"trace[1095678252] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"293.988471ms","start":"2026-04-07T09:38:47.635029Z","end":"2026-04-07T09:38:47.929018Z","steps":["trace[1095678252] 'process raft request' (duration: 293.746335ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:03.807121Z","caller":"traceutil/trace.go:171","msg":"trace[1697086061] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"116.240879ms","start":"2026-04-07T09:39:03.690857Z","end":"2026-04-07T09:39:03.807098Z","steps":["trace[1697086061] 'process raft request' (duration: 87.050852ms)","trace[1697086061] 'compare' (duration: 28.719581ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:39:27.013969Z","caller":"traceutil/trace.go:171","msg":"trace[1905873887] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"181.793241ms","start":"2026-04-07T09:39:26.832152Z","end":"2026-04-07T09:39:27.013945Z","steps":["trace[1905873887] 'process raft request' (duration: 181.444226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:27.899637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.958649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:39:27.899709Z","caller":"traceutil/trace.go:171","msg":"trace[275604690] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:2095; }","duration":"249.086334ms","start":"2026-04-07T09:39:27.650609Z","end":"2026-04-07T09:39:27.899696Z","steps":["trace[275604690] 'count revisions from in-memory index tree' (duration: 248.875115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:27.899733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.485672ms","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-07T09:39:27.899782Z","caller":"traceutil/trace.go:171","msg":"trace[366332149] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2095; }","duration":"128.566575ms","start":"2026-04-07T09:39:27.7712Z","end":"2026-04-07T09:39:27.899767Z","steps":["trace[366332149] 'range keys from in-memory index tree' (duration: 128.283973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:27.899884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.626013ms","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-07T09:39:27.899917Z","caller":"traceutil/trace.go:171","msg":"trace[1461582303] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2095; }","duration":"230.688385ms","start":"2026-04-07T09:39:27.66922Z","end":"2026-04-07T09:39:27.899908Z","steps":["trace[1461582303] 'range keys from in-memory index tree' (duration: 230.533478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:27.899727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.334836ms","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-07T09:39:27.900016Z","caller":"traceutil/trace.go:171","msg":"trace[1066617660] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2095; }","duration":"232.66134ms","start":"2026-04-07T09:39:27.667344Z","end":"2026-04-07T09:39:27.900006Z","steps":["trace[1066617660] 'range keys from in-memory index tree' (duration: 232.175809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:27.900047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.042006ms","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-07T09:39:27.900127Z","caller":"traceutil/trace.go:171","msg":"trace[968540256] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2095; }","duration":"181.176292ms","start":"2026-04-07T09:39:27.718932Z","end":"2026-04-07T09:39:27.900108Z","steps":["trace[968540256] 'range keys from in-memory index tree' (duration: 180.450931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:39:27.900139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.920731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-07T09:39:27.899789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.771936ms","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-07T09:39:27.900293Z","caller":"traceutil/trace.go:171","msg":"trace[1580759386] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2095; }","duration":"237.32662ms","start":"2026-04-07T09:39:27.662958Z","end":"2026-04-07T09:39:27.900284Z","steps":["trace[1580759386] 'range keys from in-memory index tree' (duration: 236.545647ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:27.901318Z","caller":"traceutil/trace.go:171","msg":"trace[78187690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2095; }","duration":"181.244315ms","start":"2026-04-07T09:39:27.719031Z","end":"2026-04-07T09:39:27.900275Z","steps":["trace[78187690] 'range keys from in-memory index tree' (duration: 180.513974ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:28.03218Z","caller":"traceutil/trace.go:171","msg":"trace[739032213] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"127.174703ms","start":"2026-04-07T09:39:27.904986Z","end":"2026-04-07T09:39:28.032161Z","steps":["trace[739032213] 'process raft request' (duration: 126.898421ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:28.032235Z","caller":"traceutil/trace.go:171","msg":"trace[1615997889] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"126.999846ms","start":"2026-04-07T09:39:27.905225Z","end":"2026-04-07T09:39:28.032225Z","steps":["trace[1615997889] 'process raft request' (duration: 126.824488ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:28.032171Z","caller":"traceutil/trace.go:171","msg":"trace[1098743417] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"126.587728ms","start":"2026-04-07T09:39:27.905553Z","end":"2026-04-07T09:39:28.032141Z","steps":["trace[1098743417] 'process raft request' (duration: 126.537106ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:00.172075Z","caller":"traceutil/trace.go:171","msg":"trace[941368090] transaction","detail":"{read_only:false; response_revision:2283; number_of_response:1; }","duration":"169.396226ms","start":"2026-04-07T09:40:00.002656Z","end":"2026-04-07T09:40:00.172052Z","steps":["trace[941368090] 'process raft request' (duration: 169.307241ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:00.172115Z","caller":"traceutil/trace.go:171","msg":"trace[802671880] transaction","detail":"{read_only:false; response_revision:2282; number_of_response:1; }","duration":"169.68041ms","start":"2026-04-07T09:40:00.002398Z","end":"2026-04-07T09:40:00.172078Z","steps":["trace[802671880] 'process raft request' (duration: 169.508172ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:00.172171Z","caller":"traceutil/trace.go:171","msg":"trace[692398121] transaction","detail":"{read_only:false; response_revision:2281; number_of_response:1; }","duration":"169.931983ms","start":"2026-04-07T09:40:00.002202Z","end":"2026-04-07T09:40:00.172134Z","steps":["trace[692398121] 'process raft request' (duration: 150.874067ms)","trace[692398121] 'compare' (duration: 18.682197ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:40:00.172879Z","caller":"traceutil/trace.go:171","msg":"trace[1340495795] transaction","detail":"{read_only:false; response_revision:2284; number_of_response:1; }","duration":"170.06286ms","start":"2026-04-07T09:40:00.002796Z","end":"2026-04-07T09:40:00.172859Z","steps":["trace[1340495795] 'process raft request' (duration: 169.214557ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:00.173242Z","caller":"traceutil/trace.go:171","msg":"trace[482726350] transaction","detail":"{read_only:false; response_revision:2286; number_of_response:1; }","duration":"160.759944ms","start":"2026-04-07T09:40:00.012471Z","end":"2026-04-07T09:40:00.173231Z","steps":["trace[482726350] 'process raft request' (duration: 160.361204ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:00.173163Z","caller":"traceutil/trace.go:171","msg":"trace[1798294100] transaction","detail":"{read_only:false; response_revision:2285; number_of_response:1; }","duration":"163.238721ms","start":"2026-04-07T09:40:00.009676Z","end":"2026-04-07T09:40:00.172915Z","steps":["trace[1798294100] 'process raft request' (duration: 162.966147ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.401834Z","caller":"traceutil/trace.go:171","msg":"trace[1088360781] transaction","detail":"{read_only:false; response_revision:2312; number_of_response:1; }","duration":"170.063427ms","start":"2026-04-07T09:40:04.231753Z","end":"2026-04-07T09:40:04.401816Z","steps":["trace[1088360781] 'process raft request' (duration: 156.491502ms)","trace[1088360781] 'compare' (duration: 13.458599ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:40:04.402009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.930218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-07T09:40:04.40204Z","caller":"traceutil/trace.go:171","msg":"trace[1819062067] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2312; }","duration":"127.997581ms","start":"2026-04-07T09:40:04.274035Z","end":"2026-04-07T09:40:04.402032Z","steps":["trace[1819062067] 'agreement among raft nodes before linearized reading' (duration: 127.831173ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.401834Z","caller":"traceutil/trace.go:171","msg":"trace[195980166] linearizableReadLoop","detail":"{readStateIndex:2401; appliedIndex:2399; }","duration":"127.739328ms","start":"2026-04-07T09:40:04.274065Z","end":"2026-04-07T09:40:04.401804Z","steps":["trace[195980166] 'read index received' (duration: 3.528674ms)","trace[195980166] 'applied index is now lower than readState.Index' (duration: 124.209554ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:40:04.402214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.602109ms","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-07T09:40:04.402258Z","caller":"traceutil/trace.go:171","msg":"trace[1526820969] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2312; }","duration":"126.680673ms","start":"2026-04-07T09:40:04.275572Z","end":"2026-04-07T09:40:04.402253Z","steps":["trace[1526820969] 'agreement among raft nodes before linearized reading' (duration: 126.603099ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:06.930305Z","caller":"traceutil/trace.go:171","msg":"trace[1729476289] transaction","detail":"{read_only:false; number_of_response:0; response_revision:2329; }","duration":"115.503533ms","start":"2026-04-07T09:40:06.814776Z","end":"2026-04-07T09:40:06.93028Z","steps":["trace[1729476289] 'process raft request' (duration: 115.372806ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:07.141427Z","caller":"traceutil/trace.go:171","msg":"trace[1465576022] transaction","detail":"{read_only:false; response_revision:2332; number_of_response:1; }","duration":"121.334579ms","start":"2026-04-07T09:40:07.020065Z","end":"2026-04-07T09:40:07.1414Z","steps":["trace[1465576022] 'process raft request' (duration: 72.176509ms)","trace[1465576022] 'compare' (duration: 49.048814ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:40:07.182505Z","caller":"traceutil/trace.go:171","msg":"trace[429584898] transaction","detail":"{read_only:false; response_revision:2333; number_of_response:1; }","duration":"152.189139ms","start":"2026-04-07T09:40:07.030285Z","end":"2026-04-07T09:40:07.182474Z","steps":["trace[429584898] 'process raft request' (duration: 152.062663ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:07.347137Z","caller":"traceutil/trace.go:171","msg":"trace[169783788] transaction","detail":"{read_only:false; response_revision:2334; number_of_response:1; }","duration":"157.953882ms","start":"2026-04-07T09:40:07.189159Z","end":"2026-04-07T09:40:07.347113Z","steps":["trace[169783788] 'process raft request' (duration: 157.521819ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:50.876168Z","caller":"traceutil/trace.go:171","msg":"trace[1100322032] linearizableReadLoop","detail":"{readStateIndex:2755; appliedIndex:2754; }","duration":"255.871818ms","start":"2026-04-07T09:40:50.620264Z","end":"2026-04-07T09:40:50.876135Z","steps":["trace[1100322032] 'read index received' (duration: 255.594862ms)","trace[1100322032] 'applied index is now lower than readState.Index' (duration: 274.866µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:40:50.876281Z","caller":"traceutil/trace.go:171","msg":"trace[138254624] transaction","detail":"{read_only:false; response_revision:2655; number_of_response:1; }","duration":"258.834271ms","start":"2026-04-07T09:40:50.617426Z","end":"2026-04-07T09:40:50.87626Z","steps":["trace[138254624] 'process raft request' (duration: 258.412216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:50.876496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.141646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T09:40:50.876548Z","caller":"traceutil/trace.go:171","msg":"trace[667849149] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2655; }","duration":"255.263213ms","start":"2026-04-07T09:40:50.621269Z","end":"2026-04-07T09:40:50.876532Z","steps":["trace[667849149] 'agreement among raft nodes before linearized reading' (duration: 255.070352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:50.876545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.470905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:40:50.876622Z","caller":"traceutil/trace.go:171","msg":"trace[1873644186] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:2655; }","duration":"246.608483ms","start":"2026-04-07T09:40:50.629994Z","end":"2026-04-07T09:40:50.876603Z","steps":["trace[1873644186] 'agreement among raft nodes before linearized reading' (duration: 246.475285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:50.876688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.401529ms","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-07T09:40:50.876829Z","caller":"traceutil/trace.go:171","msg":"trace[1952171052] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2655; }","duration":"256.610851ms","start":"2026-04-07T09:40:50.620197Z","end":"2026-04-07T09:40:50.876808Z","steps":["trace[1952171052] 'agreement among raft nodes before linearized reading' (duration: 256.098862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:50.876951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.429644ms","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-07T09:40:50.877087Z","caller":"traceutil/trace.go:171","msg":"trace[1359142772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2655; }","duration":"250.595634ms","start":"2026-04-07T09:40:50.626463Z","end":"2026-04-07T09:40:50.877059Z","steps":["trace[1359142772] 'agreement among raft nodes before linearized reading' (duration: 250.052873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:51.228311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.278362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:40:51.228443Z","caller":"traceutil/trace.go:171","msg":"trace[711902477] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2658; }","duration":"100.488434ms","start":"2026-04-07T09:40:51.127925Z","end":"2026-04-07T09:40:51.228414Z","steps":["trace[711902477] 'count revisions from in-memory index tree' (duration: 100.148904ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:10.530319Z","caller":"traceutil/trace.go:171","msg":"trace[1260008678] linearizableReadLoop","detail":"{readStateIndex:3611; appliedIndex:3610; }","duration":"132.628236ms","start":"2026-04-07T09:43:10.397663Z","end":"2026-04-07T09:43:10.530292Z","steps":["trace[1260008678] 'read index received' (duration: 132.382584ms)","trace[1260008678] 'applied index is now lower than readState.Index' (duration: 244.522µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:10.530388Z","caller":"traceutil/trace.go:171","msg":"trace[385843545] transaction","detail":"{read_only:false; response_revision:3478; number_of_response:1; }","duration":"140.059833ms","start":"2026-04-07T09:43:10.390284Z","end":"2026-04-07T09:43:10.530344Z","steps":["trace[385843545] 'process raft request' (duration: 139.826161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:10.531179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.423272ms","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-07T09:43:10.531249Z","caller":"traceutil/trace.go:171","msg":"trace[2066690751] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3478; }","duration":"133.604694ms","start":"2026-04-07T09:43:10.397628Z","end":"2026-04-07T09:43:10.531232Z","steps":["trace[2066690751] 'agreement among raft nodes before linearized reading' (duration: 132.819818ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:33.105281Z","caller":"traceutil/trace.go:171","msg":"trace[1909563912] transaction","detail":"{read_only:false; response_revision:3600; number_of_response:1; }","duration":"159.962076ms","start":"2026-04-07T09:43:32.945295Z","end":"2026-04-07T09:43:33.105257Z","steps":["trace[1909563912] 'process raft request' (duration: 159.806314ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:33.274162Z","caller":"traceutil/trace.go:171","msg":"trace[482184359] transaction","detail":"{read_only:false; response_revision:3603; number_of_response:1; }","duration":"146.188325ms","start":"2026-04-07T09:43:33.127937Z","end":"2026-04-07T09:43:33.274125Z","steps":["trace[482184359] 'process raft request' (duration: 84.804995ms)","trace[482184359] 'compare' (duration: 61.236008ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:47.612962Z","caller":"traceutil/trace.go:171","msg":"trace[1521558956] transaction","detail":"{read_only:false; response_revision:3712; number_of_response:1; }","duration":"153.852218ms","start":"2026-04-07T09:43:47.459085Z","end":"2026-04-07T09:43:47.612937Z","steps":["trace[1521558956] 'process raft request' (duration: 147.311583ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:48.583377Z","caller":"traceutil/trace.go:171","msg":"trace[1677579791] transaction","detail":"{read_only:false; response_revision:3738; number_of_response:1; }","duration":"113.059588ms","start":"2026-04-07T09:43:48.47029Z","end":"2026-04-07T09:43:48.583349Z","steps":["trace[1677579791] 'process raft request' (duration: 112.547528ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:48.733122Z","caller":"traceutil/trace.go:171","msg":"trace[1659377807] transaction","detail":"{read_only:false; response_revision:3741; number_of_response:1; }","duration":"114.878574ms","start":"2026-04-07T09:43:48.618223Z","end":"2026-04-07T09:43:48.733101Z","steps":["trace[1659377807] 'process raft request' (duration: 87.114107ms)","trace[1659377807] 'compare' (duration: 27.504212ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:13.722664Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868570908936790,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:13.989949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.724511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-04-07T09:44:13.990025Z","caller":"traceutil/trace.go:171","msg":"trace[1846548402] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3886; }","duration":"911.814063ms","start":"2026-04-07T09:44:13.078196Z","end":"2026-04-07T09:44:13.99001Z","steps":["trace[1846548402] 'range keys from in-memory index tree' (duration: 911.537316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.990065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:13.078141Z","time spent":"911.916765ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12233,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-07T09:44:13.99021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.882539ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:13.990495Z","caller":"traceutil/trace.go:171","msg":"trace[1131985892] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:3886; }","duration":"198.165986ms","start":"2026-04-07T09:44:13.792311Z","end":"2026-04-07T09:44:13.990477Z","steps":["trace[1131985892] 'range keys from in-memory index tree' (duration: 197.871609ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:13.990325Z","caller":"traceutil/trace.go:171","msg":"trace[1956065645] transaction","detail":"{read_only:false; response_revision:3887; number_of_response:1; }","duration":"773.642799ms","start":"2026-04-07T09:44:13.216669Z","end":"2026-04-07T09:44:13.990311Z","steps":["trace[1956065645] 'process raft request' (duration: 771.982627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.990665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:13.216643Z","time spent":"773.964207ms","remote":"127.0.0.1:60338","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-07T09:44:13.992605Z","caller":"traceutil/trace.go:171","msg":"trace[728532925] linearizableReadLoop","detail":"{readStateIndex:4050; appliedIndex:4047; }","duration":"770.12864ms","start":"2026-04-07T09:44:13.222457Z","end":"2026-04-07T09:44:13.992586Z","steps":["trace[728532925] 'read index received' (duration: 766.128698ms)","trace[728532925] 'applied index is now lower than readState.Index' (duration: 3.999062ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:13.992707Z","caller":"traceutil/trace.go:171","msg":"trace[1734238925] transaction","detail":"{read_only:false; response_revision:3889; number_of_response:1; }","duration":"282.916415ms","start":"2026-04-07T09:44:13.709769Z","end":"2026-04-07T09:44:13.992686Z","steps":["trace[1734238925] 'process raft request' (duration: 282.782462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.992779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.300085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:44:13.992828Z","caller":"traceutil/trace.go:171","msg":"trace[1381549522] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:3889; }","duration":"770.400976ms","start":"2026-04-07T09:44:13.222414Z","end":"2026-04-07T09:44:13.992815Z","steps":["trace[1381549522] 'agreement among raft nodes before linearized reading' (duration: 770.280123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.992856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:13.222396Z","time spent":"770.452868ms","remote":"127.0.0.1:39898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"info","ts":"2026-04-07T09:44:13.99277Z","caller":"traceutil/trace.go:171","msg":"trace[380530521] transaction","detail":"{read_only:false; response_revision:3888; number_of_response:1; }","duration":"727.418017ms","start":"2026-04-07T09:44:13.265207Z","end":"2026-04-07T09:44:13.992625Z","steps":["trace[380530521] 'process raft request' (duration: 727.241192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.993143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:13.265184Z","time spent":"727.800777ms","remote":"127.0.0.1:60338","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-07T09:44:13.993259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.434184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:13.993313Z","caller":"traceutil/trace.go:171","msg":"trace[1161995692] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:3889; }","duration":"566.520167ms","start":"2026-04-07T09:44:13.426782Z","end":"2026-04-07T09:44:13.993302Z","steps":["trace[1161995692] 'agreement among raft nodes before linearized reading' (duration: 566.429904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.993329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.650753ms","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-07T09:44:13.993338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:13.426768Z","time spent":"566.561897ms","remote":"127.0.0.1:35998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-07T09:44:13.993358Z","caller":"traceutil/trace.go:171","msg":"trace[622664824] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3889; }","duration":"253.707684ms","start":"2026-04-07T09:44:13.739641Z","end":"2026-04-07T09:44:13.993348Z","steps":["trace[622664824] 'agreement among raft nodes before linearized reading' (duration: 253.581211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.993529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.215445ms","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-07T09:44:13.993563Z","caller":"traceutil/trace.go:171","msg":"trace[1262904891] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3889; }","duration":"418.271497ms","start":"2026-04-07T09:44:13.575283Z","end":"2026-04-07T09:44:13.993554Z","steps":["trace[1262904891] 'agreement among raft nodes before linearized reading' (duration: 418.164054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.993585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:13.575271Z","time spent":"418.308698ms","remote":"127.0.0.1:60338","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-07T09:44:13.993563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.616964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:13.993631Z","caller":"traceutil/trace.go:171","msg":"trace[1634582576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3889; }","duration":"429.709047ms","start":"2026-04-07T09:44:13.563904Z","end":"2026-04-07T09:44:13.993613Z","steps":["trace[1634582576] 'agreement among raft nodes before linearized reading' (duration: 429.607414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.993682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:13.563888Z","time spent":"429.784289ms","remote":"127.0.0.1:60092","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-07T09:44:20.564099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000077723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T09:44:20.564255Z","caller":"traceutil/trace.go:171","msg":"trace[143131766] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000279788s","start":"2026-04-07T09:44:18.563956Z","end":"2026-04-07T09:44:20.564236Z","steps":["trace[143131766] 'agreement among raft nodes before linearized reading' (duration: 2.000103474s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:20.564368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.563939Z","time spent":"2.000409252s","remote":"127.0.0.1:60092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:44:21.135394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.028653516s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:21.135492Z","caller":"traceutil/trace.go:171","msg":"trace[1423021691] linearizableReadLoop","detail":"{readStateIndex:4072; appliedIndex:4071; }","duration":"3.114940857s","start":"2026-04-07T09:44:18.020536Z","end":"2026-04-07T09:44:21.135476Z","steps":["trace[1423021691] 'read index received' (duration: 86.088356ms)","trace[1423021691] 'applied index is now lower than readState.Index' (duration: 3.028851321s)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:21.135553Z","caller":"traceutil/trace.go:171","msg":"trace[475788934] transaction","detail":"{read_only:false; response_revision:3910; number_of_response:1; }","duration":"3.116329913s","start":"2026-04-07T09:44:18.019196Z","end":"2026-04-07T09:44:21.135526Z","steps":["trace[475788934] 'process raft request' (duration: 87.459081ms)","trace[475788934] 'compare' (duration: 3.027430743s)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:21.135641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.115109641s","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-07T09:44:21.13567Z","caller":"traceutil/trace.go:171","msg":"trace[1045504848] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3910; }","duration":"3.115166203s","start":"2026-04-07T09:44:18.020494Z","end":"2026-04-07T09:44:21.13566Z","steps":["trace[1045504848] 'agreement among raft nodes before linearized reading' (duration: 3.11504374s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.135708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.02048Z","time spent":"3.115220414s","remote":"127.0.0.1:60338","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-07T09:44:21.135737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.019173Z","time spent":"3.116476007s","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:21.156665Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.050037045s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T09:44:21.15692Z","caller":"traceutil/trace.go:171","msg":"trace[1861316348] transaction","detail":"{read_only:false; response_revision:3911; number_of_response:1; }","duration":"3.135123413s","start":"2026-04-07T09:44:18.021781Z","end":"2026-04-07T09:44:21.156904Z","steps":["trace[1861316348] 'process raft request' (duration: 3.135030171s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.157017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.02177Z","time spent":"3.135198685s","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:21.200385Z","caller":"traceutil/trace.go:171","msg":"trace[81219076] transaction","detail":"{read_only:false; response_revision:3912; number_of_response:1; }","duration":"2.333070555s","start":"2026-04-07T09:44:18.867291Z","end":"2026-04-07T09:44:21.200362Z","steps":["trace[81219076] 'process raft request' (duration: 2.33288623s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.200602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.867268Z","time spent":"2.333231399s","remote":"127.0.0.1:60338","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-07T09:44:21.20065Z","caller":"traceutil/trace.go:171","msg":"trace[221344864] transaction","detail":"{read_only:false; response_revision:3913; number_of_response:1; }","duration":"1.959792922s","start":"2026-04-07T09:44:19.240841Z","end":"2026-04-07T09:44:21.200633Z","steps":["trace[221344864] 'process raft request' (duration: 1.959456003s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.200698Z","caller":"traceutil/trace.go:171","msg":"trace[1948030035] transaction","detail":"{read_only:false; response_revision:3914; number_of_response:1; }","duration":"1.193103322s","start":"2026-04-07T09:44:20.007578Z","end":"2026-04-07T09:44:21.200681Z","steps":["trace[1948030035] 'process raft request' (duration: 1.192964889s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.200755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:19.240823Z","time spent":"1.959881145s","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:21.2008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:20.007558Z","time spent":"1.193191514s","remote":"127.0.0.1:60338","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-07T09:44:21.200895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.420227262s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:44:21.200935Z","caller":"traceutil/trace.go:171","msg":"trace[1531973048] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:3916; }","duration":"1.420300814s","start":"2026-04-07T09:44:19.780622Z","end":"2026-04-07T09:44:21.200923Z","steps":["trace[1531973048] 'agreement among raft nodes before linearized reading' (duration: 1.420212461s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.200955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.406943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:44:21.201001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.11665984s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"warn","ts":"2026-04-07T09:44:21.201031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.230798157s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:44:21.201065Z","caller":"traceutil/trace.go:171","msg":"trace[1857393086] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:3916; }","duration":"1.230872199s","start":"2026-04-07T09:44:19.970185Z","end":"2026-04-07T09:44:21.201057Z","steps":["trace[1857393086] 'agreement among raft nodes before linearized reading' (duration: 1.230804497s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.20108Z","caller":"traceutil/trace.go:171","msg":"trace[1164444079] transaction","detail":"{read_only:false; response_revision:3915; number_of_response:1; }","duration":"1.192790504s","start":"2026-04-07T09:44:20.008275Z","end":"2026-04-07T09:44:21.201066Z","steps":["trace[1164444079] 'process raft request' (duration: 1.192360962s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.201094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:19.970167Z","time spent":"1.230919259s","remote":"127.0.0.1:33164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":16,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:44:21.201112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.143152456s","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-07T09:44:21.201131Z","caller":"traceutil/trace.go:171","msg":"trace[1658600141] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3916; }","duration":"2.143201117s","start":"2026-04-07T09:44:19.057925Z","end":"2026-04-07T09:44:21.201126Z","steps":["trace[1658600141] 'agreement among raft nodes before linearized reading' (duration: 2.143132546s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.201163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:19.057909Z","time spent":"2.143248298s","remote":"127.0.0.1:60338","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-07T09:44:21.201171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:20.008268Z","time spent":"1.192853525s","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":507,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:21.200971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:19.780603Z","time spent":"1.420358685s","remote":"127.0.0.1:60334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":29,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:44:21.201261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.924827903s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:21.201283Z","caller":"traceutil/trace.go:171","msg":"trace[1350096613] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:3916; }","duration":"2.924888364s","start":"2026-04-07T09:44:18.276387Z","end":"2026-04-07T09:44:21.201275Z","steps":["trace[1350096613] 'agreement among raft nodes before linearized reading' (duration: 2.924853943s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.201301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.276367Z","time spent":"2.924929066s","remote":"127.0.0.1:36042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:44:21.200916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.179971205s","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-07T09:44:21.201399Z","caller":"traceutil/trace.go:171","msg":"trace[823392342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3916; }","duration":"3.180456379s","start":"2026-04-07T09:44:18.020911Z","end":"2026-04-07T09:44:21.201367Z","steps":["trace[823392342] 'agreement among raft nodes before linearized reading' (duration: 3.179896664s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.201451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.084146513s","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":"info","ts":"2026-04-07T09:44:21.201469Z","caller":"traceutil/trace.go:171","msg":"trace[1365248962] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:3916; }","duration":"3.084190185s","start":"2026-04-07T09:44:18.117274Z","end":"2026-04-07T09:44:21.201464Z","steps":["trace[1365248962] 'agreement among raft nodes before linearized reading' (duration: 3.084144513s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.201486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.11726Z","time spent":"3.084221905s","remote":"127.0.0.1:60286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":21,"response size":29,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:44:21.201507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.020905Z","time spent":"3.180560682s","remote":"127.0.0.1:60338","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-07T09:44:21.201038Z","caller":"traceutil/trace.go:171","msg":"trace[288265572] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3916; }","duration":"2.116729902s","start":"2026-04-07T09:44:19.084293Z","end":"2026-04-07T09:44:21.201023Z","steps":["trace[288265572] 'agreement among raft nodes before linearized reading' (duration: 2.11665912s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.201584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:19.084273Z","time spent":"2.117299737s","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12233,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-07T09:44:21.201618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.172625682s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T09:44:21.20164Z","caller":"traceutil/trace.go:171","msg":"trace[227405864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3916; }","duration":"3.172666883s","start":"2026-04-07T09:44:18.028968Z","end":"2026-04-07T09:44:21.201635Z","steps":["trace[227405864] 'agreement among raft nodes before linearized reading' (duration: 3.172608042s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.201656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.028956Z","time spent":"3.172695634s","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T09:44:21.201026Z","caller":"traceutil/trace.go:171","msg":"trace[212079310] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3916; }","duration":"635.474665ms","start":"2026-04-07T09:44:20.565532Z","end":"2026-04-07T09:44:21.201007Z","steps":["trace[212079310] 'agreement among raft nodes before linearized reading' (duration: 635.374892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.201717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:20.565487Z","time spent":"636.225935ms","remote":"127.0.0.1:60086","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-07T09:44:21.201235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.127649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:21.20199Z","caller":"traceutil/trace.go:171","msg":"trace[1315498076] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:3916; }","duration":"727.040263ms","start":"2026-04-07T09:44:20.474933Z","end":"2026-04-07T09:44:21.201973Z","steps":["trace[1315498076] 'agreement among raft nodes before linearized reading' (duration: 725.975354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.202089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:20.474917Z","time spent":"727.155646ms","remote":"127.0.0.1:60308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-04-07T09:44:23.248988Z","caller":"traceutil/trace.go:171","msg":"trace[1407573287] transaction","detail":"{read_only:false; response_revision:3922; number_of_response:1; }","duration":"102.01062ms","start":"2026-04-07T09:44:23.146959Z","end":"2026-04-07T09:44:23.248969Z","steps":["trace[1407573287] 'process raft request' (duration: 101.869846ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:23.470623Z","caller":"traceutil/trace.go:171","msg":"trace[2088761122] transaction","detail":"{read_only:false; response_revision:3927; number_of_response:1; }","duration":"180.840824ms","start":"2026-04-07T09:44:23.28975Z","end":"2026-04-07T09:44:23.470591Z","steps":["trace[2088761122] 'process raft request' (duration: 147.119509ms)","trace[2088761122] 'compare' (duration: 33.331195ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:23.470914Z","caller":"traceutil/trace.go:171","msg":"trace[1557049078] linearizableReadLoop","detail":"{readStateIndex:4093; appliedIndex:4088; }","duration":"166.681936ms","start":"2026-04-07T09:44:23.304213Z","end":"2026-04-07T09:44:23.470895Z","steps":["trace[1557049078] 'read index received' (duration: 289.978µs)","trace[1557049078] 'applied index is now lower than readState.Index' (duration: 166.391188ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:23.470977Z","caller":"traceutil/trace.go:171","msg":"trace[2000983540] transaction","detail":"{read_only:false; response_revision:3928; number_of_response:1; }","duration":"180.360161ms","start":"2026-04-07T09:44:23.2906Z","end":"2026-04-07T09:44:23.47096Z","steps":["trace[2000983540] 'process raft request' (duration: 179.870657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:23.471055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.84717ms","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-07T09:44:23.471092Z","caller":"traceutil/trace.go:171","msg":"trace[2121127115] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:3930; }","duration":"166.931812ms","start":"2026-04-07T09:44:23.304149Z","end":"2026-04-07T09:44:23.471081Z","steps":["trace[2121127115] 'agreement among raft nodes before linearized reading' (duration: 166.816089ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:23.471158Z","caller":"traceutil/trace.go:171","msg":"trace[461410711] transaction","detail":"{read_only:false; response_revision:3929; number_of_response:1; }","duration":"180.278799ms","start":"2026-04-07T09:44:23.290872Z","end":"2026-04-07T09:44:23.471151Z","steps":["trace[461410711] 'process raft request' (duration: 179.902758ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:23.471176Z","caller":"traceutil/trace.go:171","msg":"trace[296386967] transaction","detail":"{read_only:false; response_revision:3930; number_of_response:1; }","duration":"180.238917ms","start":"2026-04-07T09:44:23.290924Z","end":"2026-04-07T09:44:23.471163Z","steps":["trace[296386967] 'process raft request' (duration: 179.937649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:23.855205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.147039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-grafana\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:23.85529Z","caller":"traceutil/trace.go:171","msg":"trace[1318099575] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-grafana; range_end:; response_count:0; response_revision:3931; }","duration":"104.274173ms","start":"2026-04-07T09:44:23.750996Z","end":"2026-04-07T09:44:23.85527Z","steps":["trace[1318099575] 'range keys from in-memory index tree' (duration: 104.065427ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:24.397397Z","caller":"traceutil/trace.go:171","msg":"trace[1146397609] transaction","detail":"{read_only:false; response_revision:3932; number_of_response:1; }","duration":"159.918191ms","start":"2026-04-07T09:44:24.237447Z","end":"2026-04-07T09:44:24.397365Z","steps":["trace[1146397609] 'process raft request' (duration: 159.638833ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:24.44896Z","caller":"traceutil/trace.go:171","msg":"trace[276558491] transaction","detail":"{read_only:false; response_revision:3933; number_of_response:1; }","duration":"160.157488ms","start":"2026-04-07T09:44:24.288765Z","end":"2026-04-07T09:44:24.448923Z","steps":["trace[276558491] 'process raft request' (duration: 159.971702ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:24.760362Z","caller":"traceutil/trace.go:171","msg":"trace[1158841059] transaction","detail":"{read_only:false; response_revision:3934; number_of_response:1; }","duration":"172.13092ms","start":"2026-04-07T09:44:24.588205Z","end":"2026-04-07T09:44:24.760336Z","steps":["trace[1158841059] 'process raft request' (duration: 171.808581ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.151899Z","caller":"traceutil/trace.go:171","msg":"trace[291342504] transaction","detail":"{read_only:false; response_revision:3936; number_of_response:1; }","duration":"192.666117ms","start":"2026-04-07T09:44:24.959214Z","end":"2026-04-07T09:44:25.15188Z","steps":["trace[291342504] 'process raft request' (duration: 192.380749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.469974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.807338ms","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-07T09:44:25.470053Z","caller":"traceutil/trace.go:171","msg":"trace[1298709093] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3937; }","duration":"216.928541ms","start":"2026-04-07T09:44:25.253106Z","end":"2026-04-07T09:44:25.470035Z","steps":["trace[1298709093] 'range keys from in-memory index tree' (duration: 216.624083ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.470222Z","caller":"traceutil/trace.go:171","msg":"trace[928041327] transaction","detail":"{read_only:false; response_revision:3938; number_of_response:1; }","duration":"183.409087ms","start":"2026-04-07T09:44:25.28679Z","end":"2026-04-07T09:44:25.470199Z","steps":["trace[928041327] 'process raft request' (duration: 85.632364ms)","trace[928041327] 'compare' (duration: 97.444134ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:25.489336Z","caller":"traceutil/trace.go:171","msg":"trace[1376716590] transaction","detail":"{read_only:false; response_revision:3939; number_of_response:1; }","duration":"202.085027ms","start":"2026-04-07T09:44:25.287227Z","end":"2026-04-07T09:44:25.489312Z","steps":["trace[1376716590] 'process raft request' (duration: 201.899002ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.489608Z","caller":"traceutil/trace.go:171","msg":"trace[842813474] transaction","detail":"{read_only:false; response_revision:3940; number_of_response:1; }","duration":"202.347805ms","start":"2026-04-07T09:44:25.287237Z","end":"2026-04-07T09:44:25.489585Z","steps":["trace[842813474] 'process raft request' (duration: 202.014156ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.491324Z","caller":"traceutil/trace.go:171","msg":"trace[1295133998] linearizableReadLoop","detail":"{readStateIndex:4104; appliedIndex:4101; }","duration":"183.291825ms","start":"2026-04-07T09:44:25.308011Z","end":"2026-04-07T09:44:25.491302Z","steps":["trace[1295133998] 'read index received' (duration: 64.548628ms)","trace[1295133998] 'applied index is now lower than readState.Index' (duration: 118.741717ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:25.491498Z","caller":"traceutil/trace.go:171","msg":"trace[217215306] transaction","detail":"{read_only:false; response_revision:3941; number_of_response:1; }","duration":"163.822963ms","start":"2026-04-07T09:44:25.327545Z","end":"2026-04-07T09:44:25.491368Z","steps":["trace[217215306] 'process raft request' (duration: 162.380902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.491592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.558152ms","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-07T09:44:25.49173Z","caller":"traceutil/trace.go:171","msg":"trace[914713945] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3941; }","duration":"183.714526ms","start":"2026-04-07T09:44:25.307963Z","end":"2026-04-07T09:44:25.491677Z","steps":["trace[914713945] 'agreement among raft nodes before linearized reading' (duration: 183.444899ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.844945Z","caller":"traceutil/trace.go:171","msg":"trace[698092823] transaction","detail":"{read_only:false; response_revision:3948; number_of_response:1; }","duration":"321.150283ms","start":"2026-04-07T09:44:25.52377Z","end":"2026-04-07T09:44:25.84492Z","steps":["trace[698092823] 'process raft request' (duration: 321.108902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.845086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:25.523764Z","time spent":"321.249606ms","remote":"127.0.0.1:60338","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-07T09:44:25.84543Z","caller":"traceutil/trace.go:171","msg":"trace[89751683] transaction","detail":"{read_only:false; response_revision:3946; number_of_response:1; }","duration":"323.19791ms","start":"2026-04-07T09:44:25.52219Z","end":"2026-04-07T09:44:25.845388Z","steps":["trace[89751683] 'process raft request' (duration: 322.621864ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.845472Z","caller":"traceutil/trace.go:171","msg":"trace[1717147501] transaction","detail":"{read_only:false; response_revision:3945; number_of_response:1; }","duration":"323.298003ms","start":"2026-04-07T09:44:25.522152Z","end":"2026-04-07T09:44:25.84545Z","steps":["trace[1717147501] 'process raft request' (duration: 322.587573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.84556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:25.522145Z","time spent":"323.376355ms","remote":"127.0.0.1:60338","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-07T09:44:25.845462Z","caller":"traceutil/trace.go:171","msg":"trace[2071537218] transaction","detail":"{read_only:false; response_revision:3944; number_of_response:1; }","duration":"324.60585ms","start":"2026-04-07T09:44:25.520828Z","end":"2026-04-07T09:44:25.845434Z","steps":["trace[2071537218] 'process raft request' (duration: 241.30347ms)","trace[2071537218] 'compare' (duration: 82.169928ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:25.846335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:25.520814Z","time spent":"325.449404ms","remote":"127.0.0.1:60440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1418,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:44:25.845604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:25.522186Z","time spent":"323.334314ms","remote":"127.0.0.1:60338","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-07T09:44:25.845495Z","caller":"traceutil/trace.go:171","msg":"trace[1643277580] transaction","detail":"{read_only:false; response_revision:3947; number_of_response:1; }","duration":"323.15131ms","start":"2026-04-07T09:44:25.522319Z","end":"2026-04-07T09:44:25.84547Z","steps":["trace[1643277580] 'process raft request' (duration: 322.525422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.846821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:25.522314Z","time spent":"324.408474ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:26.148683Z","caller":"traceutil/trace.go:171","msg":"trace[581140493] transaction","detail":"{read_only:false; response_revision:3949; number_of_response:1; }","duration":"168.847501ms","start":"2026-04-07T09:44:25.979781Z","end":"2026-04-07T09:44:26.148628Z","steps":["trace[581140493] 'process raft request' (duration: 167.837893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:26.735497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.278817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-04-07T09:44:26.735597Z","caller":"traceutil/trace.go:171","msg":"trace[2040965518] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3950; }","duration":"374.431241ms","start":"2026-04-07T09:44:26.361151Z","end":"2026-04-07T09:44:26.735583Z","steps":["trace[2040965518] 'range keys from in-memory index tree' (duration: 374.075682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:26.735631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:26.361102Z","time spent":"374.521264ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12233,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-07T09:44:26.766707Z","caller":"traceutil/trace.go:171","msg":"trace[224438219] linearizableReadLoop","detail":"{readStateIndex:4115; appliedIndex:4114; }","duration":"228.023395ms","start":"2026-04-07T09:44:26.538629Z","end":"2026-04-07T09:44:26.766652Z","steps":["trace[224438219] 'read index received' (duration: 226.222904ms)","trace[224438219] 'applied index is now lower than readState.Index' (duration: 1.798881ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:26.76675Z","caller":"traceutil/trace.go:171","msg":"trace[775650891] transaction","detail":"{read_only:false; response_revision:3951; number_of_response:1; }","duration":"362.811355ms","start":"2026-04-07T09:44:26.403903Z","end":"2026-04-07T09:44:26.766714Z","steps":["trace[775650891] 'process raft request' (duration: 361.401436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:26.766955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.321354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T09:44:26.767009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.63154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-07T09:44:26.76701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:26.403874Z","time spent":"362.95349ms","remote":"127.0.0.1:60158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":451429,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:26.767065Z","caller":"traceutil/trace.go:171","msg":"trace[385617067] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:3951; }","duration":"219.728862ms","start":"2026-04-07T09:44:26.54732Z","end":"2026-04-07T09:44:26.767049Z","steps":["trace[385617067] 'agreement among raft nodes before linearized reading' (duration: 219.539757ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:26.767048Z","caller":"traceutil/trace.go:171","msg":"trace[422674525] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:3951; }","duration":"228.439097ms","start":"2026-04-07T09:44:26.538563Z","end":"2026-04-07T09:44:26.767003Z","steps":["trace[422674525] 'agreement among raft nodes before linearized reading' (duration: 228.22154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:26.767166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.820898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:26.767251Z","caller":"traceutil/trace.go:171","msg":"trace[1807151262] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3951; }","duration":"202.917831ms","start":"2026-04-07T09:44:26.564315Z","end":"2026-04-07T09:44:26.767232Z","steps":["trace[1807151262] 'agreement among raft nodes before linearized reading' (duration: 202.761067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:27.108097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.391806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:27.108421Z","caller":"traceutil/trace.go:171","msg":"trace[733180247] transaction","detail":"{read_only:false; response_revision:3952; number_of_response:1; }","duration":"313.41042ms","start":"2026-04-07T09:44:26.794972Z","end":"2026-04-07T09:44:27.108383Z","steps":["trace[733180247] 'process raft request' (duration: 181.648785ms)","trace[733180247] 'compare' (duration: 131.150428ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:27.108453Z","caller":"traceutil/trace.go:171","msg":"trace[1204000264] linearizableReadLoop","detail":"{readStateIndex:4118; appliedIndex:4116; }","duration":"250.456315ms","start":"2026-04-07T09:44:26.857914Z","end":"2026-04-07T09:44:27.10837Z","steps":["trace[1204000264] 'read index received' (duration: 118.689119ms)","trace[1204000264] 'applied index is now lower than readState.Index' (duration: 131.765386ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:27.108556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:26.79495Z","time spent":"313.547184ms","remote":"127.0.0.1:60426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1418,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:44:27.108608Z","caller":"traceutil/trace.go:171","msg":"trace[2123532315] transaction","detail":"{read_only:false; response_revision:3953; number_of_response:1; }","duration":"302.162515ms","start":"2026-04-07T09:44:26.806428Z","end":"2026-04-07T09:44:27.108591Z","steps":["trace[2123532315] 'process raft request' (duration: 301.784594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:27.108826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.091812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T09:44:27.108786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:26.806393Z","time spent":"302.303009ms","remote":"127.0.0.1:60102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:27.108884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.965059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:27.109077Z","caller":"traceutil/trace.go:171","msg":"trace[2059131380] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3953; }","duration":"251.193095ms","start":"2026-04-07T09:44:26.857857Z","end":"2026-04-07T09:44:27.10905Z","steps":["trace[2059131380] 'agreement among raft nodes before linearized reading' (duration: 250.985049ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.108866Z","caller":"traceutil/trace.go:171","msg":"trace[2037531416] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3953; }","duration":"154.171985ms","start":"2026-04-07T09:44:26.954684Z","end":"2026-04-07T09:44:27.108856Z","steps":["trace[2037531416] 'agreement among raft nodes before linearized reading' (duration: 154.065902ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.387258Z","caller":"traceutil/trace.go:171","msg":"trace[1995780705] transaction","detail":"{read_only:false; response_revision:3954; number_of_response:1; }","duration":"137.00159ms","start":"2026-04-07T09:44:27.250235Z","end":"2026-04-07T09:44:27.387237Z","steps":["trace[1995780705] 'process raft request' (duration: 136.158186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:27.632363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.389011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:27.6326Z","caller":"traceutil/trace.go:171","msg":"trace[740605483] transaction","detail":"{read_only:false; response_revision:3955; number_of_response:1; }","duration":"218.764738ms","start":"2026-04-07T09:44:27.413813Z","end":"2026-04-07T09:44:27.632578Z","steps":["trace[740605483] 'process raft request' (duration: 82.070658ms)","trace[740605483] 'compare' (duration: 136.197226ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:27.68691Z","caller":"traceutil/trace.go:171","msg":"trace[305603847] transaction","detail":"{read_only:false; response_revision:3957; number_of_response:1; }","duration":"203.977161ms","start":"2026-04-07T09:44:27.482906Z","end":"2026-04-07T09:44:27.686883Z","steps":["trace[305603847] 'process raft request' (duration: 203.875578ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.68693Z","caller":"traceutil/trace.go:171","msg":"trace[717394216] transaction","detail":"{read_only:false; response_revision:3956; number_of_response:1; }","duration":"210.812493ms","start":"2026-04-07T09:44:27.476089Z","end":"2026-04-07T09:44:27.686902Z","steps":["trace[717394216] 'process raft request' (duration: 210.491184ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.687195Z","caller":"traceutil/trace.go:171","msg":"trace[1010600209] transaction","detail":"{read_only:false; response_revision:3958; number_of_response:1; }","duration":"191.529219ms","start":"2026-04-07T09:44:27.495647Z","end":"2026-04-07T09:44:27.687176Z","steps":["trace[1010600209] 'process raft request' (duration: 191.184569ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.687189Z","caller":"traceutil/trace.go:171","msg":"trace[1903206472] linearizableReadLoop","detail":"{readStateIndex:4124; appliedIndex:4120; }","duration":"164.108495ms","start":"2026-04-07T09:44:27.523054Z","end":"2026-04-07T09:44:27.687162Z","steps":["trace[1903206472] 'read index received' (duration: 163.436226ms)","trace[1903206472] 'applied index is now lower than readState.Index' (duration: 670.849µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:27.687267Z","caller":"traceutil/trace.go:171","msg":"trace[1767275842] transaction","detail":"{read_only:false; response_revision:3959; number_of_response:1; }","duration":"191.511799ms","start":"2026-04-07T09:44:27.495729Z","end":"2026-04-07T09:44:27.687241Z","steps":["trace[1767275842] 'process raft request' (duration: 191.337224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:27.687437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.359972ms","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-07T09:44:27.68749Z","caller":"traceutil/trace.go:171","msg":"trace[594356771] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3959; }","duration":"164.451265ms","start":"2026-04-07T09:44:27.523027Z","end":"2026-04-07T09:44:27.687478Z","steps":["trace[594356771] 'agreement among raft nodes before linearized reading' (duration: 164.265329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:27.687662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.544431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:44:27.687733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.614263ms","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-07T09:44:27.688002Z","caller":"traceutil/trace.go:171","msg":"trace[1671775835] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3959; }","duration":"122.818049ms","start":"2026-04-07T09:44:27.564959Z","end":"2026-04-07T09:44:27.687777Z","steps":["trace[1671775835] 'agreement among raft nodes before linearized reading' (duration: 122.623104ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.688057Z","caller":"traceutil/trace.go:171","msg":"trace[116864755] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3959; }","duration":"122.745627ms","start":"2026-04-07T09:44:27.56498Z","end":"2026-04-07T09:44:27.687725Z","steps":["trace[116864755] 'agreement among raft nodes before linearized reading' (duration: 122.467669ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.901204Z","caller":"traceutil/trace.go:171","msg":"trace[140526282] transaction","detail":"{read_only:false; response_revision:3960; number_of_response:1; }","duration":"210.421722ms","start":"2026-04-07T09:44:27.69074Z","end":"2026-04-07T09:44:27.901162Z","steps":["trace[140526282] 'process raft request' (duration: 178.914712ms)","trace[140526282] 'compare' (duration: 31.204142ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:27.901481Z","caller":"traceutil/trace.go:171","msg":"trace[920884483] transaction","detail":"{read_only:false; response_revision:3961; number_of_response:1; }","duration":"207.740247ms","start":"2026-04-07T09:44:27.693709Z","end":"2026-04-07T09:44:27.901449Z","steps":["trace[920884483] 'process raft request' (duration: 207.308675ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.901554Z","caller":"traceutil/trace.go:171","msg":"trace[258427537] transaction","detail":"{read_only:false; response_revision:3962; number_of_response:1; }","duration":"207.714107ms","start":"2026-04-07T09:44:27.693821Z","end":"2026-04-07T09:44:27.901535Z","steps":["trace[258427537] 'process raft request' (duration: 207.274014ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:49.723012Z","caller":"traceutil/trace.go:171","msg":"trace[1896050013] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"322.133253ms","start":"2026-04-07T09:44:49.40083Z","end":"2026-04-07T09:44:49.722963Z","steps":["trace[1896050013] 'process raft request' (duration: 321.584596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:49.723236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:49.40081Z","time spent":"322.316059ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:49.748154Z","caller":"traceutil/trace.go:171","msg":"trace[1457782702] linearizableReadLoop","detail":"{readStateIndex:4836; appliedIndex:4834; }","duration":"212.685433ms","start":"2026-04-07T09:44:49.535447Z","end":"2026-04-07T09:44:49.748133Z","steps":["trace[1457782702] 'read index received' (duration: 187.303116ms)","trace[1457782702] 'applied index is now lower than readState.Index' (duration: 25.381197ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:49.748204Z","caller":"traceutil/trace.go:171","msg":"trace[1981558024] transaction","detail":"{read_only:false; response_revision:4655; number_of_response:1; }","duration":"346.687323ms","start":"2026-04-07T09:44:49.401475Z","end":"2026-04-07T09:44:49.748162Z","steps":["trace[1981558024] 'process raft request' (duration: 346.529668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:49.748375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:49.401451Z","time spent":"346.839948ms","remote":"127.0.0.1:60144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":878,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:44:49.748651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.174039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1dec694b-6b34-4773-bc2b-cddf55a8c457\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-04-07T09:44:49.748759Z","caller":"traceutil/trace.go:171","msg":"trace[76523037] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1dec694b-6b34-4773-bc2b-cddf55a8c457; range_end:; response_count:1; response_revision:4655; }","duration":"213.301883ms","start":"2026-04-07T09:44:49.535431Z","end":"2026-04-07T09:44:49.748733Z","steps":["trace[76523037] 'agreement among raft nodes before linearized reading' (duration: 212.830458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:50.437802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.009498ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:50.438022Z","caller":"traceutil/trace.go:171","msg":"trace[34234385] linearizableReadLoop","detail":"{readStateIndex:4843; appliedIndex:4842; }","duration":"371.214024ms","start":"2026-04-07T09:44:50.06679Z","end":"2026-04-07T09:44:50.438004Z","steps":["trace[34234385] 'read index received' (duration: 41.611µs)","trace[34234385] 'applied index is now lower than readState.Index' (duration: 371.169773ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:50.438054Z","caller":"traceutil/trace.go:171","msg":"trace[147373953] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"465.620102ms","start":"2026-04-07T09:44:49.972399Z","end":"2026-04-07T09:44:50.438019Z","steps":["trace[147373953] 'compare' (duration: 457.7932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:50.438281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:49.97237Z","time spent":"465.816099ms","remote":"127.0.0.1:60144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":937,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:44:50.438388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.589496ms","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-07T09:44:50.438455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.511114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:44:50.438484Z","caller":"traceutil/trace.go:171","msg":"trace[630603730] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4662; }","duration":"166.600587ms","start":"2026-04-07T09:44:50.271873Z","end":"2026-04-07T09:44:50.438474Z","steps":["trace[630603730] 'agreement among raft nodes before linearized reading' (duration: 166.552175ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:50.438515Z","caller":"traceutil/trace.go:171","msg":"trace[195589627] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4662; }","duration":"371.72496ms","start":"2026-04-07T09:44:50.066734Z","end":"2026-04-07T09:44:50.438459Z","steps":["trace[195589627] 'agreement among raft nodes before linearized reading' (duration: 371.39369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:50.438588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:50.066706Z","time spent":"371.866665ms","remote":"127.0.0.1:60338","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-07T09:44:50.438743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.348488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T09:44:50.438768Z","caller":"traceutil/trace.go:171","msg":"trace[2084176728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4662; }","duration":"354.390819ms","start":"2026-04-07T09:44:50.08437Z","end":"2026-04-07T09:44:50.43876Z","steps":["trace[2084176728] 'agreement among raft nodes before linearized reading' (duration: 354.271805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:50.438787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:50.084357Z","time spent":"354.425661ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T09:44:50.438884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.424272ms","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-07T09:44:50.438906Z","caller":"traceutil/trace.go:171","msg":"trace[1215023381] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4662; }","duration":"359.480415ms","start":"2026-04-07T09:44:50.079419Z","end":"2026-04-07T09:44:50.438899Z","steps":["trace[1215023381] 'agreement among raft nodes before linearized reading' (duration: 359.422483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:50.438923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:50.079402Z","time spent":"359.517125ms","remote":"127.0.0.1:60338","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-07T09:44:50.438402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.837186ms","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-07T09:44:50.439055Z","caller":"traceutil/trace.go:171","msg":"trace[2030647515] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4662; }","duration":"360.531268ms","start":"2026-04-07T09:44:50.07851Z","end":"2026-04-07T09:44:50.439041Z","steps":["trace[2030647515] 'agreement among raft nodes before linearized reading' (duration: 359.773894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:50.439124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:50.078495Z","time spent":"360.615841ms","remote":"127.0.0.1:60338","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-07T09:44:50.439166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.56528ms","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-07T09:44:50.439011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.337592ms","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-07T09:44:50.439227Z","caller":"traceutil/trace.go:171","msg":"trace[1165699621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4662; }","duration":"360.655823ms","start":"2026-04-07T09:44:50.078553Z","end":"2026-04-07T09:44:50.439209Z","steps":["trace[1165699621] 'agreement among raft nodes before linearized reading' (duration: 360.449826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:50.439255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:50.078515Z","time spent":"360.734535ms","remote":"127.0.0.1:60338","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-07T09:44:50.439301Z","caller":"traceutil/trace.go:171","msg":"trace[358659705] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4662; }","duration":"360.626411ms","start":"2026-04-07T09:44:50.078625Z","end":"2026-04-07T09:44:50.439251Z","steps":["trace[358659705] 'agreement among raft nodes before linearized reading' (duration: 360.339492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:50.440272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:50.078435Z","time spent":"361.000603ms","remote":"127.0.0.1:60338","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-07T09:44:53.839262Z","caller":"traceutil/trace.go:171","msg":"trace[670018721] linearizableReadLoop","detail":"{readStateIndex:4882; appliedIndex:4881; }","duration":"313.493938ms","start":"2026-04-07T09:44:53.52574Z","end":"2026-04-07T09:44:53.839234Z","steps":["trace[670018721] 'read index received' (duration: 313.106625ms)","trace[670018721] 'applied index is now lower than readState.Index' (duration: 385.673µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:53.839388Z","caller":"traceutil/trace.go:171","msg":"trace[1024697067] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"386.059969ms","start":"2026-04-07T09:44:53.453275Z","end":"2026-04-07T09:44:53.839335Z","steps":["trace[1024697067] 'process raft request' (duration: 385.731899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:53.839623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.781628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:53.839744Z","caller":"traceutil/trace.go:171","msg":"trace[1251537275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4700; }","duration":"274.950113ms","start":"2026-04-07T09:44:53.564772Z","end":"2026-04-07T09:44:53.839722Z","steps":["trace[1251537275] 'agreement among raft nodes before linearized reading' (duration: 274.750137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:53.839989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.225333ms","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-07T09:44:53.840054Z","caller":"traceutil/trace.go:171","msg":"trace[1397909316] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4700; }","duration":"314.348867ms","start":"2026-04-07T09:44:53.525687Z","end":"2026-04-07T09:44:53.840036Z","steps":["trace[1397909316] 'agreement among raft nodes before linearized reading' (duration: 313.727106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:53.840092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:53.525665Z","time spent":"314.417899ms","remote":"127.0.0.1:60338","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-07T09:44:53.839731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:53.4532Z","time spent":"386.278217ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3939,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:54.049235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.331859ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:54.049442Z","caller":"traceutil/trace.go:171","msg":"trace[641854761] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"203.248578ms","start":"2026-04-07T09:44:53.846148Z","end":"2026-04-07T09:44:54.049396Z","steps":["trace[641854761] 'process raft request' (duration: 56.824285ms)","trace[641854761] 'compare' (duration: 145.719309ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:54.049513Z","caller":"traceutil/trace.go:171","msg":"trace[1375953962] linearizableReadLoop","detail":"{readStateIndex:4883; appliedIndex:4882; }","duration":"202.776652ms","start":"2026-04-07T09:44:53.846691Z","end":"2026-04-07T09:44:54.049467Z","steps":["trace[1375953962] 'read index received' (duration: 56.38091ms)","trace[1375953962] 'applied index is now lower than readState.Index' (duration: 146.393422ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:54.049579Z","caller":"traceutil/trace.go:171","msg":"trace[226445848] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"193.602011ms","start":"2026-04-07T09:44:53.855951Z","end":"2026-04-07T09:44:54.049553Z","steps":["trace[226445848] 'process raft request' (duration: 193.415525ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:54.049691Z","caller":"traceutil/trace.go:171","msg":"trace[1509424040] transaction","detail":"{read_only:false; response_revision:4703; number_of_response:1; }","duration":"193.361453ms","start":"2026-04-07T09:44:53.856317Z","end":"2026-04-07T09:44:54.049678Z","steps":["trace[1509424040] 'process raft request' (duration: 193.168727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.049941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.201516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1dec694b-6b34-4773-bc2b-cddf55a8c457\" ","response":"range_response_count:1 size:3954"} {"level":"info","ts":"2026-04-07T09:44:54.050057Z","caller":"traceutil/trace.go:171","msg":"trace[1389092406] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1dec694b-6b34-4773-bc2b-cddf55a8c457; range_end:; response_count:1; response_revision:4703; }","duration":"203.419673ms","start":"2026-04-07T09:44:53.846618Z","end":"2026-04-07T09:44:54.050037Z","steps":["trace[1389092406] 'agreement among raft nodes before linearized reading' (duration: 202.982798ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:54.049977Z","caller":"traceutil/trace.go:171","msg":"trace[1896811406] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"193.065913ms","start":"2026-04-07T09:44:53.856903Z","end":"2026-04-07T09:44:54.049969Z","steps":["trace[1896811406] 'process raft request' (duration: 192.642379ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.050214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.479916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd.18a409f0e58f721f\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-04-07T09:44:54.050272Z","caller":"traceutil/trace.go:171","msg":"trace[190539953] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd.18a409f0e58f721f; range_end:; response_count:1; response_revision:4704; }","duration":"200.610891ms","start":"2026-04-07T09:44:53.849646Z","end":"2026-04-07T09:44:54.050257Z","steps":["trace[190539953] 'agreement among raft nodes before linearized reading' (duration: 200.297161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.491397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.603733ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:54.491613Z","caller":"traceutil/trace.go:171","msg":"trace[3983524] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"439.856835ms","start":"2026-04-07T09:44:54.05165Z","end":"2026-04-07T09:44:54.491507Z","steps":["trace[3983524] 'process raft request' (duration: 230.028995ms)","trace[3983524] 'compare' (duration: 209.440917ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:54.491957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.051627Z","time spent":"440.156215ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3951,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:54.524742Z","caller":"traceutil/trace.go:171","msg":"trace[1326366775] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"472.536262ms","start":"2026-04-07T09:44:54.052156Z","end":"2026-04-07T09:44:54.524692Z","steps":["trace[1326366775] 'process raft request' (duration: 472.271154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.524979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.052135Z","time spent":"472.712248ms","remote":"127.0.0.1:60144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":891,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:54.788375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.320413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-07T09:44:54.788547Z","caller":"traceutil/trace.go:171","msg":"trace[135199170] linearizableReadLoop","detail":"{readStateIndex:4889; appliedIndex:4888; }","duration":"263.901033ms","start":"2026-04-07T09:44:54.524627Z","end":"2026-04-07T09:44:54.788528Z","steps":["trace[135199170] 'read index received' (duration: 84.385983ms)","trace[135199170] 'applied index is now lower than readState.Index' (duration: 179.513129ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:54.788952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.838022ms","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-07T09:44:54.788999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.547263ms","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-07T09:44:54.788654Z","caller":"traceutil/trace.go:171","msg":"trace[1002142678] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4707; }","duration":"294.632415ms","start":"2026-04-07T09:44:54.494011Z","end":"2026-04-07T09:44:54.788644Z","steps":["trace[1002142678] 'process raft request' (duration: 114.92467ms)","trace[1002142678] 'compare' (duration: 179.062334ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:54.789127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.778951ms","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-07T09:44:54.789048Z","caller":"traceutil/trace.go:171","msg":"trace[462638123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4707; }","duration":"324.956796ms","start":"2026-04-07T09:44:54.46407Z","end":"2026-04-07T09:44:54.789027Z","steps":["trace[462638123] 'agreement among raft nodes before linearized reading' (duration: 324.725318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.789202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.276787ms","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-07T09:44:54.789214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.385107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-fc95fb499-p5lr8.18a409f24ed178df\" ","response":"range_response_count:1 size:893"} {"level":"info","ts":"2026-04-07T09:44:54.789306Z","caller":"traceutil/trace.go:171","msg":"trace[1750794234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4707; }","duration":"322.443003ms","start":"2026-04-07T09:44:54.466849Z","end":"2026-04-07T09:44:54.789292Z","steps":["trace[1750794234] 'agreement among raft nodes before linearized reading' (duration: 322.203795ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:54.789125Z","caller":"traceutil/trace.go:171","msg":"trace[1694973695] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4707; }","duration":"311.688278ms","start":"2026-04-07T09:44:54.477418Z","end":"2026-04-07T09:44:54.789106Z","steps":["trace[1694973695] 'agreement among raft nodes before linearized reading' (duration: 311.46501ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:54.789317Z","caller":"traceutil/trace.go:171","msg":"trace[297275882] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-fc95fb499-p5lr8.18a409f24ed178df; range_end:; response_count:1; response_revision:4707; }","duration":"260.521891ms","start":"2026-04-07T09:44:54.528777Z","end":"2026-04-07T09:44:54.789299Z","steps":["trace[297275882] 'agreement among raft nodes before linearized reading' (duration: 260.338085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.78899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.600548ms","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-07T09:44:54.789377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.466819Z","time spent":"322.522205ms","remote":"127.0.0.1:60338","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-07T09:44:54.789394Z","caller":"traceutil/trace.go:171","msg":"trace[123903124] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4707; }","duration":"313.036433ms","start":"2026-04-07T09:44:54.476345Z","end":"2026-04-07T09:44:54.789382Z","steps":["trace[123903124] 'agreement among raft nodes before linearized reading' (duration: 312.503255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.789397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.464062Z","time spent":"325.217634ms","remote":"127.0.0.1:60338","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-07T09:44:54.789434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.476291Z","time spent":"313.131296ms","remote":"127.0.0.1:60338","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-07T09:44:54.789526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.434061ms","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-07T09:44:54.789207Z","caller":"traceutil/trace.go:171","msg":"trace[1125778726] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4707; }","duration":"328.895915ms","start":"2026-04-07T09:44:54.460293Z","end":"2026-04-07T09:44:54.789189Z","steps":["trace[1125778726] 'agreement among raft nodes before linearized reading' (duration: 328.663788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.789606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.460276Z","time spent":"329.311339ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-04-07T09:44:54.78959Z","caller":"traceutil/trace.go:171","msg":"trace[1950032944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4707; }","duration":"325.595697ms","start":"2026-04-07T09:44:54.463979Z","end":"2026-04-07T09:44:54.789575Z","steps":["trace[1950032944] 'agreement among raft nodes before linearized reading' (duration: 325.050669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.789874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.463947Z","time spent":"325.907777ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T09:44:54.790524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.47741Z","time spent":"312.216096ms","remote":"127.0.0.1:60338","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-07T09:44:55.182522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.76987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:55.182658Z","caller":"traceutil/trace.go:171","msg":"trace[1896365739] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"390.462404ms","start":"2026-04-07T09:44:54.792175Z","end":"2026-04-07T09:44:55.182638Z","steps":["trace[1896365739] 'process raft request' (duration: 135.478248ms)","trace[1896365739] 'compare' (duration: 254.422528ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:55.182732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.79216Z","time spent":"390.541307ms","remote":"127.0.0.1:60144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":878,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:55.203244Z","caller":"traceutil/trace.go:171","msg":"trace[897194479] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"407.985945ms","start":"2026-04-07T09:44:54.795231Z","end":"2026-04-07T09:44:55.203217Z","steps":["trace[897194479] 'process raft request' (duration: 407.896282ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.203264Z","caller":"traceutil/trace.go:171","msg":"trace[2111106990] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"408.13517ms","start":"2026-04-07T09:44:54.795098Z","end":"2026-04-07T09:44:55.203233Z","steps":["trace[2111106990] 'process raft request' (duration: 407.873862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.203425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.795197Z","time spent":"408.123919ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:55.20353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.795065Z","time spent":"408.399459ms","remote":"127.0.0.1:60338","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-07T09:44:55.20363Z","caller":"traceutil/trace.go:171","msg":"trace[305919574] transaction","detail":"{read_only:false; response_revision:4712; number_of_response:1; }","duration":"408.004695ms","start":"2026-04-07T09:44:54.795618Z","end":"2026-04-07T09:44:55.203623Z","steps":["trace[305919574] 'process raft request' (duration: 407.800869ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.203596Z","caller":"traceutil/trace.go:171","msg":"trace[1826021308] transaction","detail":"{read_only:false; response_revision:4711; number_of_response:1; }","duration":"408.031237ms","start":"2026-04-07T09:44:54.795521Z","end":"2026-04-07T09:44:55.203553Z","steps":["trace[1826021308] 'process raft request' (duration: 407.647524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.203659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.795608Z","time spent":"408.038167ms","remote":"127.0.0.1:60218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1203,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:44:55.203747Z","caller":"traceutil/trace.go:171","msg":"trace[717757951] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"407.017904ms","start":"2026-04-07T09:44:54.796703Z","end":"2026-04-07T09:44:55.203721Z","steps":["trace[717757951] 'process raft request' (duration: 406.836408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.203778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.795512Z","time spent":"408.165761ms","remote":"127.0.0.1:60338","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-07T09:44:55.203794Z","caller":"traceutil/trace.go:171","msg":"trace[1526772191] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"406.124544ms","start":"2026-04-07T09:44:54.797663Z","end":"2026-04-07T09:44:55.203788Z","steps":["trace[1526772191] 'process raft request' (duration: 405.953598ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.203786Z","caller":"traceutil/trace.go:171","msg":"trace[530250268] linearizableReadLoop","detail":"{readStateIndex:4897; appliedIndex:4889; }","duration":"339.660662ms","start":"2026-04-07T09:44:54.864083Z","end":"2026-04-07T09:44:55.203744Z","steps":["trace[530250268] 'read index received' (duration: 63.695041ms)","trace[530250268] 'applied index is now lower than readState.Index' (duration: 275.964451ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:55.203823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.797653Z","time spent":"406.155264ms","remote":"127.0.0.1:60338","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-07T09:44:55.203849Z","caller":"traceutil/trace.go:171","msg":"trace[1515759742] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"406.060022ms","start":"2026-04-07T09:44:54.797784Z","end":"2026-04-07T09:44:55.203844Z","steps":["trace[1515759742] 'process raft request' (duration: 405.924887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.203876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.797778Z","time spent":"406.084882ms","remote":"127.0.0.1:60338","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-07T09:44:55.203858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.796692Z","time spent":"407.108486ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:55.204013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.90383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:44:55.204094Z","caller":"traceutil/trace.go:171","msg":"trace[13261674] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:4715; }","duration":"340.017744ms","start":"2026-04-07T09:44:54.86404Z","end":"2026-04-07T09:44:55.204057Z","steps":["trace[13261674] 'agreement among raft nodes before linearized reading' (duration: 339.869539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.204147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.864016Z","time spent":"340.113387ms","remote":"127.0.0.1:60564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":6,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:44:55.65326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.119483ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:55.653429Z","caller":"traceutil/trace.go:171","msg":"trace[653894544] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"711.576337ms","start":"2026-04-07T09:44:54.94183Z","end":"2026-04-07T09:44:55.653406Z","steps":["trace[653894544] 'process raft request' (duration: 536.235248ms)","trace[653894544] 'compare' (duration: 174.991308ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:55.653591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.941783Z","time spent":"711.701231ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:55.653529Z","caller":"traceutil/trace.go:171","msg":"trace[1410826499] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"444.977014ms","start":"2026-04-07T09:44:55.208502Z","end":"2026-04-07T09:44:55.653479Z","steps":["trace[1410826499] 'process raft request' (duration: 444.838949ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.653662Z","caller":"traceutil/trace.go:171","msg":"trace[579639437] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"442.360507ms","start":"2026-04-07T09:44:55.211125Z","end":"2026-04-07T09:44:55.653486Z","steps":["trace[579639437] 'process raft request' (duration: 442.279174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.653765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.211095Z","time spent":"442.623786ms","remote":"127.0.0.1:60218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1307,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:55.653761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.20848Z","time spent":"445.16673ms","remote":"127.0.0.1:60144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":848,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:44:55.890712Z","caller":"traceutil/trace.go:171","msg":"trace[1073602593] transaction","detail":"{read_only:false; response_revision:4719; number_of_response:1; }","duration":"233.049442ms","start":"2026-04-07T09:44:55.657621Z","end":"2026-04-07T09:44:55.89067Z","steps":["trace[1073602593] 'process raft request' (duration: 209.925156ms)","trace[1073602593] 'compare' (duration: 22.817665ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:55.890741Z","caller":"traceutil/trace.go:171","msg":"trace[714359810] linearizableReadLoop","detail":"{readStateIndex:4901; appliedIndex:4900; }","duration":"198.669092ms","start":"2026-04-07T09:44:55.691856Z","end":"2026-04-07T09:44:55.890525Z","steps":["trace[714359810] 'read index received' (duration: 175.629789ms)","trace[714359810] 'applied index is now lower than readState.Index' (duration: 23.037723ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:55.890826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.950362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd.18a409eef501486a\" ","response":"range_response_count:1 size:832"} {"level":"info","ts":"2026-04-07T09:44:55.890855Z","caller":"traceutil/trace.go:171","msg":"trace[699433880] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd.18a409eef501486a; range_end:; response_count:1; response_revision:4719; }","duration":"199.030844ms","start":"2026-04-07T09:44:55.691817Z","end":"2026-04-07T09:44:55.890848Z","steps":["trace[699433880] 'agreement among raft nodes before linearized reading' (duration: 198.913941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.453204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.733377ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:56.453722Z","caller":"traceutil/trace.go:171","msg":"trace[1598397843] transaction","detail":"{read_only:false; response_revision:4721; number_of_response:1; }","duration":"557.830894ms","start":"2026-04-07T09:44:55.895851Z","end":"2026-04-07T09:44:56.453682Z","steps":["trace[1598397843] 'process raft request' (duration: 248.543598ms)","trace[1598397843] 'compare' (duration: 308.623614ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:56.45393Z","caller":"traceutil/trace.go:171","msg":"trace[1607682900] linearizableReadLoop","detail":"{readStateIndex:4903; appliedIndex:4902; }","duration":"445.603824ms","start":"2026-04-07T09:44:56.008314Z","end":"2026-04-07T09:44:56.453917Z","steps":["trace[1607682900] 'read index received' (duration: 136.043929ms)","trace[1607682900] 'applied index is now lower than readState.Index' (duration: 309.558865ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:56.453956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.89584Z","time spent":"557.967698ms","remote":"127.0.0.1:60232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1850,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:56.454276Z","caller":"traceutil/trace.go:171","msg":"trace[1606394197] transaction","detail":"{read_only:false; response_revision:4722; number_of_response:1; }","duration":"399.012843ms","start":"2026-04-07T09:44:56.055248Z","end":"2026-04-07T09:44:56.454261Z","steps":["trace[1606394197] 'process raft request' (duration: 398.698633ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.454291Z","caller":"traceutil/trace.go:171","msg":"trace[2082842323] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"398.769234ms","start":"2026-04-07T09:44:56.055502Z","end":"2026-04-07T09:44:56.454271Z","steps":["trace[2082842323] 'process raft request' (duration: 398.658831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.454362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.055228Z","time spent":"399.101515ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":507,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:56.454473Z","caller":"traceutil/trace.go:171","msg":"trace[1816660755] transaction","detail":"{read_only:false; response_revision:4724; number_of_response:1; }","duration":"398.6309ms","start":"2026-04-07T09:44:56.055825Z","end":"2026-04-07T09:44:56.454456Z","steps":["trace[1816660755] 'process raft request' (duration: 398.404522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.45455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.055465Z","time spent":"398.911369ms","remote":"127.0.0.1:60338","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-07T09:44:56.45457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.055804Z","time spent":"398.718123ms","remote":"127.0.0.1:60338","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-07T09:44:56.454279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.951715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd.18a409eef8519f1e\" ","response":"range_response_count:1 size:832"} {"level":"info","ts":"2026-04-07T09:44:56.454825Z","caller":"traceutil/trace.go:171","msg":"trace[521550729] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd.18a409eef8519f1e; range_end:; response_count:1; response_revision:4721; }","duration":"446.513104ms","start":"2026-04-07T09:44:56.008277Z","end":"2026-04-07T09:44:56.45479Z","steps":["trace[521550729] 'agreement among raft nodes before linearized reading' (duration: 445.674886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.454958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.008262Z","time spent":"446.656589ms","remote":"127.0.0.1:60144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":854,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd.18a409eef8519f1e\" "} {"level":"warn","ts":"2026-04-07T09:44:56.809531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.638809ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:56.809739Z","caller":"traceutil/trace.go:171","msg":"trace[543150217] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"302.958464ms","start":"2026-04-07T09:44:56.506762Z","end":"2026-04-07T09:44:56.809721Z","steps":["trace[543150217] 'process raft request' (duration: 302.885112ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.809773Z","caller":"traceutil/trace.go:171","msg":"trace[598601083] linearizableReadLoop","detail":"{readStateIndex:4907; appliedIndex:4906; }","duration":"351.040955ms","start":"2026-04-07T09:44:56.458676Z","end":"2026-04-07T09:44:56.809717Z","steps":["trace[598601083] 'read index received' (duration: 98.134937ms)","trace[598601083] 'applied index is now lower than readState.Index' (duration: 252.902968ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:56.809808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.506733Z","time spent":"303.044857ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9208,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:56.809973Z","caller":"traceutil/trace.go:171","msg":"trace[1376310389] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"352.229055ms","start":"2026-04-07T09:44:56.457726Z","end":"2026-04-07T09:44:56.809955Z","steps":["trace[1376310389] 'process raft request' (duration: 99.068668ms)","trace[1376310389] 'compare' (duration: 252.499055ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:56.810189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.457702Z","time spent":"352.350448ms","remote":"127.0.0.1:60144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":817,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:56.810466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.486356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd\" ","response":"range_response_count:1 size:9901"} {"level":"info","ts":"2026-04-07T09:44:56.810606Z","caller":"traceutil/trace.go:171","msg":"trace[436182199] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd; range_end:; response_count:1; response_revision:4726; }","duration":"347.674673ms","start":"2026-04-07T09:44:56.462896Z","end":"2026-04-07T09:44:56.81057Z","steps":["trace[436182199] 'agreement among raft nodes before linearized reading' (duration: 347.268119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.810687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.462883Z","time spent":"347.784487ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9923,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd\" "} {"level":"warn","ts":"2026-04-07T09:44:56.810483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.747888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-1dec694b-6b34-4773-bc2b-cddf55a8c457\" ","response":"range_response_count:1 size:1322"} {"level":"warn","ts":"2026-04-07T09:44:56.810488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.759599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-07T09:44:56.810796Z","caller":"traceutil/trace.go:171","msg":"trace[1265439533] range","detail":"{range_begin:/registry/persistentvolumes/pvc-1dec694b-6b34-4773-bc2b-cddf55a8c457; range_end:; response_count:1; response_revision:4726; }","duration":"352.131601ms","start":"2026-04-07T09:44:56.458629Z","end":"2026-04-07T09:44:56.810761Z","steps":["trace[1265439533] 'agreement among raft nodes before linearized reading' (duration: 351.609263ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.811174Z","caller":"traceutil/trace.go:171","msg":"trace[608528550] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:4726; }","duration":"261.520155ms","start":"2026-04-07T09:44:56.549631Z","end":"2026-04-07T09:44:56.811151Z","steps":["trace[608528550] 'agreement among raft nodes before linearized reading' (duration: 260.613385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.811181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.458609Z","time spent":"352.526104ms","remote":"127.0.0.1:60218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1344,"request content":"key:\"/registry/persistentvolumes/pvc-1dec694b-6b34-4773-bc2b-cddf55a8c457\" "} {"level":"warn","ts":"2026-04-07T09:44:57.391961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.003484ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-04-07T09:44:57.39218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.814245Z","time spent":"577.926119ms","remote":"127.0.0.1:60102","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-07T09:44:57.392318Z","caller":"traceutil/trace.go:171","msg":"trace[69765644] linearizableReadLoop","detail":"{readStateIndex:4911; appliedIndex:4908; }","duration":"542.793139ms","start":"2026-04-07T09:44:56.849506Z","end":"2026-04-07T09:44:57.392299Z","steps":["trace[69765644] 'read index received' (duration: 230.449883ms)","trace[69765644] 'applied index is now lower than readState.Index' (duration: 312.342266ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:57.392542Z","caller":"traceutil/trace.go:171","msg":"trace[909303525] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"569.530519ms","start":"2026-04-07T09:44:56.822975Z","end":"2026-04-07T09:44:57.392506Z","steps":["trace[909303525] 'process raft request' (duration: 569.219828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.392669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.822958Z","time spent":"569.637253ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9713,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:57.392781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.274605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-07T09:44:57.392751Z","caller":"traceutil/trace.go:171","msg":"trace[1441624420] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"578.177197ms","start":"2026-04-07T09:44:56.814529Z","end":"2026-04-07T09:44:57.392706Z","steps":["trace[1441624420] 'process raft request' (duration: 577.525156ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:57.392847Z","caller":"traceutil/trace.go:171","msg":"trace[1462861857] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4728; }","duration":"543.368348ms","start":"2026-04-07T09:44:56.849444Z","end":"2026-04-07T09:44:57.392813Z","steps":["trace[1462861857] 'agreement among raft nodes before linearized reading' (duration: 543.145751ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.392885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.859879ms","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-07T09:44:57.392918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.849417Z","time spent":"543.486932ms","remote":"127.0.0.1:60232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-07T09:44:57.392966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.814505Z","time spent":"578.354184ms","remote":"127.0.0.1:60144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":720,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:44:57.393033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.012864ms","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-07T09:44:57.392808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.96059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:57.393077Z","caller":"traceutil/trace.go:171","msg":"trace[490997416] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4728; }","duration":"184.091076ms","start":"2026-04-07T09:44:57.208974Z","end":"2026-04-07T09:44:57.393065Z","steps":["trace[490997416] 'agreement among raft nodes before linearized reading' (duration: 183.985873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.393083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.425505ms","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-07T09:44:57.393092Z","caller":"traceutil/trace.go:171","msg":"trace[681491392] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:4728; }","duration":"198.283531ms","start":"2026-04-07T09:44:57.19479Z","end":"2026-04-07T09:44:57.393073Z","steps":["trace[681491392] 'agreement among raft nodes before linearized reading' (duration: 197.96266ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:57.393121Z","caller":"traceutil/trace.go:171","msg":"trace[800057042] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4728; }","duration":"183.476266ms","start":"2026-04-07T09:44:57.209634Z","end":"2026-04-07T09:44:57.393111Z","steps":["trace[800057042] 'agreement among raft nodes before linearized reading' (duration: 183.359202ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:57.392935Z","caller":"traceutil/trace.go:171","msg":"trace[396892743] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4728; }","duration":"183.906631ms","start":"2026-04-07T09:44:57.209013Z","end":"2026-04-07T09:44:57.392919Z","steps":["trace[396892743] 'agreement among raft nodes before linearized reading' (duration: 183.784726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.393148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.531518ms","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-07T09:44:57.39321Z","caller":"traceutil/trace.go:171","msg":"trace[450542102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4728; }","duration":"183.610721ms","start":"2026-04-07T09:44:57.20959Z","end":"2026-04-07T09:44:57.393201Z","steps":["trace[450542102] 'agreement among raft nodes before linearized reading' (duration: 183.477846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.392938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.4862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-07T09:44:57.393032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.864629ms","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-07T09:44:57.39326Z","caller":"traceutil/trace.go:171","msg":"trace[166356715] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4728; }","duration":"184.843842ms","start":"2026-04-07T09:44:57.208406Z","end":"2026-04-07T09:44:57.39325Z","steps":["trace[166356715] 'agreement among raft nodes before linearized reading' (duration: 184.431658ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:57.39328Z","caller":"traceutil/trace.go:171","msg":"trace[58063215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4728; }","duration":"184.180919ms","start":"2026-04-07T09:44:57.209089Z","end":"2026-04-07T09:44:57.39327Z","steps":["trace[58063215] 'agreement among raft nodes before linearized reading' (duration: 183.705723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.813553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.216183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:57.81402Z","caller":"traceutil/trace.go:171","msg":"trace[1111952850] linearizableReadLoop","detail":"{readStateIndex:4914; appliedIndex:4911; }","duration":"416.310623ms","start":"2026-04-07T09:44:57.397691Z","end":"2026-04-07T09:44:57.814002Z","steps":["trace[1111952850] 'read index received' (duration: 242.554852ms)","trace[1111952850] 'applied index is now lower than readState.Index' (duration: 173.754401ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:57.814177Z","caller":"traceutil/trace.go:171","msg":"trace[1267893192] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"416.729397ms","start":"2026-04-07T09:44:57.397425Z","end":"2026-04-07T09:44:57.814155Z","steps":["trace[1267893192] 'process raft request' (duration: 416.254792ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:57.814242Z","caller":"traceutil/trace.go:171","msg":"trace[1131726185] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"416.22184ms","start":"2026-04-07T09:44:57.398001Z","end":"2026-04-07T09:44:57.814223Z","steps":["trace[1131726185] 'process raft request' (duration: 415.839787ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:57.81427Z","caller":"traceutil/trace.go:171","msg":"trace[156077857] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"418.682962ms","start":"2026-04-07T09:44:57.395553Z","end":"2026-04-07T09:44:57.814236Z","steps":["trace[156077857] 'process raft request' (duration: 244.681703ms)","trace[156077857] 'compare' (duration: 173.061278ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:57.814089Z","caller":"traceutil/trace.go:171","msg":"trace[1150906280] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"416.557321ms","start":"2026-04-07T09:44:57.397493Z","end":"2026-04-07T09:44:57.814051Z","steps":["trace[1150906280] 'process raft request' (duration: 416.284022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.814327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.397405Z","time spent":"416.871621ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:57.814425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.397991Z","time spent":"416.314253ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:57.814147Z","caller":"traceutil/trace.go:171","msg":"trace[1277734870] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"415.170225ms","start":"2026-04-07T09:44:57.398913Z","end":"2026-04-07T09:44:57.814083Z","steps":["trace[1277734870] 'process raft request' (duration: 414.965848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.814451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.395528Z","time spent":"418.829037ms","remote":"127.0.0.1:60102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:57.814452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.397486Z","time spent":"416.872102ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:57.814584Z","caller":"traceutil/trace.go:171","msg":"trace[264659836] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"414.966397ms","start":"2026-04-07T09:44:57.39961Z","end":"2026-04-07T09:44:57.814576Z","steps":["trace[264659836] 'process raft request' (duration: 414.336906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.814649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.399602Z","time spent":"415.001829ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:57.814297Z","caller":"traceutil/trace.go:171","msg":"trace[1060166913] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"414.260444ms","start":"2026-04-07T09:44:57.400012Z","end":"2026-04-07T09:44:57.814273Z","steps":["trace[1060166913] 'process raft request' (duration: 413.958264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.814863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.169012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-1dec694b-6b34-4773-bc2b-cddf55a8c457\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-04-07T09:44:57.814925Z","caller":"traceutil/trace.go:171","msg":"trace[1149906807] range","detail":"{range_begin:/registry/persistentvolumes/pvc-1dec694b-6b34-4773-bc2b-cddf55a8c457; range_end:; response_count:1; response_revision:4735; }","duration":"417.264825ms","start":"2026-04-07T09:44:57.397645Z","end":"2026-04-07T09:44:57.81491Z","steps":["trace[1149906807] 'agreement among raft nodes before linearized reading' (duration: 417.102309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.81496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.39763Z","time spent":"417.322477ms","remote":"127.0.0.1:60218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1344,"request content":"key:\"/registry/persistentvolumes/pvc-1dec694b-6b34-4773-bc2b-cddf55a8c457\" "} {"level":"warn","ts":"2026-04-07T09:44:57.814517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.398906Z","time spent":"415.585499ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:57.815169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.400006Z","time spent":"415.113823ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:57.816513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.325641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd\" ","response":"range_response_count:1 size:9728"} {"level":"info","ts":"2026-04-07T09:44:57.816568Z","caller":"traceutil/trace.go:171","msg":"trace[118599931] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd; range_end:; response_count:1; response_revision:4735; }","duration":"418.402542ms","start":"2026-04-07T09:44:57.398151Z","end":"2026-04-07T09:44:57.816554Z","steps":["trace[118599931] 'agreement among raft nodes before linearized reading' (duration: 418.263548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.8166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.398143Z","time spent":"418.449895ms","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9750,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-h2qzd\" "} {"level":"warn","ts":"2026-04-07T09:44:57.816923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.668791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:57.816961Z","caller":"traceutil/trace.go:171","msg":"trace[1032378409] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4735; }","duration":"252.736723ms","start":"2026-04-07T09:44:57.564215Z","end":"2026-04-07T09:44:57.816951Z","steps":["trace[1032378409] 'agreement among raft nodes before linearized reading' (duration: 252.682631ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:58.082954Z","caller":"traceutil/trace.go:171","msg":"trace[1548213384] linearizableReadLoop","detail":"{readStateIndex:4919; appliedIndex:4918; }","duration":"219.212863ms","start":"2026-04-07T09:44:57.863712Z","end":"2026-04-07T09:44:58.082925Z","steps":["trace[1548213384] 'read index received' (duration: 135.229852ms)","trace[1548213384] 'applied index is now lower than readState.Index' (duration: 83.981531ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:58.083072Z","caller":"traceutil/trace.go:171","msg":"trace[2040267330] transaction","detail":"{read_only:false; response_revision:4736; number_of_response:1; }","duration":"255.100574ms","start":"2026-04-07T09:44:57.827959Z","end":"2026-04-07T09:44:58.08306Z","steps":["trace[2040267330] 'process raft request' (duration: 170.991398ms)","trace[2040267330] 'compare' (duration: 83.693052ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:58.083311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.586836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:58.083346Z","caller":"traceutil/trace.go:171","msg":"trace[837639804] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:4736; }","duration":"219.679799ms","start":"2026-04-07T09:44:57.863656Z","end":"2026-04-07T09:44:58.083336Z","steps":["trace[837639804] 'agreement among raft nodes before linearized reading' (duration: 219.598966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:58.083463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.15731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:58.083532Z","caller":"traceutil/trace.go:171","msg":"trace[511178265] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4736; }","duration":"207.270424ms","start":"2026-04-07T09:44:57.876245Z","end":"2026-04-07T09:44:58.083515Z","steps":["trace[511178265] 'agreement among raft nodes before linearized reading' (duration: 207.131089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:58.083579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.355631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:713"} {"level":"info","ts":"2026-04-07T09:44:58.083653Z","caller":"traceutil/trace.go:171","msg":"trace[801432801] range","detail":"{range_begin:/registry/serviceaccounts/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4736; }","duration":"159.471766ms","start":"2026-04-07T09:44:57.924165Z","end":"2026-04-07T09:44:58.083636Z","steps":["trace[801432801] 'agreement among raft nodes before linearized reading' (duration: 159.256479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.116163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.398108ms","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-07T09:45:06.116259Z","caller":"traceutil/trace.go:171","msg":"trace[763386973] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4844; }","duration":"254.531293ms","start":"2026-04-07T09:45:05.861705Z","end":"2026-04-07T09:45:06.116236Z","steps":["trace[763386973] 'range keys from in-memory index tree' (duration: 254.237212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.116309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.885501ms","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-07T09:45:06.116357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.069682ms","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-07T09:45:06.11642Z","caller":"traceutil/trace.go:171","msg":"trace[1405800089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4844; }","duration":"255.154144ms","start":"2026-04-07T09:45:05.861252Z","end":"2026-04-07T09:45:06.116406Z","steps":["trace[1405800089] 'range keys from in-memory index tree' (duration: 254.687898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.116471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.17937ms","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-07T09:45:06.116366Z","caller":"traceutil/trace.go:171","msg":"trace[1666287426] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4844; }","duration":"251.974794ms","start":"2026-04-07T09:45:05.864376Z","end":"2026-04-07T09:45:06.116351Z","steps":["trace[1666287426] 'range keys from in-memory index tree' (duration: 251.621261ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:06.116513Z","caller":"traceutil/trace.go:171","msg":"trace[1672846691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4844; }","duration":"256.255632ms","start":"2026-04-07T09:45:05.860246Z","end":"2026-04-07T09:45:06.116502Z","steps":["trace[1672846691] 'range keys from in-memory index tree' (duration: 255.752135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.116587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.974298ms","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-07T09:45:06.11662Z","caller":"traceutil/trace.go:171","msg":"trace[1471221023] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4844; }","duration":"255.02371ms","start":"2026-04-07T09:45:05.861586Z","end":"2026-04-07T09:45:06.11661Z","steps":["trace[1471221023] 'range keys from in-memory index tree' (duration: 254.493391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.116179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.499951ms","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-07T09:45:06.116674Z","caller":"traceutil/trace.go:171","msg":"trace[2057227298] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4844; }","duration":"255.013ms","start":"2026-04-07T09:45:05.861645Z","end":"2026-04-07T09:45:06.116658Z","steps":["trace[2057227298] 'range keys from in-memory index tree' (duration: 254.397988ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:06.1173Z","caller":"traceutil/trace.go:171","msg":"trace[723640116] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"176.439418ms","start":"2026-04-07T09:45:05.940829Z","end":"2026-04-07T09:45:06.117269Z","steps":["trace[723640116] 'process raft request' (duration: 150.484005ms)","trace[723640116] 'compare' (duration: 25.837749ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:45:06.502202Z","caller":"traceutil/trace.go:171","msg":"trace[448511476] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"380.243615ms","start":"2026-04-07T09:45:06.121935Z","end":"2026-04-07T09:45:06.502178Z","steps":["trace[448511476] 'process raft request' (duration: 375.522621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.502613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:06.12192Z","time spent":"380.351188ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:45:06.540983Z","caller":"traceutil/trace.go:171","msg":"trace[1846756281] transaction","detail":"{read_only:false; response_revision:4848; number_of_response:1; }","duration":"418.983462ms","start":"2026-04-07T09:45:06.121971Z","end":"2026-04-07T09:45:06.540954Z","steps":["trace[1846756281] 'process raft request' (duration: 418.876228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.541163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:06.121843Z","time spent":"419.231761ms","remote":"127.0.0.1:60338","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-07T09:45:06.540999Z","caller":"traceutil/trace.go:171","msg":"trace[1521567490] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"419.031564ms","start":"2026-04-07T09:45:06.121925Z","end":"2026-04-07T09:45:06.540957Z","steps":["trace[1521567490] 'process raft request' (duration: 418.743554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.541422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:06.121843Z","time spent":"419.527131ms","remote":"127.0.0.1:60338","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-07T09:45:06.541418Z","caller":"traceutil/trace.go:171","msg":"trace[449245085] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"419.344045ms","start":"2026-04-07T09:45:06.122045Z","end":"2026-04-07T09:45:06.541389Z","steps":["trace[449245085] 'process raft request' (duration: 418.854228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.541593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:06.122036Z","time spent":"419.477749ms","remote":"127.0.0.1:60338","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-07T09:45:06.541659Z","caller":"traceutil/trace.go:171","msg":"trace[899137548] transaction","detail":"{read_only:false; response_revision:4850; number_of_response:1; }","duration":"419.314443ms","start":"2026-04-07T09:45:06.122326Z","end":"2026-04-07T09:45:06.54164Z","steps":["trace[899137548] 'process raft request' (duration: 418.858308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.541772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:06.122317Z","time spent":"419.389106ms","remote":"127.0.0.1:60338","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-07T09:45:06.541803Z","caller":"traceutil/trace.go:171","msg":"trace[1390715486] transaction","detail":"{read_only:false; response_revision:4851; number_of_response:1; }","duration":"419.270162ms","start":"2026-04-07T09:45:06.12252Z","end":"2026-04-07T09:45:06.54179Z","steps":["trace[1390715486] 'process raft request' (duration: 419.059134ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:06.541984Z","caller":"traceutil/trace.go:171","msg":"trace[1895561919] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"272.27031ms","start":"2026-04-07T09:45:06.26969Z","end":"2026-04-07T09:45:06.54196Z","steps":["trace[1895561919] 'process raft request' (duration: 272.012441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.541869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:06.122513Z","time spent":"419.317064ms","remote":"127.0.0.1:60338","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-07T09:45:06.701798Z","caller":"traceutil/trace.go:171","msg":"trace[1592882495] linearizableReadLoop","detail":"{readStateIndex:5043; appliedIndex:5042; }","duration":"151.834311ms","start":"2026-04-07T09:45:06.549935Z","end":"2026-04-07T09:45:06.701769Z","steps":["trace[1592882495] 'read index received' (duration: 66.858535ms)","trace[1592882495] 'applied index is now lower than readState.Index' (duration: 84.974216ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:45:06.701852Z","caller":"traceutil/trace.go:171","msg":"trace[2060515234] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"183.908036ms","start":"2026-04-07T09:45:06.517914Z","end":"2026-04-07T09:45:06.701822Z","steps":["trace[2060515234] 'process raft request' (duration: 98.888419ms)","trace[2060515234] 'compare' (duration: 84.82001ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:45:06.702207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.911387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13290"} {"level":"info","ts":"2026-04-07T09:45:06.702513Z","caller":"traceutil/trace.go:171","msg":"trace[1627043697] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4856; }","duration":"140.251638ms","start":"2026-04-07T09:45:06.562243Z","end":"2026-04-07T09:45:06.702495Z","steps":["trace[1627043697] 'agreement among raft nodes before linearized reading' (duration: 139.853274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.702097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.144271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-07T09:45:06.703293Z","caller":"traceutil/trace.go:171","msg":"trace[2139755174] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:4856; }","duration":"153.372694ms","start":"2026-04-07T09:45:06.5499Z","end":"2026-04-07T09:45:06.703273Z","steps":["trace[2139755174] 'agreement among raft nodes before linearized reading' (duration: 152.017167ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:06.957315Z","caller":"traceutil/trace.go:171","msg":"trace[12530903] linearizableReadLoop","detail":"{readStateIndex:5046; appliedIndex:5044; }","duration":"241.130827ms","start":"2026-04-07T09:45:06.716153Z","end":"2026-04-07T09:45:06.957283Z","steps":["trace[12530903] 'read index received' (duration: 23.733576ms)","trace[12530903] 'applied index is now lower than readState.Index' (duration: 217.39236ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:45:06.9574Z","caller":"traceutil/trace.go:171","msg":"trace[726335340] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"242.456963ms","start":"2026-04-07T09:45:06.714917Z","end":"2026-04-07T09:45:06.957374Z","steps":["trace[726335340] 'process raft request' (duration: 184.204857ms)","trace[726335340] 'compare' (duration: 58.019508ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:45:06.957591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.634089ms","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-07T09:45:06.957662Z","caller":"traceutil/trace.go:171","msg":"trace[1048323795] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:4858; }","duration":"215.765714ms","start":"2026-04-07T09:45:06.741877Z","end":"2026-04-07T09:45:06.957643Z","steps":["trace[1048323795] 'agreement among raft nodes before linearized reading' (duration: 215.626389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:06.958643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.412461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-07T09:45:06.958788Z","caller":"traceutil/trace.go:171","msg":"trace[1821595499] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4858; }","duration":"242.629189ms","start":"2026-04-07T09:45:06.716134Z","end":"2026-04-07T09:45:06.958763Z","steps":["trace[1821595499] 'agreement among raft nodes before linearized reading' (duration: 241.316703ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:07.208366Z","caller":"traceutil/trace.go:171","msg":"trace[119638589] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"151.357666ms","start":"2026-04-07T09:45:07.056974Z","end":"2026-04-07T09:45:07.208332Z","steps":["trace[119638589] 'process raft request' (duration: 89.886749ms)","trace[119638589] 'compare' (duration: 61.084783ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:45:07.222452Z","caller":"traceutil/trace.go:171","msg":"trace[61057382] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"164.966271ms","start":"2026-04-07T09:45:07.057459Z","end":"2026-04-07T09:45:07.222425Z","steps":["trace[61057382] 'process raft request' (duration: 164.724462ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:07.222948Z","caller":"traceutil/trace.go:171","msg":"trace[743585766] transaction","detail":"{read_only:false; response_revision:4864; number_of_response:1; }","duration":"159.710627ms","start":"2026-04-07T09:45:07.063225Z","end":"2026-04-07T09:45:07.222936Z","steps":["trace[743585766] 'process raft request' (duration: 159.606714ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:07.223003Z","caller":"traceutil/trace.go:171","msg":"trace[1691984046] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"165.316343ms","start":"2026-04-07T09:45:07.057637Z","end":"2026-04-07T09:45:07.222953Z","steps":["trace[1691984046] 'process raft request' (duration: 164.724622ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:07.223222Z","caller":"traceutil/trace.go:171","msg":"trace[899616714] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"156.669941ms","start":"2026-04-07T09:45:07.066537Z","end":"2026-04-07T09:45:07.223207Z","steps":["trace[899616714] 'process raft request' (duration: 156.34459ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:07.223658Z","caller":"traceutil/trace.go:171","msg":"trace[1540258692] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"165.569292ms","start":"2026-04-07T09:45:07.05807Z","end":"2026-04-07T09:45:07.223639Z","steps":["trace[1540258692] 'process raft request' (duration: 164.600518ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:46:33.673587Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2880} {"level":"info","ts":"2026-04-07T09:46:33.75416Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2880,"took":"79.360597ms","hash":311296166,"current-db-size-bytes":52097024,"current-db-size":"52 MB","current-db-size-in-use-bytes":28864512,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-07T09:46:33.754229Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":311296166,"revision":2880,"compact-revision":-1} {"level":"info","ts":"2026-04-07T09:48:58.153477Z","caller":"traceutil/trace.go:171","msg":"trace[771284618] transaction","detail":"{read_only:false; response_revision:6512; number_of_response:1; }","duration":"218.83544ms","start":"2026-04-07T09:48:57.934609Z","end":"2026-04-07T09:48:58.153444Z","steps":["trace[771284618] 'process raft request' (duration: 218.730105ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:48:58.153757Z","caller":"traceutil/trace.go:171","msg":"trace[574170774] transaction","detail":"{read_only:false; response_revision:6511; number_of_response:1; }","duration":"219.345646ms","start":"2026-04-07T09:48:57.93437Z","end":"2026-04-07T09:48:58.153715Z","steps":["trace[574170774] 'process raft request' (duration: 206.64418ms)","trace[574170774] 'compare' (duration: 11.811651ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:33.679627Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5522} {"level":"info","ts":"2026-04-07T09:51:33.748982Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5522,"took":"68.342403ms","hash":1933828778,"current-db-size-bytes":52097024,"current-db-size":"52 MB","current-db-size-in-use-bytes":17965056,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-07T09:51:33.749033Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1933828778,"revision":5522,"compact-revision":2880} {"level":"warn","ts":"2026-04-07T09:51:58.638382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.599666ms","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-07T09:51:58.638482Z","caller":"traceutil/trace.go:171","msg":"trace[230007718] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7499; }","duration":"103.749568ms","start":"2026-04-07T09:51:58.534713Z","end":"2026-04-07T09:51:58.638462Z","steps":["trace[230007718] 'range keys from in-memory index tree' (duration: 103.466056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:58.638732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.992825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-cluster-total\" ","response":"range_response_count:1 size:14105"} {"level":"info","ts":"2026-04-07T09:51:58.638799Z","caller":"traceutil/trace.go:171","msg":"trace[1470159616] range","detail":"{range_begin:/registry/configmaps/monitoring/kube-prometheus-stack-cluster-total; range_end:; response_count:1; response_revision:7499; }","duration":"122.095126ms","start":"2026-04-07T09:51:58.516688Z","end":"2026-04-07T09:51:58.638784Z","steps":["trace[1470159616] 'range keys from in-memory index tree' (duration: 121.911915ms)"],"step_count":1}