{"level":"warn","ts":"2026-04-07T09:42:54.997114Z","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:42:54.997225Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113: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.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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:42:54.997302Z","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:42:54.997318Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-04-07T09:42:54.997344Z","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:42:54.99895Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-04-07T09:42:54.999349Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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:42:55.004074Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.289104ms"} {"level":"info","ts":"2026-04-07T09:42:55.009583Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-04-07T09:42:55.009657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T09:42:55.009681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-04-07T09:42:55.009693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T09:42:55.009706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-04-07T09:42:55.009766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-04-07T09:42:55.021471Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T09:42:55.026744Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T09:42:55.028581Z","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:42:55.031112Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T09:42:55.03144Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T09:42:55.031507Z","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:42:55.031644Z","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:42:55.031662Z","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:42:55.032586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-04-07T09:42:55.032771Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-04-07T09:42:55.034534Z","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:42:55.034592Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-04-07T09:42:55.03464Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-04-07T09:42:55.034871Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T09:42:55.034916Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T09:42:55.210386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T09:42:55.210442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T09:42:55.210538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-04-07T09:42:55.210563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-04-07T09:42:55.210603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-04-07T09:42:55.210632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-04-07T09:42:55.210648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-04-07T09:42:55.211785Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:42:55.212603Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T09:42:55.212609Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T09:42:55.212669Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T09:42:55.213016Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T09:42:55.213046Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T09:42:55.213025Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:42:55.213232Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:42:55.213349Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:42:55.216201Z","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:42:55.217618Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"warn","ts":"2026-04-07T09:43:16.917832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.880548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-07T09:43:16.917956Z","caller":"traceutil/trace.go:171","msg":"trace[1855246612] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:454; }","duration":"656.062252ms","start":"2026-04-07T09:43:16.261874Z","end":"2026-04-07T09:43:16.917936Z","steps":["trace[1855246612] 'range keys from in-memory index tree' (duration: 655.701944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:16.918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:16.261848Z","time spent":"656.143814ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-07T09:43:20.278518Z","caller":"traceutil/trace.go:171","msg":"trace[477313611] linearizableReadLoop","detail":"{readStateIndex:480; appliedIndex:479; }","duration":"116.032947ms","start":"2026-04-07T09:43:20.162461Z","end":"2026-04-07T09:43:20.278494Z","steps":["trace[477313611] 'read index received' (duration: 115.827402ms)","trace[477313611] 'applied index is now lower than readState.Index' (duration: 204.505µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:20.278593Z","caller":"traceutil/trace.go:171","msg":"trace[1305896990] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"138.826295ms","start":"2026-04-07T09:43:20.139729Z","end":"2026-04-07T09:43:20.278555Z","steps":["trace[1305896990] 'process raft request' (duration: 138.609969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:20.278701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.215432ms","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:43:20.278813Z","caller":"traceutil/trace.go:171","msg":"trace[1031270333] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:463; }","duration":"116.371115ms","start":"2026-04-07T09:43:20.16241Z","end":"2026-04-07T09:43:20.278782Z","steps":["trace[1031270333] 'agreement among raft nodes before linearized reading' (duration: 116.223312ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:26.395734Z","caller":"traceutil/trace.go:171","msg":"trace[365812088] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"105.775176ms","start":"2026-04-07T09:43:26.289925Z","end":"2026-04-07T09:43:26.3957Z","steps":["trace[365812088] 'process raft request' (duration: 105.443918ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:26.396322Z","caller":"traceutil/trace.go:171","msg":"trace[1226180262] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"102.490325ms","start":"2026-04-07T09:43:26.293813Z","end":"2026-04-07T09:43:26.396303Z","steps":["trace[1226180262] 'process raft request' (duration: 102.27996ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:26.396331Z","caller":"traceutil/trace.go:171","msg":"trace[1617318821] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"104.843683ms","start":"2026-04-07T09:43:26.291462Z","end":"2026-04-07T09:43:26.396306Z","steps":["trace[1617318821] 'process raft request' (duration: 104.075644ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:27.190784Z","caller":"traceutil/trace.go:171","msg":"trace[1917042187] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"369.574207ms","start":"2026-04-07T09:43:26.821179Z","end":"2026-04-07T09:43:27.190754Z","steps":["trace[1917042187] 'process raft request' (duration: 369.403453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:27.191313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:26.821157Z","time spent":"369.714591ms","remote":"127.0.0.1:41304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:43:27.199844Z","caller":"traceutil/trace.go:171","msg":"trace[1890461386] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"374.57757ms","start":"2026-04-07T09:43:26.825232Z","end":"2026-04-07T09:43:27.19981Z","steps":["trace[1890461386] 'process raft request' (duration: 374.279413ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:27.199932Z","caller":"traceutil/trace.go:171","msg":"trace[1801497281] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"372.14446ms","start":"2026-04-07T09:43:26.827764Z","end":"2026-04-07T09:43:27.199908Z","steps":["trace[1801497281] 'process raft request' (duration: 371.932075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:27.19997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.328072ms","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:43:27.200068Z","caller":"traceutil/trace.go:171","msg":"trace[1328893917] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:572; }","duration":"194.483986ms","start":"2026-04-07T09:43:27.005572Z","end":"2026-04-07T09:43:27.200056Z","steps":["trace[1328893917] 'agreement among raft nodes before linearized reading' (duration: 194.339342ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:27.199832Z","caller":"traceutil/trace.go:171","msg":"trace[1746294688] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:590; }","duration":"194.168318ms","start":"2026-04-07T09:43:27.005635Z","end":"2026-04-07T09:43:27.199803Z","steps":["trace[1746294688] 'read index received' (duration: 185.061025ms)","trace[1746294688] 'applied index is now lower than readState.Index' (duration: 9.106203ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:27.200165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:26.825204Z","time spent":"374.725064ms","remote":"127.0.0.1:41304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:43:27.200241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:26.827719Z","time spent":"372.261293ms","remote":"127.0.0.1:41304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74745,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:43:30.877807Z","caller":"traceutil/trace.go:171","msg":"trace[1437158199] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"116.770505ms","start":"2026-04-07T09:43:30.761004Z","end":"2026-04-07T09:43:30.877775Z","steps":["trace[1437158199] 'process raft request' (duration: 114.342116ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:31.482675Z","caller":"traceutil/trace.go:171","msg":"trace[1976944313] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"117.196896ms","start":"2026-04-07T09:43:31.365442Z","end":"2026-04-07T09:43:31.482639Z","steps":["trace[1976944313] 'process raft request' (duration: 116.1435ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:33.129734Z","caller":"traceutil/trace.go:171","msg":"trace[189171992] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"139.014689ms","start":"2026-04-07T09:43:32.990694Z","end":"2026-04-07T09:43:33.129708Z","steps":["trace[189171992] 'process raft request' (duration: 137.500732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.854748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.212879ms","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:43:34.854835Z","caller":"traceutil/trace.go:171","msg":"trace[599575245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"396.354162ms","start":"2026-04-07T09:43:34.458463Z","end":"2026-04-07T09:43:34.854817Z","steps":["trace[599575245] 'range keys from in-memory index tree' (duration: 396.072626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.85487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:34.458442Z","time spent":"396.419734ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T09:43:34.855032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.217591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.855103Z","caller":"traceutil/trace.go:171","msg":"trace[337181584] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:631; }","duration":"291.282852ms","start":"2026-04-07T09:43:34.563777Z","end":"2026-04-07T09:43:34.855059Z","steps":["trace[337181584] 'range keys from in-memory index tree' (duration: 291.103028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.855144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.101839ms","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:43:34.855171Z","caller":"traceutil/trace.go:171","msg":"trace[721203753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"399.161361ms","start":"2026-04-07T09:43:34.456003Z","end":"2026-04-07T09:43:34.855164Z","steps":["trace[721203753] 'range keys from in-memory index tree' (duration: 398.171836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.855198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:34.455979Z","time spent":"399.213713ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T09:43:34.85533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.518399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.855365Z","caller":"traceutil/trace.go:171","msg":"trace[1608446659] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:631; }","duration":"291.585211ms","start":"2026-04-07T09:43:34.563771Z","end":"2026-04-07T09:43:34.855356Z","steps":["trace[1608446659] 'count revisions from in-memory index tree' (duration: 291.399316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.855516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.417726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.855552Z","caller":"traceutil/trace.go:171","msg":"trace[1074385296] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:631; }","duration":"291.472567ms","start":"2026-04-07T09:43:34.564071Z","end":"2026-04-07T09:43:34.855544Z","steps":["trace[1074385296] 'range keys from in-memory index tree' (duration: 291.381995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.855662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.662472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.855695Z","caller":"traceutil/trace.go:171","msg":"trace[1990171638] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:631; }","duration":"273.708614ms","start":"2026-04-07T09:43:34.581978Z","end":"2026-04-07T09:43:34.855687Z","steps":["trace[1990171638] 'range keys from in-memory index tree' (duration: 273.616451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.855827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.527099ms","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:43:34.855904Z","caller":"traceutil/trace.go:171","msg":"trace[799556202] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:631; }","duration":"273.57531ms","start":"2026-04-07T09:43:34.582276Z","end":"2026-04-07T09:43:34.855851Z","steps":["trace[799556202] 'count revisions from in-memory index tree' (duration: 273.443207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.85603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.288903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.856061Z","caller":"traceutil/trace.go:171","msg":"trace[243789337] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:631; }","duration":"273.338285ms","start":"2026-04-07T09:43:34.582715Z","end":"2026-04-07T09:43:34.856053Z","steps":["trace[243789337] 'range keys from in-memory index tree' (duration: 273.255803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.856206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.932323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.856239Z","caller":"traceutil/trace.go:171","msg":"trace[28045184] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:631; }","duration":"247.996165ms","start":"2026-04-07T09:43:34.608234Z","end":"2026-04-07T09:43:34.856231Z","steps":["trace[28045184] 'count revisions from in-memory index tree' (duration: 247.845901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.85638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.940463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.856424Z","caller":"traceutil/trace.go:171","msg":"trace[743453272] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:631; }","duration":"248.040205ms","start":"2026-04-07T09:43:34.608371Z","end":"2026-04-07T09:43:34.856411Z","steps":["trace[743453272] 'range keys from in-memory index tree' (duration: 247.783729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.856595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.547844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.856632Z","caller":"traceutil/trace.go:171","msg":"trace[394833496] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:631; }","duration":"247.622306ms","start":"2026-04-07T09:43:34.609Z","end":"2026-04-07T09:43:34.856623Z","steps":["trace[394833496] 'range keys from in-memory index tree' (duration: 247.457581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.85675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.721686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.856782Z","caller":"traceutil/trace.go:171","msg":"trace[379310743] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:631; }","duration":"231.774407ms","start":"2026-04-07T09:43:34.624999Z","end":"2026-04-07T09:43:34.856773Z","steps":["trace[379310743] 'range keys from in-memory index tree' (duration: 231.677645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.856919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.785098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.85695Z","caller":"traceutil/trace.go:171","msg":"trace[1805841658] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:631; }","duration":"231.846899ms","start":"2026-04-07T09:43:34.625095Z","end":"2026-04-07T09:43:34.856942Z","steps":["trace[1805841658] 'count revisions from in-memory index tree' (duration: 231.729907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.857057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.237065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.857088Z","caller":"traceutil/trace.go:171","msg":"trace[2078361555] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:631; }","duration":"231.280276ms","start":"2026-04-07T09:43:34.6258Z","end":"2026-04-07T09:43:34.85708Z","steps":["trace[2078361555] 'range keys from in-memory index tree' (duration: 231.204184ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.857281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.585948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.857316Z","caller":"traceutil/trace.go:171","msg":"trace[32610631] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:631; }","duration":"194.66194ms","start":"2026-04-07T09:43:34.662647Z","end":"2026-04-07T09:43:34.857309Z","steps":["trace[32610631] 'range keys from in-memory index tree' (duration: 194.521446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.857437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.522066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.857464Z","caller":"traceutil/trace.go:171","msg":"trace[967032040] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:631; }","duration":"194.550387ms","start":"2026-04-07T09:43:34.662906Z","end":"2026-04-07T09:43:34.857456Z","steps":["trace[967032040] 'count revisions from in-memory index tree' (duration: 194.429754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.857618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.64738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.857655Z","caller":"traceutil/trace.go:171","msg":"trace[590920416] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:631; }","duration":"194.717302ms","start":"2026-04-07T09:43:34.662929Z","end":"2026-04-07T09:43:34.857647Z","steps":["trace[590920416] 'range keys from in-memory index tree' (duration: 194.579817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.857793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.401013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.857973Z","caller":"traceutil/trace.go:171","msg":"trace[573151897] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:631; }","duration":"167.619978ms","start":"2026-04-07T09:43:34.690337Z","end":"2026-04-07T09:43:34.857956Z","steps":["trace[573151897] 'range keys from in-memory index tree' (duration: 167.358303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.858209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.715441ms","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:43:34.85997Z","caller":"traceutil/trace.go:171","msg":"trace[540035880] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:631; }","duration":"169.497805ms","start":"2026-04-07T09:43:34.690446Z","end":"2026-04-07T09:43:34.859944Z","steps":["trace[540035880] 'count revisions from in-memory index tree' (duration: 167.572347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.858514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.205048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.860144Z","caller":"traceutil/trace.go:171","msg":"trace[557262024] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:631; }","duration":"168.872179ms","start":"2026-04-07T09:43:34.691251Z","end":"2026-04-07T09:43:34.860124Z","steps":["trace[557262024] 'range keys from in-memory index tree' (duration: 167.072965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.858654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.68725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:34.858705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.570647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.860405Z","caller":"traceutil/trace.go:171","msg":"trace[1500733763] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:631; }","duration":"133.258978ms","start":"2026-04-07T09:43:34.727104Z","end":"2026-04-07T09:43:34.860363Z","steps":["trace[1500733763] 'range keys from in-memory index tree' (duration: 131.535726ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:34.860359Z","caller":"traceutil/trace.go:171","msg":"trace[647883112] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:631; }","duration":"133.349801ms","start":"2026-04-07T09:43:34.726924Z","end":"2026-04-07T09:43:34.860273Z","steps":["trace[647883112] 'count revisions from in-memory index tree' (duration: 131.559477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.858754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.957737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.860542Z","caller":"traceutil/trace.go:171","msg":"trace[417934337] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:631; }","duration":"104.751891ms","start":"2026-04-07T09:43:34.755742Z","end":"2026-04-07T09:43:34.860493Z","steps":["trace[417934337] 'count revisions from in-memory index tree' (duration: 102.848085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:34.858805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.147162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:34.860652Z","caller":"traceutil/trace.go:171","msg":"trace[131535938] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:631; }","duration":"105.006338ms","start":"2026-04-07T09:43:34.755628Z","end":"2026-04-07T09:43:34.860635Z","steps":["trace[131535938] 'range keys from in-memory index tree' (duration: 103.108822ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:35.078799Z","caller":"traceutil/trace.go:171","msg":"trace[136848012] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"216.542765ms","start":"2026-04-07T09:43:34.862238Z","end":"2026-04-07T09:43:35.078781Z","steps":["trace[136848012] 'process raft request' (duration: 216.380141ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:35.087373Z","caller":"traceutil/trace.go:171","msg":"trace[1824780817] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"200.908423ms","start":"2026-04-07T09:43:34.886446Z","end":"2026-04-07T09:43:35.087354Z","steps":["trace[1824780817] 'read index received' (duration: 192.141479ms)","trace[1824780817] 'applied index is now lower than readState.Index' (duration: 8.764404ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:35.087508Z","caller":"traceutil/trace.go:171","msg":"trace[2147247382] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"224.765646ms","start":"2026-04-07T09:43:34.86273Z","end":"2026-04-07T09:43:35.087462Z","steps":["trace[2147247382] 'process raft request' (duration: 224.51695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:35.087595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.952424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:35.087653Z","caller":"traceutil/trace.go:171","msg":"trace[1448850541] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:633; }","duration":"201.049837ms","start":"2026-04-07T09:43:34.886589Z","end":"2026-04-07T09:43:35.087639Z","steps":["trace[1448850541] 'agreement among raft nodes before linearized reading' (duration: 200.945424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:35.087731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.19081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:35.087922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.368573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:35.087895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.935123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:35.087956Z","caller":"traceutil/trace.go:171","msg":"trace[1509699997] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:633; }","duration":"102.451375ms","start":"2026-04-07T09:43:34.985497Z","end":"2026-04-07T09:43:35.087948Z","steps":["trace[1509699997] 'agreement among raft nodes before linearized reading' (duration: 102.393234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:35.087946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.269597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:35.08813Z","caller":"traceutil/trace.go:171","msg":"trace[1545040117] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:633; }","duration":"155.497792ms","start":"2026-04-07T09:43:34.932613Z","end":"2026-04-07T09:43:35.088111Z","steps":["trace[1545040117] 'agreement among raft nodes before linearized reading' (duration: 155.155504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:35.088117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.109268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:35.088161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.728817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:35.087983Z","caller":"traceutil/trace.go:171","msg":"trace[467576049] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:633; }","duration":"201.070877ms","start":"2026-04-07T09:43:34.886893Z","end":"2026-04-07T09:43:35.087964Z","steps":["trace[467576049] 'agreement among raft nodes before linearized reading' (duration: 200.911183ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:35.088387Z","caller":"traceutil/trace.go:171","msg":"trace[1202036167] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:633; }","duration":"101.971423ms","start":"2026-04-07T09:43:34.986406Z","end":"2026-04-07T09:43:35.088377Z","steps":["trace[1202036167] 'agreement among raft nodes before linearized reading' (duration: 101.731477ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:35.088394Z","caller":"traceutil/trace.go:171","msg":"trace[481573616] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"127.248921ms","start":"2026-04-07T09:43:34.960939Z","end":"2026-04-07T09:43:35.088188Z","steps":["trace[481573616] 'agreement among raft nodes before linearized reading' (duration: 127.064787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:35.088055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.424481ms","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:43:35.087944Z","caller":"traceutil/trace.go:171","msg":"trace[1038352896] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:633; }","duration":"201.421725ms","start":"2026-04-07T09:43:34.886408Z","end":"2026-04-07T09:43:35.087829Z","steps":["trace[1038352896] 'agreement among raft nodes before linearized reading' (duration: 201.122528ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:35.088492Z","caller":"traceutil/trace.go:171","msg":"trace[669666251] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:633; }","duration":"155.884332ms","start":"2026-04-07T09:43:34.932571Z","end":"2026-04-07T09:43:35.088455Z","steps":["trace[669666251] 'agreement among raft nodes before linearized reading' (duration: 155.450801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:35.088642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.034499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:35.088728Z","caller":"traceutil/trace.go:171","msg":"trace[1973605011] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:633; }","duration":"103.175733ms","start":"2026-04-07T09:43:34.985539Z","end":"2026-04-07T09:43:35.088715Z","steps":["trace[1973605011] 'agreement among raft nodes before linearized reading' (duration: 102.084506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:35.088728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.718698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:35.088884Z","caller":"traceutil/trace.go:171","msg":"trace[1703175018] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:633; }","duration":"155.878012ms","start":"2026-04-07T09:43:34.932996Z","end":"2026-04-07T09:43:35.088874Z","steps":["trace[1703175018] 'agreement among raft nodes before linearized reading' (duration: 155.647686ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:47.611087Z","caller":"traceutil/trace.go:171","msg":"trace[1150775342] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"150.983352ms","start":"2026-04-07T09:43:47.460069Z","end":"2026-04-07T09:43:47.611053Z","steps":["trace[1150775342] 'process raft request' (duration: 150.793668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.46109Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356764556006074912,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:13.961509Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356764556006074912,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:13.981255Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.393847193s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T09:44:13.981783Z","caller":"traceutil/trace.go:171","msg":"trace[928906152] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"1.394492909s","start":"2026-04-07T09:44:12.587261Z","end":"2026-04-07T09:44:13.981754Z","steps":["trace[928906152] 'process raft request' (duration: 1.394304374s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.98196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:12.587233Z","time spent":"1.394622002s","remote":"127.0.0.1:41500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3148,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:13.986963Z","caller":"traceutil/trace.go:171","msg":"trace[1167667442] linearizableReadLoop","detail":"{readStateIndex:1199; appliedIndex:1196; }","duration":"1.025977738s","start":"2026-04-07T09:44:12.960963Z","end":"2026-04-07T09:44:13.986941Z","steps":["trace[1167667442] 'read index received' (duration: 1.020694849s)","trace[1167667442] 'applied index is now lower than readState.Index' (duration: 5.281889ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:13.987007Z","caller":"traceutil/trace.go:171","msg":"trace[2071884886] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"275.068646ms","start":"2026-04-07T09:44:13.711913Z","end":"2026-04-07T09:44:13.986981Z","steps":["trace[2071884886] 'process raft request' (duration: 274.896242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.987115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026136312s","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.987191Z","caller":"traceutil/trace.go:171","msg":"trace[1457540944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1166; }","duration":"1.026254605s","start":"2026-04-07T09:44:12.960919Z","end":"2026-04-07T09:44:13.987173Z","steps":["trace[1457540944] 'agreement among raft nodes before linearized reading' (duration: 1.026116002s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.987242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:12.960899Z","time spent":"1.026331907s","remote":"127.0.0.1:41248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:44:13.987274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.581807ms","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:44:13.98732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.884487ms","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:13.987411Z","caller":"traceutil/trace.go:171","msg":"trace[665203194] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1166; }","duration":"429.029352ms","start":"2026-04-07T09:44:13.558363Z","end":"2026-04-07T09:44:13.987392Z","steps":["trace[665203194] 'agreement among raft nodes before linearized reading' (duration: 428.799786ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:13.98734Z","caller":"traceutil/trace.go:171","msg":"trace[695939645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1166; }","duration":"708.68353ms","start":"2026-04-07T09:44:13.278629Z","end":"2026-04-07T09:44:13.987312Z","steps":["trace[695939645] 'agreement among raft nodes before linearized reading' (duration: 708.512765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.987462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:13.558342Z","time spent":"429.108273ms","remote":"127.0.0.1:41530","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.987509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:13.278425Z","time spent":"709.070609ms","remote":"127.0.0.1:41530","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:13.987469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.034971ms","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:13.987649Z","caller":"traceutil/trace.go:171","msg":"trace[717549264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1166; }","duration":"667.282587ms","start":"2026-04-07T09:44:13.320341Z","end":"2026-04-07T09:44:13.987624Z","steps":["trace[717549264] 'agreement among raft nodes before linearized reading' (duration: 666.828466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.987524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.331796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-07T09:44:13.987788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:13.320326Z","time spent":"667.41157ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T09:44:13.987799Z","caller":"traceutil/trace.go:171","msg":"trace[1064918011] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1166; }","duration":"224.654624ms","start":"2026-04-07T09:44:13.763116Z","end":"2026-04-07T09:44:13.987771Z","steps":["trace[1064918011] 'agreement among raft nodes before linearized reading' (duration: 224.159442ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:18.148558Z","caller":"traceutil/trace.go:171","msg":"trace[1387190389] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"130.301088ms","start":"2026-04-07T09:44:18.018231Z","end":"2026-04-07T09:44:18.148532Z","steps":["trace[1387190389] 'process raft request' (duration: 130.149695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:18.998905Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356764556006074959,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:19.499811Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356764556006074959,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:20.000751Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356764556006074959,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:20.501708Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356764556006074959,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:20.963247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000510912s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T09:44:20.963363Z","caller":"traceutil/trace.go:171","msg":"trace[1574150349] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000684856s","start":"2026-04-07T09:44:18.96266Z","end":"2026-04-07T09:44:20.963345Z","steps":["trace[1574150349] 'agreement among raft nodes before linearized reading' (duration: 2.000547432s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:20.963412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.962638Z","time spent":"2.000764197s","remote":"127.0.0.1:41248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 09:44:20 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T09:44:21.002002Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356764556006074959,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:21.169887Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.021525271s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-07T09:44:21.178247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.365614304s","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:21.17841Z","caller":"traceutil/trace.go:171","msg":"trace[594299626] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1187; }","duration":"1.365801858s","start":"2026-04-07T09:44:19.812587Z","end":"2026-04-07T09:44:21.178389Z","steps":["trace[594299626] 'range keys from in-memory index tree' (duration: 1.365591923s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.178892Z","caller":"traceutil/trace.go:171","msg":"trace[873134589] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"3.157975025s","start":"2026-04-07T09:44:18.020869Z","end":"2026-04-07T09:44:21.178844Z","steps":["trace[873134589] 'process raft request' (duration: 3.149277158s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.178978Z","caller":"traceutil/trace.go:171","msg":"trace[1774536090] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"3.157915014s","start":"2026-04-07T09:44:18.021032Z","end":"2026-04-07T09:44:21.178947Z","steps":["trace[1774536090] 'process raft request' (duration: 3.157654657s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.178979Z","caller":"traceutil/trace.go:171","msg":"trace[1500891605] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"3.157876253s","start":"2026-04-07T09:44:18.021066Z","end":"2026-04-07T09:44:21.178943Z","steps":["trace[1500891605] 'process raft request' (duration: 3.157804732s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.179161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.020848Z","time spent":"3.158218731s","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:21.179192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.021005Z","time spent":"3.158088988s","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:21.179271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.021044Z","time spent":"3.158059277s","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:21.183415Z","caller":"traceutil/trace.go:171","msg":"trace[1659882862] linearizableReadLoop","detail":"{readStateIndex:1225; appliedIndex:1220; }","duration":"2.684874625s","start":"2026-04-07T09:44:18.498506Z","end":"2026-04-07T09:44:21.18338Z","steps":["trace[1659882862] 'read index received' (duration: 2.671659061s)","trace[1659882862] 'applied index is now lower than readState.Index' (duration: 13.213994ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:21.183444Z","caller":"traceutil/trace.go:171","msg":"trace[915073955] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"2.433332104s","start":"2026-04-07T09:44:18.750087Z","end":"2026-04-07T09:44:21.183419Z","steps":["trace[915073955] 'process raft request' (duration: 2.433074648s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.183499Z","caller":"traceutil/trace.go:171","msg":"trace[878494127] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"1.17119866s","start":"2026-04-07T09:44:20.012272Z","end":"2026-04-07T09:44:21.183471Z","steps":["trace[878494127] 'process raft request' (duration: 1.171063037s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.18358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.750059Z","time spent":"2.433446006s","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:21.183618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:20.012248Z","time spent":"1.171304013s","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:21.183673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.421165025s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:44:21.183712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.685170252s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.113\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-07T09:44:21.183735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.030352852s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-07T09:44:21.18377Z","caller":"traceutil/trace.go:171","msg":"trace[457878636] range","detail":"{range_begin:/registry/masterleases/199.204.45.113; range_end:; response_count:1; response_revision:1192; }","duration":"2.685280795s","start":"2026-04-07T09:44:18.498474Z","end":"2026-04-07T09:44:21.183755Z","steps":["trace[457878636] 'agreement among raft nodes before linearized reading' (duration: 2.685045589s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.183791Z","caller":"traceutil/trace.go:171","msg":"trace[521681040] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1192; }","duration":"1.030442964s","start":"2026-04-07T09:44:20.153334Z","end":"2026-04-07T09:44:21.183777Z","steps":["trace[521681040] 'agreement among raft nodes before linearized reading' (duration: 1.03027154s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.18381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.164925ms","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.183809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.638937393s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-07T09:44:21.183834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:20.153312Z","time spent":"1.030515015s","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-07T09:44:21.183877Z","caller":"traceutil/trace.go:171","msg":"trace[34671426] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1192; }","duration":"2.639020685s","start":"2026-04-07T09:44:18.544829Z","end":"2026-04-07T09:44:21.183849Z","steps":["trace[34671426] 'agreement among raft nodes before linearized reading' (duration: 2.638914902s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.183886Z","caller":"traceutil/trace.go:171","msg":"trace[121254761] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1192; }","duration":"220.245227ms","start":"2026-04-07T09:44:20.963598Z","end":"2026-04-07T09:44:21.183843Z","steps":["trace[121254761] 'agreement among raft nodes before linearized reading' (duration: 220.171435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.18391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.544809Z","time spent":"2.639092716s","remote":"127.0.0.1:41530","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:21.18371Z","caller":"traceutil/trace.go:171","msg":"trace[1311897696] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1192; }","duration":"2.421234485s","start":"2026-04-07T09:44:18.762463Z","end":"2026-04-07T09:44:21.183698Z","steps":["trace[1311897696] 'agreement among raft nodes before linearized reading' (duration: 2.421189114s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.183927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.57957686s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-startupapicheck-78lgq\" ","response":"range_response_count:1 size:4165"} {"level":"info","ts":"2026-04-07T09:44:21.183987Z","caller":"traceutil/trace.go:171","msg":"trace[815785280] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-startupapicheck-78lgq; range_end:; response_count:1; response_revision:1192; }","duration":"2.579669503s","start":"2026-04-07T09:44:18.604303Z","end":"2026-04-07T09:44:21.183973Z","steps":["trace[815785280] 'agreement among raft nodes before linearized reading' (duration: 2.579437507s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.184028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.604284Z","time spent":"2.579735455s","remote":"127.0.0.1:41456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":4188,"request content":"key:\"/registry/pods/cert-manager/cert-manager-startupapicheck-78lgq\" "} {"level":"warn","ts":"2026-04-07T09:44:21.183814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.498459Z","time spent":"2.685345726s","remote":"127.0.0.1:41274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.113\" "} {"level":"warn","ts":"2026-04-07T09:44:21.183948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.762446Z","time spent":"2.421492292s","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:44:21.183621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.682821006s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:21.184192Z","caller":"traceutil/trace.go:171","msg":"trace[837140327] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1192; }","duration":"2.68339745s","start":"2026-04-07T09:44:18.500781Z","end":"2026-04-07T09:44:21.184178Z","steps":["trace[837140327] 'agreement among raft nodes before linearized reading' (duration: 2.682788085s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.184134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.90574ms","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.184243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.500737Z","time spent":"2.683489562s","remote":"127.0.0.1:41642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"info","ts":"2026-04-07T09:44:21.184343Z","caller":"traceutil/trace.go:171","msg":"trace[1005359543] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1192; }","duration":"273.107534ms","start":"2026-04-07T09:44:20.911165Z","end":"2026-04-07T09:44:21.184272Z","steps":["trace[1005359543] 'agreement among raft nodes before linearized reading' (duration: 272.617302ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.386007Z","caller":"traceutil/trace.go:171","msg":"trace[1432076142] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"198.137241ms","start":"2026-04-07T09:44:21.187817Z","end":"2026-04-07T09:44:21.385955Z","steps":["trace[1432076142] 'process raft request' (duration: 172.871781ms)","trace[1432076142] 'compare' (duration: 24.648965ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:21.38611Z","caller":"traceutil/trace.go:171","msg":"trace[2050236592] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"195.263203ms","start":"2026-04-07T09:44:21.190821Z","end":"2026-04-07T09:44:21.386085Z","steps":["trace[2050236592] 'process raft request' (duration: 195.206752ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.386324Z","caller":"traceutil/trace.go:171","msg":"trace[1280444093] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"198.261585ms","start":"2026-04-07T09:44:21.188053Z","end":"2026-04-07T09:44:21.386315Z","steps":["trace[1280444093] 'process raft request' (duration: 197.935737ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.386548Z","caller":"traceutil/trace.go:171","msg":"trace[510212957] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"198.49135ms","start":"2026-04-07T09:44:21.188044Z","end":"2026-04-07T09:44:21.386536Z","steps":["trace[510212957] 'process raft request' (duration: 197.686251ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.459574Z","caller":"traceutil/trace.go:171","msg":"trace[478657557] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"256.030568ms","start":"2026-04-07T09:44:21.203519Z","end":"2026-04-07T09:44:21.459549Z","steps":["trace[478657557] 'process raft request' (duration: 255.900545ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:22.38181Z","caller":"traceutil/trace.go:171","msg":"trace[1088909893] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"237.698593ms","start":"2026-04-07T09:44:22.144071Z","end":"2026-04-07T09:44:22.381769Z","steps":["trace[1088909893] 'process raft request' (duration: 215.161637ms)","trace[1088909893] 'compare' (duration: 22.244429ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:22.680931Z","caller":"traceutil/trace.go:171","msg":"trace[1297150101] linearizableReadLoop","detail":"{readStateIndex:1237; appliedIndex:1236; }","duration":"206.91154ms","start":"2026-04-07T09:44:22.474002Z","end":"2026-04-07T09:44:22.680914Z","steps":["trace[1297150101] 'read index received' (duration: 206.705515ms)","trace[1297150101] 'applied index is now lower than readState.Index' (duration: 205.205µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:22.680999Z","caller":"traceutil/trace.go:171","msg":"trace[1664773614] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"210.432054ms","start":"2026-04-07T09:44:22.470539Z","end":"2026-04-07T09:44:22.680972Z","steps":["trace[1664773614] 'process raft request' (duration: 210.25781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:22.681228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.168976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2929"} {"level":"info","ts":"2026-04-07T09:44:22.681338Z","caller":"traceutil/trace.go:171","msg":"trace[1698628124] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1203; }","duration":"207.32759ms","start":"2026-04-07T09:44:22.473985Z","end":"2026-04-07T09:44:22.681312Z","steps":["trace[1698628124] 'agreement among raft nodes before linearized reading' (duration: 207.006473ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:22.889333Z","caller":"traceutil/trace.go:171","msg":"trace[1749802955] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"201.187955ms","start":"2026-04-07T09:44:22.688116Z","end":"2026-04-07T09:44:22.889304Z","steps":["trace[1749802955] 'process raft request' (duration: 164.763988ms)","trace[1749802955] 'compare' (duration: 36.172311ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:23.108125Z","caller":"traceutil/trace.go:171","msg":"trace[1549618498] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"213.648661ms","start":"2026-04-07T09:44:22.894449Z","end":"2026-04-07T09:44:23.108098Z","steps":["trace[1549618498] 'process raft request' (duration: 142.805566ms)","trace[1549618498] 'compare' (duration: 70.66606ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:23.108269Z","caller":"traceutil/trace.go:171","msg":"trace[2099257226] linearizableReadLoop","detail":"{readStateIndex:1241; appliedIndex:1239; }","duration":"206.782567ms","start":"2026-04-07T09:44:22.901463Z","end":"2026-04-07T09:44:23.108246Z","steps":["trace[2099257226] 'read index received' (duration: 135.84178ms)","trace[2099257226] 'applied index is now lower than readState.Index' (duration: 70.939707ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:23.108392Z","caller":"traceutil/trace.go:171","msg":"trace[29587050] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"213.818904ms","start":"2026-04-07T09:44:22.894563Z","end":"2026-04-07T09:44:23.108382Z","steps":["trace[29587050] 'process raft request' (duration: 213.503607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:23.108526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.257408ms","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:23.108604Z","caller":"traceutil/trace.go:171","msg":"trace[738879759] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1207; }","duration":"146.381201ms","start":"2026-04-07T09:44:22.962206Z","end":"2026-04-07T09:44:23.108587Z","steps":["trace[738879759] 'agreement among raft nodes before linearized reading' (duration: 146.230348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:23.10874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.268018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-startupapicheck\" ","response":"range_response_count:1 size:1054"} {"level":"info","ts":"2026-04-07T09:44:23.108854Z","caller":"traceutil/trace.go:171","msg":"trace[2012188096] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-startupapicheck; range_end:; response_count:1; response_revision:1207; }","duration":"207.408862ms","start":"2026-04-07T09:44:22.901425Z","end":"2026-04-07T09:44:23.108833Z","steps":["trace[2012188096] 'agreement among raft nodes before linearized reading' (duration: 206.963271ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:23.380372Z","caller":"traceutil/trace.go:171","msg":"trace[2081958213] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1243; }","duration":"196.323709ms","start":"2026-04-07T09:44:23.184023Z","end":"2026-04-07T09:44:23.380347Z","steps":["trace[2081958213] 'read index received' (duration: 153.569632ms)","trace[2081958213] 'applied index is now lower than readState.Index' (duration: 42.752927ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:23.380475Z","caller":"traceutil/trace.go:171","msg":"trace[1900165518] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1210; }","duration":"202.258359ms","start":"2026-04-07T09:44:23.178191Z","end":"2026-04-07T09:44:23.38045Z","steps":["trace[1900165518] 'process raft request' (duration: 159.38409ms)","trace[1900165518] 'compare' (duration: 42.590603ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:23.38058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.542054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-07T09:44:23.380683Z","caller":"traceutil/trace.go:171","msg":"trace[127382850] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1210; }","duration":"196.687407ms","start":"2026-04-07T09:44:23.183983Z","end":"2026-04-07T09:44:23.38067Z","steps":["trace[127382850] 'agreement among raft nodes before linearized reading' (duration: 196.461921ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:23.411737Z","caller":"traceutil/trace.go:171","msg":"trace[196096963] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"221.391135ms","start":"2026-04-07T09:44:23.190326Z","end":"2026-04-07T09:44:23.411718Z","steps":["trace[196096963] 'process raft request' (duration: 221.279522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:23.412043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.578472ms","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:23.412127Z","caller":"traceutil/trace.go:171","msg":"trace[161297818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1211; }","duration":"227.686484ms","start":"2026-04-07T09:44:23.184422Z","end":"2026-04-07T09:44:23.412108Z","steps":["trace[161297818] 'agreement among raft nodes before linearized reading' (duration: 227.349516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:23.412121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.154262ms","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:23.412334Z","caller":"traceutil/trace.go:171","msg":"trace[1475490936] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1211; }","duration":"227.385177ms","start":"2026-04-07T09:44:23.184875Z","end":"2026-04-07T09:44:23.41226Z","steps":["trace[1475490936] 'agreement among raft nodes before linearized reading' (duration: 226.889475ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:23.586613Z","caller":"traceutil/trace.go:171","msg":"trace[1862347653] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"169.778007ms","start":"2026-04-07T09:44:23.416813Z","end":"2026-04-07T09:44:23.586591Z","steps":["trace[1862347653] 'process raft request' (duration: 77.323749ms)","trace[1862347653] 'compare' (duration: 92.12665ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:23.586605Z","caller":"traceutil/trace.go:171","msg":"trace[556646325] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"169.714256ms","start":"2026-04-07T09:44:23.416853Z","end":"2026-04-07T09:44:23.586567Z","steps":["trace[556646325] 'process raft request' (duration: 169.636764ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:23.634837Z","caller":"traceutil/trace.go:171","msg":"trace[2065680574] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1215; }","duration":"168.720141ms","start":"2026-04-07T09:44:23.466083Z","end":"2026-04-07T09:44:23.634803Z","steps":["trace[2065680574] 'process raft request' (duration: 168.397563ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:23.636517Z","caller":"traceutil/trace.go:171","msg":"trace[483738992] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"167.081912ms","start":"2026-04-07T09:44:23.469417Z","end":"2026-04-07T09:44:23.636499Z","steps":["trace[483738992] 'process raft request' (duration: 166.869717ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:23.636424Z","caller":"traceutil/trace.go:171","msg":"trace[1656967435] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"167.252016ms","start":"2026-04-07T09:44:23.46912Z","end":"2026-04-07T09:44:23.636372Z","steps":["trace[1656967435] 'process raft request' (duration: 165.548636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:24.00835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.769354ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T09:44:24.008482Z","caller":"traceutil/trace.go:171","msg":"trace[1361621715] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1251; }","duration":"369.951397ms","start":"2026-04-07T09:44:23.638508Z","end":"2026-04-07T09:44:24.008459Z","steps":["trace[1361621715] 'read index received' (duration: 49.818335ms)","trace[1361621715] 'applied index is now lower than readState.Index' (duration: 320.131172ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:24.008679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.155322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-startupapicheck-78lgq\" ","response":"range_response_count:1 size:4065"} {"level":"info","ts":"2026-04-07T09:44:24.008726Z","caller":"traceutil/trace.go:171","msg":"trace[1192816625] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-startupapicheck-78lgq; range_end:; response_count:1; response_revision:1217; }","duration":"370.249944ms","start":"2026-04-07T09:44:23.638461Z","end":"2026-04-07T09:44:24.008711Z","steps":["trace[1192816625] 'agreement among raft nodes before linearized reading' (duration: 370.05905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:24.008776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:23.638442Z","time spent":"370.321526ms","remote":"127.0.0.1:41456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":4088,"request content":"key:\"/registry/pods/cert-manager/cert-manager-startupapicheck-78lgq\" "} {"level":"info","ts":"2026-04-07T09:44:24.079477Z","caller":"traceutil/trace.go:171","msg":"trace[379191887] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"354.471749ms","start":"2026-04-07T09:44:23.724974Z","end":"2026-04-07T09:44:24.079446Z","steps":["trace[379191887] 'process raft request' (duration: 354.003268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:24.079701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:23.72495Z","time spent":"354.633733ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":211659,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:24.302646Z","caller":"traceutil/trace.go:171","msg":"trace[1595231738] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"221.055337ms","start":"2026-04-07T09:44:24.081555Z","end":"2026-04-07T09:44:24.302611Z","steps":["trace[1595231738] 'process raft request' (duration: 183.015682ms)","trace[1595231738] 'compare' (duration: 37.878181ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:24.832075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.463901ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:24.832271Z","caller":"traceutil/trace.go:171","msg":"trace[550695148] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1221; }","duration":"527.450173ms","start":"2026-04-07T09:44:24.304803Z","end":"2026-04-07T09:44:24.832254Z","steps":["trace[550695148] 'process raft request' (duration: 527.390852ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:24.832244Z","caller":"traceutil/trace.go:171","msg":"trace[1430188742] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"747.325972ms","start":"2026-04-07T09:44:24.084869Z","end":"2026-04-07T09:44:24.832195Z","steps":["trace[1430188742] 'process raft request' (duration: 590.644716ms)","trace[1430188742] 'compare' (duration: 156.272786ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:24.832394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:24.304769Z","time spent":"527.540165ms","remote":"127.0.0.1:41456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":66,"response count":0,"response size":41,"request content":"compare: success: > failure: >"} {"level":"warn","ts":"2026-04-07T09:44:24.832442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:24.084839Z","time spent":"747.490545ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":542,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:24.832444Z","caller":"traceutil/trace.go:171","msg":"trace[142880556] linearizableReadLoop","detail":"{readStateIndex:1255; appliedIndex:1253; }","duration":"672.200325ms","start":"2026-04-07T09:44:24.160207Z","end":"2026-04-07T09:44:24.832407Z","steps":["trace[142880556] 'read index received' (duration: 104.170017ms)","trace[142880556] 'applied index is now lower than readState.Index' (duration: 568.023918ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:24.832824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.591965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:2 size:213823"} {"level":"info","ts":"2026-04-07T09:44:24.832868Z","caller":"traceutil/trace.go:171","msg":"trace[616657776] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:2; response_revision:1221; }","duration":"672.698946ms","start":"2026-04-07T09:44:24.160158Z","end":"2026-04-07T09:44:24.832856Z","steps":["trace[616657776] 'agreement among raft nodes before linearized reading' (duration: 672.366468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:24.832906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:24.160138Z","time spent":"672.759278ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":213846,"request content":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" "} {"level":"warn","ts":"2026-04-07T09:44:25.641014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.39804ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:25.641181Z","caller":"traceutil/trace.go:171","msg":"trace[1439505851] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"167.219346ms","start":"2026-04-07T09:44:25.473928Z","end":"2026-04-07T09:44:25.641147Z","steps":["trace[1439505851] 'process raft request' (duration: 23.572331ms)","trace[1439505851] 'compare' (duration: 143.186654ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:25.979834Z","caller":"traceutil/trace.go:171","msg":"trace[464120361] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"332.247651ms","start":"2026-04-07T09:44:25.647562Z","end":"2026-04-07T09:44:25.979809Z","steps":["trace[464120361] 'process raft request' (duration: 331.957064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.980063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:25.647499Z","time spent":"332.476387ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:25.980122Z","caller":"traceutil/trace.go:171","msg":"trace[811177350] linearizableReadLoop","detail":"{readStateIndex:1262; appliedIndex:1259; }","duration":"146.560876ms","start":"2026-04-07T09:44:25.83354Z","end":"2026-04-07T09:44:25.980101Z","steps":["trace[811177350] 'read index received' (duration: 145.991112ms)","trace[811177350] 'applied index is now lower than readState.Index' (duration: 568.794µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:25.980249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.693639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/self-signed\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:25.980225Z","caller":"traceutil/trace.go:171","msg":"trace[1464271289] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"332.126178ms","start":"2026-04-07T09:44:25.648074Z","end":"2026-04-07T09:44:25.9802Z","steps":["trace[1464271289] 'process raft request' (duration: 331.935063ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.980245Z","caller":"traceutil/trace.go:171","msg":"trace[1781429189] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"332.413405ms","start":"2026-04-07T09:44:25.647791Z","end":"2026-04-07T09:44:25.980204Z","steps":["trace[1781429189] 'process raft request' (duration: 331.965204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.980365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:25.64804Z","time spent":"332.266691ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:25.980291Z","caller":"traceutil/trace.go:171","msg":"trace[1600208714] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/self-signed; range_end:; response_count:0; response_revision:1227; }","duration":"146.797311ms","start":"2026-04-07T09:44:25.833483Z","end":"2026-04-07T09:44:25.980281Z","steps":["trace[1600208714] 'agreement among raft nodes before linearized reading' (duration: 146.695628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.980423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:25.647778Z","time spent":"332.553918ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:26.172805Z","caller":"traceutil/trace.go:171","msg":"trace[537359574] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"176.337833ms","start":"2026-04-07T09:44:25.996427Z","end":"2026-04-07T09:44:26.172765Z","steps":["trace[537359574] 'process raft request' (duration: 91.332322ms)","trace[537359574] 'compare' (duration: 84.798976ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:27.272405Z","caller":"traceutil/trace.go:171","msg":"trace[588003158] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"199.408811ms","start":"2026-04-07T09:44:27.072942Z","end":"2026-04-07T09:44:27.272351Z","steps":["trace[588003158] 'process raft request' (duration: 171.012106ms)","trace[588003158] 'compare' (duration: 28.148709ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:27.295785Z","caller":"traceutil/trace.go:171","msg":"trace[1341777965] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1231; }","duration":"221.20729ms","start":"2026-04-07T09:44:27.07455Z","end":"2026-04-07T09:44:27.295757Z","steps":["trace[1341777965] 'process raft request' (duration: 220.939254ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.295823Z","caller":"traceutil/trace.go:171","msg":"trace[498206311] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"218.129047ms","start":"2026-04-07T09:44:27.077662Z","end":"2026-04-07T09:44:27.295791Z","steps":["trace[498206311] 'process raft request' (duration: 217.993094ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.534263Z","caller":"traceutil/trace.go:171","msg":"trace[2061266401] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"254.870831ms","start":"2026-04-07T09:44:27.279368Z","end":"2026-04-07T09:44:27.534239Z","steps":["trace[2061266401] 'process raft request' (duration: 254.8178ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.534305Z","caller":"traceutil/trace.go:171","msg":"trace[47358942] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"255.184758ms","start":"2026-04-07T09:44:27.279075Z","end":"2026-04-07T09:44:27.53426Z","steps":["trace[47358942] 'process raft request' (duration: 219.336896ms)","trace[47358942] 'compare' (duration: 35.649408ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:27.893459Z","caller":"traceutil/trace.go:171","msg":"trace[2142096816] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"590.555544ms","start":"2026-04-07T09:44:27.302838Z","end":"2026-04-07T09:44:27.893393Z","steps":["trace[2142096816] 'process raft request' (duration: 590.235806ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.893612Z","caller":"traceutil/trace.go:171","msg":"trace[301088894] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"581.236912ms","start":"2026-04-07T09:44:27.312325Z","end":"2026-04-07T09:44:27.893562Z","steps":["trace[301088894] 'process raft request' (duration: 580.992186ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.893654Z","caller":"traceutil/trace.go:171","msg":"trace[845949087] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"584.610542ms","start":"2026-04-07T09:44:27.309027Z","end":"2026-04-07T09:44:27.893638Z","steps":["trace[845949087] 'process raft request' (duration: 584.212663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:27.893704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:27.302808Z","time spent":"590.781398ms","remote":"127.0.0.1:41342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:44:27.893822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:27.308993Z","time spent":"584.740845ms","remote":"127.0.0.1:53920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1157,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:27.893889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:27.312287Z","time spent":"581.441756ms","remote":"127.0.0.1:53880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2053,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:27.893431Z","caller":"traceutil/trace.go:171","msg":"trace[2058767161] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"433.635812ms","start":"2026-04-07T09:44:27.45977Z","end":"2026-04-07T09:44:27.893406Z","steps":["trace[2058767161] 'process raft request' (duration: 433.586171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:27.894437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:27.459723Z","time spent":"434.480452ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:27.896623Z","caller":"traceutil/trace.go:171","msg":"trace[2136489594] linearizableReadLoop","detail":"{readStateIndex:1276; appliedIndex:1270; }","duration":"250.104318ms","start":"2026-04-07T09:44:27.64649Z","end":"2026-04-07T09:44:27.896595Z","steps":["trace[2136489594] 'read index received' (duration: 246.505532ms)","trace[2136489594] 'applied index is now lower than readState.Index' (duration: 3.597486ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:27.896661Z","caller":"traceutil/trace.go:171","msg":"trace[420435637] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"356.918197ms","start":"2026-04-07T09:44:27.539709Z","end":"2026-04-07T09:44:27.896628Z","steps":["trace[420435637] 'process raft request' (duration: 356.59128ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.896701Z","caller":"traceutil/trace.go:171","msg":"trace[1024238905] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1239; }","duration":"351.516939ms","start":"2026-04-07T09:44:27.54516Z","end":"2026-04-07T09:44:27.896677Z","steps":["trace[1024238905] 'process raft request' (duration: 351.315814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:27.896786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:27.545144Z","time spent":"351.596851ms","remote":"127.0.0.1:53880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":70,"response count":0,"response size":2102,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:27.896793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:27.53968Z","time spent":"357.047621ms","remote":"127.0.0.1:41342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":784,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:44:27.897096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.594239ms","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:44:27.897189Z","caller":"traceutil/trace.go:171","msg":"trace[1701088753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1239; }","duration":"250.732992ms","start":"2026-04-07T09:44:27.646436Z","end":"2026-04-07T09:44:27.897169Z","steps":["trace[1701088753] 'agreement among raft nodes before linearized reading' (duration: 250.406754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:27.897096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.637929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-07T09:44:27.897315Z","caller":"traceutil/trace.go:171","msg":"trace[1512234900] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1239; }","duration":"218.895135ms","start":"2026-04-07T09:44:27.678385Z","end":"2026-04-07T09:44:27.89728Z","steps":["trace[1512234900] 'agreement among raft nodes before linearized reading' (duration: 218.504786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.154761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.885879ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T09:44:54.155095Z","caller":"traceutil/trace.go:171","msg":"trace[465806884] linearizableReadLoop","detail":"{readStateIndex:1621; appliedIndex:1620; }","duration":"193.700946ms","start":"2026-04-07T09:44:53.961362Z","end":"2026-04-07T09:44:54.155063Z","steps":["trace[465806884] 'read index received' (duration: 23.455958ms)","trace[465806884] 'applied index is now lower than readState.Index' (duration: 170.243188ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:54.155181Z","caller":"traceutil/trace.go:171","msg":"trace[663409287] transaction","detail":"{read_only:false; response_revision:1561; number_of_response:1; }","duration":"145.132482ms","start":"2026-04-07T09:44:54.009996Z","end":"2026-04-07T09:44:54.155129Z","steps":["trace[663409287] 'process raft request' (duration: 144.867055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.298128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.742358ms","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:54.298175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.753523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-07T09:44:54.298215Z","caller":"traceutil/trace.go:171","msg":"trace[1512458356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1561; }","duration":"336.869151ms","start":"2026-04-07T09:44:53.961323Z","end":"2026-04-07T09:44:54.298192Z","steps":["trace[1512458356] 'agreement among raft nodes before linearized reading' (duration: 193.85659ms)","trace[1512458356] 'range keys from in-memory index tree' (duration: 142.870567ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:54.298241Z","caller":"traceutil/trace.go:171","msg":"trace[1804331354] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1561; }","duration":"242.859236ms","start":"2026-04-07T09:44:54.055363Z","end":"2026-04-07T09:44:54.298223Z","steps":["trace[1804331354] 'agreement among raft nodes before linearized reading' (duration: 99.932887ms)","trace[1804331354] 'range keys from in-memory index tree' (duration: 142.751725ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:54.298258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:53.961306Z","time spent":"336.943702ms","remote":"127.0.0.1:41248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:44:54.298288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.266335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/openstack/rabbitmq-cluster-operator\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:54.298377Z","caller":"traceutil/trace.go:171","msg":"trace[1952705643] range","detail":"{range_begin:/registry/networkpolicies/openstack/rabbitmq-cluster-operator; range_end:; response_count:0; response_revision:1561; }","duration":"325.405169ms","start":"2026-04-07T09:44:53.972947Z","end":"2026-04-07T09:44:54.298352Z","steps":["trace[1952705643] 'agreement among raft nodes before linearized reading' (duration: 182.292735ms)","trace[1952705643] 'range keys from in-memory index tree' (duration: 142.97908ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:54.298413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.826153ms","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:44:54.298437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:53.972931Z","time spent":"325.49172ms","remote":"127.0.0.1:41556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/openstack/rabbitmq-cluster-operator\" "} {"level":"info","ts":"2026-04-07T09:44:54.298487Z","caller":"traceutil/trace.go:171","msg":"trace[2086966510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1561; }","duration":"170.913924ms","start":"2026-04-07T09:44:54.127551Z","end":"2026-04-07T09:44:54.298465Z","steps":["trace[2086966510] 'agreement among raft nodes before linearized reading' (duration: 27.715339ms)","trace[2086966510] 'range keys from in-memory index tree' (duration: 142.782606ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:54.298513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.607884ms","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:54.298416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.817127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-07T09:44:54.298575Z","caller":"traceutil/trace.go:171","msg":"trace[517289707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1561; }","duration":"177.691605ms","start":"2026-04-07T09:44:54.120851Z","end":"2026-04-07T09:44:54.298542Z","steps":["trace[517289707] 'agreement among raft nodes before linearized reading' (duration: 34.432738ms)","trace[517289707] 'range keys from in-memory index tree' (duration: 142.823357ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:54.298585Z","caller":"traceutil/trace.go:171","msg":"trace[123372341] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1561; }","duration":"241.038102ms","start":"2026-04-07T09:44:54.057538Z","end":"2026-04-07T09:44:54.298576Z","steps":["trace[123372341] 'agreement among raft nodes before linearized reading' (duration: 97.751314ms)","trace[123372341] 'range keys from in-memory index tree' (duration: 142.915388ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:54.29868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.338878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-07T09:44:54.298697Z","caller":"traceutil/trace.go:171","msg":"trace[760274782] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1561; }","duration":"172.3961ms","start":"2026-04-07T09:44:54.126295Z","end":"2026-04-07T09:44:54.298691Z","steps":["trace[760274782] 'agreement among raft nodes before linearized reading' (duration: 28.980229ms)","trace[760274782] 'range keys from in-memory index tree' (duration: 143.014391ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:54.56299Z","caller":"traceutil/trace.go:171","msg":"trace[198555715] linearizableReadLoop","detail":"{readStateIndex:1626; appliedIndex:1622; }","duration":"258.581639ms","start":"2026-04-07T09:44:54.304383Z","end":"2026-04-07T09:44:54.562964Z","steps":["trace[198555715] 'read index received' (duration: 42.05022ms)","trace[198555715] 'applied index is now lower than readState.Index' (duration: 216.530209ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:54.563086Z","caller":"traceutil/trace.go:171","msg":"trace[73542733] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"259.214814ms","start":"2026-04-07T09:44:54.303841Z","end":"2026-04-07T09:44:54.563056Z","steps":["trace[73542733] 'process raft request' (duration: 259.0176ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:54.563152Z","caller":"traceutil/trace.go:171","msg":"trace[61187085] transaction","detail":"{read_only:false; response_revision:1565; number_of_response:1; }","duration":"259.197344ms","start":"2026-04-07T09:44:54.303919Z","end":"2026-04-07T09:44:54.563117Z","steps":["trace[61187085] 'process raft request' (duration: 258.979099ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:54.563292Z","caller":"traceutil/trace.go:171","msg":"trace[12028941] transaction","detail":"{read_only:false; response_revision:1566; number_of_response:1; }","duration":"258.787444ms","start":"2026-04-07T09:44:54.304496Z","end":"2026-04-07T09:44:54.563283Z","steps":["trace[12028941] 'process raft request' (duration: 258.433125ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:54.563386Z","caller":"traceutil/trace.go:171","msg":"trace[1369656469] transaction","detail":"{read_only:false; response_revision:1563; number_of_response:1; }","duration":"259.628094ms","start":"2026-04-07T09:44:54.303737Z","end":"2026-04-07T09:44:54.563365Z","steps":["trace[1369656469] 'process raft request' (duration: 258.974028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.563413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.006469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/rabbitmq-cluster-operator\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:54.563452Z","caller":"traceutil/trace.go:171","msg":"trace[407923668] range","detail":"{range_begin:/registry/serviceaccounts/openstack/rabbitmq-cluster-operator; range_end:; response_count:0; response_revision:1566; }","duration":"259.074711ms","start":"2026-04-07T09:44:54.304363Z","end":"2026-04-07T09:44:54.563438Z","steps":["trace[407923668] 'agreement among raft nodes before linearized reading' (duration: 259.000169ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:54.867695Z","caller":"traceutil/trace.go:171","msg":"trace[1082475337] transaction","detail":"{read_only:false; response_revision:1570; number_of_response:1; }","duration":"147.6037ms","start":"2026-04-07T09:44:54.720052Z","end":"2026-04-07T09:44:54.867656Z","steps":["trace[1082475337] 'process raft request' (duration: 102.588719ms)","trace[1082475337] 'compare' (duration: 44.850707ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:55.114748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.953485ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:55.114887Z","caller":"traceutil/trace.go:171","msg":"trace[909754227] transaction","detail":"{read_only:false; response_revision:1574; number_of_response:1; }","duration":"149.533766ms","start":"2026-04-07T09:44:54.965332Z","end":"2026-04-07T09:44:55.114865Z","steps":["trace[909754227] 'compare' (duration: 138.781701ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.129102Z","caller":"traceutil/trace.go:171","msg":"trace[1884394170] transaction","detail":"{read_only:false; response_revision:1575; number_of_response:1; }","duration":"163.627821ms","start":"2026-04-07T09:44:54.965448Z","end":"2026-04-07T09:44:55.129076Z","steps":["trace[1884394170] 'process raft request' (duration: 163.498928ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.384336Z","caller":"traceutil/trace.go:171","msg":"trace[599045280] transaction","detail":"{read_only:false; response_revision:1577; number_of_response:1; }","duration":"250.18133ms","start":"2026-04-07T09:44:55.13412Z","end":"2026-04-07T09:44:55.384302Z","steps":["trace[599045280] 'process raft request' (duration: 155.705433ms)","trace[599045280] 'compare' (duration: 94.18568ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:55.384503Z","caller":"traceutil/trace.go:171","msg":"trace[1760087264] transaction","detail":"{read_only:false; response_revision:1579; number_of_response:1; }","duration":"250.261911ms","start":"2026-04-07T09:44:55.134216Z","end":"2026-04-07T09:44:55.384478Z","steps":["trace[1760087264] 'process raft request' (duration: 250.090317ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.384526Z","caller":"traceutil/trace.go:171","msg":"trace[630241201] transaction","detail":"{read_only:false; response_revision:1583; number_of_response:1; }","duration":"249.976404ms","start":"2026-04-07T09:44:55.134529Z","end":"2026-04-07T09:44:55.384505Z","steps":["trace[630241201] 'process raft request' (duration: 249.923243ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.384669Z","caller":"traceutil/trace.go:171","msg":"trace[42691274] transaction","detail":"{read_only:false; response_revision:1578; number_of_response:1; }","duration":"250.479586ms","start":"2026-04-07T09:44:55.13418Z","end":"2026-04-07T09:44:55.384659Z","steps":["trace[42691274] 'process raft request' (duration: 250.056506ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.38468Z","caller":"traceutil/trace.go:171","msg":"trace[1022942161] transaction","detail":"{read_only:false; response_revision:1580; number_of_response:1; }","duration":"250.325462ms","start":"2026-04-07T09:44:55.134343Z","end":"2026-04-07T09:44:55.384668Z","steps":["trace[1022942161] 'process raft request' (duration: 250.003665ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.384776Z","caller":"traceutil/trace.go:171","msg":"trace[1628606233] transaction","detail":"{read_only:false; response_revision:1581; number_of_response:1; }","duration":"250.379834ms","start":"2026-04-07T09:44:55.134363Z","end":"2026-04-07T09:44:55.384743Z","steps":["trace[1628606233] 'process raft request' (duration: 250.021206ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.384814Z","caller":"traceutil/trace.go:171","msg":"trace[832780346] transaction","detail":"{read_only:false; response_revision:1582; number_of_response:1; }","duration":"250.345553ms","start":"2026-04-07T09:44:55.134433Z","end":"2026-04-07T09:44:55.384779Z","steps":["trace[832780346] 'process raft request' (duration: 249.984044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.756467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.811469ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:55.756555Z","caller":"traceutil/trace.go:171","msg":"trace[464928489] transaction","detail":"{read_only:false; response_revision:1584; number_of_response:1; }","duration":"570.765173ms","start":"2026-04-07T09:44:55.185775Z","end":"2026-04-07T09:44:55.75654Z","steps":["trace[464928489] 'process raft request' (duration: 466.806501ms)","trace[464928489] 'compare' (duration: 103.710836ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:55.756595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.185749Z","time spent":"570.826764ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4100,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:55.845231Z","caller":"traceutil/trace.go:171","msg":"trace[1592763637] transaction","detail":"{read_only:false; response_revision:1585; number_of_response:1; }","duration":"456.490954ms","start":"2026-04-07T09:44:55.388716Z","end":"2026-04-07T09:44:55.845207Z","steps":["trace[1592763637] 'process raft request' (duration: 456.263168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.845364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.388689Z","time spent":"456.604907ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:55.845374Z","caller":"traceutil/trace.go:171","msg":"trace[1636528825] transaction","detail":"{read_only:false; response_revision:1587; number_of_response:1; }","duration":"455.116351ms","start":"2026-04-07T09:44:55.390236Z","end":"2026-04-07T09:44:55.845352Z","steps":["trace[1636528825] 'process raft request' (duration: 454.961198ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.845408Z","caller":"traceutil/trace.go:171","msg":"trace[1920763382] transaction","detail":"{read_only:false; response_revision:1586; number_of_response:1; }","duration":"455.182923ms","start":"2026-04-07T09:44:55.390186Z","end":"2026-04-07T09:44:55.845369Z","steps":["trace[1920763382] 'process raft request' (duration: 454.958847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.845473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.390223Z","time spent":"455.202253ms","remote":"127.0.0.1:41618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1256,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:44:55.845365Z","caller":"traceutil/trace.go:171","msg":"trace[2039405272] transaction","detail":"{read_only:false; response_revision:1589; number_of_response:1; }","duration":"450.314877ms","start":"2026-04-07T09:44:55.395025Z","end":"2026-04-07T09:44:55.84534Z","steps":["trace[2039405272] 'process raft request' (duration: 450.259756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.845552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.390164Z","time spent":"455.324597ms","remote":"127.0.0.1:41618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1310,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:44:55.845531Z","caller":"traceutil/trace.go:171","msg":"trace[278022558] transaction","detail":"{read_only:false; response_revision:1588; number_of_response:1; }","duration":"452.9246ms","start":"2026-04-07T09:44:55.392568Z","end":"2026-04-07T09:44:55.845492Z","steps":["trace[278022558] 'process raft request' (duration: 452.668614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.845655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.395011Z","time spent":"450.565304ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4304,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:55.845743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.392548Z","time spent":"453.096523ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2512,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:56.112216Z","caller":"traceutil/trace.go:171","msg":"trace[735249372] transaction","detail":"{read_only:false; response_revision:1590; number_of_response:1; }","duration":"345.453634ms","start":"2026-04-07T09:44:55.766738Z","end":"2026-04-07T09:44:56.112192Z","steps":["trace[735249372] 'process raft request' (duration: 345.29323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.112371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.76672Z","time spent":"345.569327ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4231,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:56.351455Z","caller":"traceutil/trace.go:171","msg":"trace[1820095138] linearizableReadLoop","detail":"{readStateIndex:1654; appliedIndex:1650; }","duration":"388.851367ms","start":"2026-04-07T09:44:55.962583Z","end":"2026-04-07T09:44:56.351434Z","steps":["trace[1820095138] 'read index received' (duration: 149.443214ms)","trace[1820095138] 'applied index is now lower than readState.Index' (duration: 239.407363ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:56.351519Z","caller":"traceutil/trace.go:171","msg":"trace[2043159277] transaction","detail":"{read_only:false; response_revision:1592; number_of_response:1; }","duration":"500.930292ms","start":"2026-04-07T09:44:55.85055Z","end":"2026-04-07T09:44:56.35148Z","steps":["trace[2043159277] 'process raft request' (duration: 500.797409ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.351621Z","caller":"traceutil/trace.go:171","msg":"trace[823335755] transaction","detail":"{read_only:false; response_revision:1591; number_of_response:1; }","duration":"501.092566ms","start":"2026-04-07T09:44:55.850501Z","end":"2026-04-07T09:44:56.351594Z","steps":["trace[823335755] 'process raft request' (duration: 500.729627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.351671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.850524Z","time spent":"501.072296ms","remote":"127.0.0.1:41592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1172,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:44:56.351552Z","caller":"traceutil/trace.go:171","msg":"trace[2056242041] transaction","detail":"{read_only:false; response_revision:1593; number_of_response:1; }","duration":"495.647086ms","start":"2026-04-07T09:44:55.855895Z","end":"2026-04-07T09:44:56.351542Z","steps":["trace[2056242041] 'process raft request' (duration: 495.486213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.351939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.855885Z","time spent":"495.922063ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4304,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:56.352045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.850481Z","time spent":"501.208799ms","remote":"127.0.0.1:41592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:44:56.35201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.360389ms","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:56.352131Z","caller":"traceutil/trace.go:171","msg":"trace[315741110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1593; }","duration":"389.582494ms","start":"2026-04-07T09:44:55.962531Z","end":"2026-04-07T09:44:56.352114Z","steps":["trace[315741110] 'agreement among raft nodes before linearized reading' (duration: 389.040531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.352246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:55.962511Z","time spent":"389.688577ms","remote":"127.0.0.1:41232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T09:44:56.584842Z","caller":"traceutil/trace.go:171","msg":"trace[349245374] linearizableReadLoop","detail":"{readStateIndex:1656; appliedIndex:1654; }","duration":"233.306228ms","start":"2026-04-07T09:44:56.351514Z","end":"2026-04-07T09:44:56.58482Z","steps":["trace[349245374] 'read index received' (duration: 233.059202ms)","trace[349245374] 'applied index is now lower than readState.Index' (duration: 246.056µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:56.584865Z","caller":"traceutil/trace.go:171","msg":"trace[658764841] transaction","detail":"{read_only:false; response_revision:1594; number_of_response:1; }","duration":"461.75249ms","start":"2026-04-07T09:44:56.123088Z","end":"2026-04-07T09:44:56.58484Z","steps":["trace[658764841] 'process raft request' (duration: 461.511545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.585053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.12306Z","time spent":"461.902624ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4506,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:56.585093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.947697ms","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:56.585169Z","caller":"traceutil/trace.go:171","msg":"trace[1703092287] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1595; }","duration":"235.07403ms","start":"2026-04-07T09:44:56.350078Z","end":"2026-04-07T09:44:56.585152Z","steps":["trace[1703092287] 'agreement among raft nodes before linearized reading' (duration: 234.865555ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.585321Z","caller":"traceutil/trace.go:171","msg":"trace[1901075323] transaction","detail":"{read_only:false; response_revision:1595; number_of_response:1; }","duration":"425.595131ms","start":"2026-04-07T09:44:56.159698Z","end":"2026-04-07T09:44:56.585293Z","steps":["trace[1901075323] 'process raft request' (duration: 425.062178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.585484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.159665Z","time spent":"425.749624ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:56.788102Z","caller":"traceutil/trace.go:171","msg":"trace[1527336580] transaction","detail":"{read_only:false; response_revision:1596; number_of_response:1; }","duration":"431.658164ms","start":"2026-04-07T09:44:56.356418Z","end":"2026-04-07T09:44:56.788076Z","steps":["trace[1527336580] 'process raft request' (duration: 431.46874ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.788396Z","caller":"traceutil/trace.go:171","msg":"trace[834378843] transaction","detail":"{read_only:false; response_revision:1598; number_of_response:1; }","duration":"425.952669ms","start":"2026-04-07T09:44:56.362431Z","end":"2026-04-07T09:44:56.788384Z","steps":["trace[834378843] 'process raft request' (duration: 425.635141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.788376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.844262ms","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:44:56.788358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.389634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-07T09:44:56.788341Z","caller":"traceutil/trace.go:171","msg":"trace[1220975780] transaction","detail":"{read_only:false; response_revision:1597; number_of_response:1; }","duration":"431.840169ms","start":"2026-04-07T09:44:56.356481Z","end":"2026-04-07T09:44:56.788321Z","steps":["trace[1220975780] 'process raft request' (duration: 431.544092ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.788175Z","caller":"traceutil/trace.go:171","msg":"trace[1922814762] linearizableReadLoop","detail":"{readStateIndex:1659; appliedIndex:1656; }","duration":"203.213933ms","start":"2026-04-07T09:44:56.584914Z","end":"2026-04-07T09:44:56.788128Z","steps":["trace[1922814762] 'read index received' (duration: 202.998968ms)","trace[1922814762] 'applied index is now lower than readState.Index' (duration: 214.035µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:56.788451Z","caller":"traceutil/trace.go:171","msg":"trace[490738683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1598; }","duration":"220.976685ms","start":"2026-04-07T09:44:56.567456Z","end":"2026-04-07T09:44:56.788433Z","steps":["trace[490738683] 'agreement among raft nodes before linearized reading' (duration: 220.734919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.788459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.453306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-07T09:44:56.788497Z","caller":"traceutil/trace.go:171","msg":"trace[152222073] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1598; }","duration":"221.539068ms","start":"2026-04-07T09:44:56.566904Z","end":"2026-04-07T09:44:56.788443Z","steps":["trace[152222073] 'agreement among raft nodes before linearized reading' (duration: 221.321163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.788469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.993485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-07T09:44:56.788535Z","caller":"traceutil/trace.go:171","msg":"trace[999861911] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1598; }","duration":"221.576969ms","start":"2026-04-07T09:44:56.566942Z","end":"2026-04-07T09:44:56.788519Z","steps":["trace[999861911] 'agreement among raft nodes before linearized reading' (duration: 221.379814ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.788554Z","caller":"traceutil/trace.go:171","msg":"trace[1156820566] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1598; }","duration":"221.116328ms","start":"2026-04-07T09:44:56.567424Z","end":"2026-04-07T09:44:56.78854Z","steps":["trace[1156820566] 'agreement among raft nodes before linearized reading' (duration: 220.886492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.788773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.356399Z","time spent":"431.964122ms","remote":"127.0.0.1:41598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1224,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:44:56.788905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.356456Z","time spent":"432.007934ms","remote":"127.0.0.1:41598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1279,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:44:56.788868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.362416Z","time spent":"426.005041ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4304,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:56.802119Z","caller":"traceutil/trace.go:171","msg":"trace[1905040153] transaction","detail":"{read_only:false; response_revision:1599; number_of_response:1; }","duration":"213.854895ms","start":"2026-04-07T09:44:56.588247Z","end":"2026-04-07T09:44:56.802102Z","steps":["trace[1905040153] 'process raft request' (duration: 213.758873ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.958662Z","caller":"traceutil/trace.go:171","msg":"trace[444443035] transaction","detail":"{read_only:false; response_revision:1600; number_of_response:1; }","duration":"165.964896ms","start":"2026-04-07T09:44:56.792666Z","end":"2026-04-07T09:44:56.958631Z","steps":["trace[444443035] 'process raft request' (duration: 150.393426ms)","trace[444443035] 'compare' (duration: 15.347965ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:56.958974Z","caller":"traceutil/trace.go:171","msg":"trace[1186605840] linearizableReadLoop","detail":"{readStateIndex:1663; appliedIndex:1659; }","duration":"165.479575ms","start":"2026-04-07T09:44:56.793472Z","end":"2026-04-07T09:44:56.958951Z","steps":["trace[1186605840] 'read index received' (duration: 8.594724ms)","trace[1186605840] 'applied index is now lower than readState.Index' (duration: 156.882751ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:56.959021Z","caller":"traceutil/trace.go:171","msg":"trace[1585029360] transaction","detail":"{read_only:false; response_revision:1604; number_of_response:1; }","duration":"162.139656ms","start":"2026-04-07T09:44:56.796863Z","end":"2026-04-07T09:44:56.959003Z","steps":["trace[1585029360] 'process raft request' (duration: 161.86792ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.958682Z","caller":"traceutil/trace.go:171","msg":"trace[1709313915] transaction","detail":"{read_only:false; response_revision:1602; number_of_response:1; }","duration":"165.755201ms","start":"2026-04-07T09:44:56.792906Z","end":"2026-04-07T09:44:56.958661Z","steps":["trace[1709313915] 'process raft request' (duration: 165.665689ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.95869Z","caller":"traceutil/trace.go:171","msg":"trace[1751522850] transaction","detail":"{read_only:false; response_revision:1601; number_of_response:1; }","duration":"165.949406ms","start":"2026-04-07T09:44:56.792713Z","end":"2026-04-07T09:44:56.958662Z","steps":["trace[1751522850] 'process raft request' (duration: 165.795232ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.958856Z","caller":"traceutil/trace.go:171","msg":"trace[1253132841] transaction","detail":"{read_only:false; response_revision:1603; number_of_response:1; }","duration":"165.234459ms","start":"2026-04-07T09:44:56.793591Z","end":"2026-04-07T09:44:56.958826Z","steps":["trace[1253132841] 'process raft request' (duration: 165.025364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.959254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.762501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:115771"} {"level":"info","ts":"2026-04-07T09:44:56.959301Z","caller":"traceutil/trace.go:171","msg":"trace[1614006316] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1604; }","duration":"165.849984ms","start":"2026-04-07T09:44:56.79344Z","end":"2026-04-07T09:44:56.95929Z","steps":["trace[1614006316] 'agreement among raft nodes before linearized reading' (duration: 165.584248ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:57.174146Z","caller":"traceutil/trace.go:171","msg":"trace[1538950853] linearizableReadLoop","detail":"{readStateIndex:1666; appliedIndex:1665; }","duration":"210.065386ms","start":"2026-04-07T09:44:56.964054Z","end":"2026-04-07T09:44:57.17412Z","steps":["trace[1538950853] 'read index received' (duration: 171.15097ms)","trace[1538950853] 'applied index is now lower than readState.Index' (duration: 38.913306ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:57.174235Z","caller":"traceutil/trace.go:171","msg":"trace[1712119996] transaction","detail":"{read_only:false; response_revision:1605; number_of_response:1; }","duration":"211.312886ms","start":"2026-04-07T09:44:56.96285Z","end":"2026-04-07T09:44:57.174163Z","steps":["trace[1712119996] 'process raft request' (duration: 172.346499ms)","trace[1712119996] 'compare' (duration: 38.767452ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:57.174283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.219099ms","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.174348Z","caller":"traceutil/trace.go:171","msg":"trace[1228856143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1605; }","duration":"210.337002ms","start":"2026-04-07T09:44:56.963998Z","end":"2026-04-07T09:44:57.174335Z","steps":["trace[1228856143] 'agreement among raft nodes before linearized reading' (duration: 210.214759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:57.399075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.279463ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:57.399222Z","caller":"traceutil/trace.go:171","msg":"trace[2121695127] transaction","detail":"{read_only:false; response_revision:1607; number_of_response:1; }","duration":"139.119028ms","start":"2026-04-07T09:44:57.260081Z","end":"2026-04-07T09:44:57.3992Z","steps":["trace[2121695127] 'process raft request' (duration: 25.609119ms)","trace[2121695127] 'compare' (duration: 113.086099ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:57.453923Z","caller":"traceutil/trace.go:171","msg":"trace[377710095] transaction","detail":"{read_only:false; response_revision:1608; number_of_response:1; }","duration":"193.808239ms","start":"2026-04-07T09:44:57.26008Z","end":"2026-04-07T09:44:57.453889Z","steps":["trace[377710095] 'process raft request' (duration: 193.581883ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:57.45393Z","caller":"traceutil/trace.go:171","msg":"trace[1673467510] transaction","detail":"{read_only:false; response_revision:1610; number_of_response:1; }","duration":"191.004842ms","start":"2026-04-07T09:44:57.262903Z","end":"2026-04-07T09:44:57.453908Z","steps":["trace[1673467510] 'process raft request' (duration: 190.965911ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:57.454173Z","caller":"traceutil/trace.go:171","msg":"trace[678197369] transaction","detail":"{read_only:false; response_revision:1609; number_of_response:1; }","duration":"193.181514ms","start":"2026-04-07T09:44:57.260813Z","end":"2026-04-07T09:44:57.453994Z","steps":["trace[678197369] 'process raft request' (duration: 192.99818ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:57.809266Z","caller":"traceutil/trace.go:171","msg":"trace[867920410] transaction","detail":"{read_only:false; response_revision:1611; number_of_response:1; }","duration":"348.780493ms","start":"2026-04-07T09:44:57.460419Z","end":"2026-04-07T09:44:57.8092Z","steps":["trace[867920410] 'process raft request' (duration: 286.586934ms)","trace[867920410] 'compare' (duration: 61.969634ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:57.809491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.460393Z","time spent":"348.989889ms","remote":"127.0.0.1:41744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5385,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:44:57.990218Z","caller":"traceutil/trace.go:171","msg":"trace[1880831536] transaction","detail":"{read_only:false; response_revision:1613; number_of_response:1; }","duration":"524.331888ms","start":"2026-04-07T09:44:57.465854Z","end":"2026-04-07T09:44:57.990186Z","steps":["trace[1880831536] 'process raft request' (duration: 524.257597ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:57.99024Z","caller":"traceutil/trace.go:171","msg":"trace[1511439446] transaction","detail":"{read_only:false; response_revision:1612; number_of_response:1; }","duration":"529.511031ms","start":"2026-04-07T09:44:57.460693Z","end":"2026-04-07T09:44:57.990204Z","steps":["trace[1511439446] 'process raft request' (duration: 487.384589ms)","trace[1511439446] 'compare' (duration: 41.852855ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:57.990395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.46584Z","time spent":"524.471761ms","remote":"127.0.0.1:53880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1786,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:44:57.990419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:57.460671Z","time spent":"529.654845ms","remote":"127.0.0.1:41744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5671,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:44:58.076228Z","caller":"traceutil/trace.go:171","msg":"trace[1462854589] linearizableReadLoop","detail":"{readStateIndex:1675; appliedIndex:1672; }","duration":"261.245662ms","start":"2026-04-07T09:44:57.814951Z","end":"2026-04-07T09:44:58.076196Z","steps":["trace[1462854589] 'read index received' (duration: 133.148196ms)","trace[1462854589] 'applied index is now lower than readState.Index' (duration: 128.096136ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:58.076578Z","caller":"traceutil/trace.go:171","msg":"trace[1491285316] transaction","detail":"{read_only:false; response_revision:1614; number_of_response:1; }","duration":"261.99014ms","start":"2026-04-07T09:44:57.814547Z","end":"2026-04-07T09:44:58.076537Z","steps":["trace[1491285316] 'process raft request' (duration: 261.277983ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:58.076554Z","caller":"traceutil/trace.go:171","msg":"trace[1084646494] transaction","detail":"{read_only:false; response_revision:1615; number_of_response:1; }","duration":"259.504261ms","start":"2026-04-07T09:44:57.816974Z","end":"2026-04-07T09:44:58.076478Z","steps":["trace[1084646494] 'process raft request' (duration: 259.133432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:58.076938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.895828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:58.077143Z","caller":"traceutil/trace.go:171","msg":"trace[1920483843] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:1615; }","duration":"262.205826ms","start":"2026-04-07T09:44:57.814917Z","end":"2026-04-07T09:44:58.077123Z","steps":["trace[1920483843] 'agreement among raft nodes before linearized reading' (duration: 261.410317ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:14.31063Z","caller":"traceutil/trace.go:171","msg":"trace[1728179311] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"422.092707ms","start":"2026-04-07T09:45:13.888509Z","end":"2026-04-07T09:45:14.310602Z","steps":["trace[1728179311] 'process raft request' (duration: 421.937663ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:14.310704Z","caller":"traceutil/trace.go:171","msg":"trace[328691249] linearizableReadLoop","detail":"{readStateIndex:1946; appliedIndex:1945; }","duration":"304.401368ms","start":"2026-04-07T09:45:14.006271Z","end":"2026-04-07T09:45:14.310673Z","steps":["trace[328691249] 'read index received' (duration: 304.160893ms)","trace[328691249] 'applied index is now lower than readState.Index' (duration: 237.955µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:45:14.310759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:13.888491Z","time spent":"422.20569ms","remote":"127.0.0.1:41456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:45:14.310907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.263495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:45:14.310986Z","caller":"traceutil/trace.go:171","msg":"trace[2114258789] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:1873; }","duration":"206.361777ms","start":"2026-04-07T09:45:14.104604Z","end":"2026-04-07T09:45:14.310965Z","steps":["trace[2114258789] 'agreement among raft nodes before linearized reading' (duration: 206.224394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:14.310994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.716877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d84175b4-95d8-4267-b7d7-9c758f3e6a74\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T09:45:14.311063Z","caller":"traceutil/trace.go:171","msg":"trace[275694924] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d84175b4-95d8-4267-b7d7-9c758f3e6a74; range_end:; response_count:1; response_revision:1873; }","duration":"304.828989ms","start":"2026-04-07T09:45:14.006214Z","end":"2026-04-07T09:45:14.311043Z","steps":["trace[275694924] 'agreement among raft nodes before linearized reading' (duration: 304.617214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:14.311106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:14.006191Z","time spent":"304.90494ms","remote":"127.0.0.1:41456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d84175b4-95d8-4267-b7d7-9c758f3e6a74\" "} {"level":"info","ts":"2026-04-07T09:45:14.459566Z","caller":"traceutil/trace.go:171","msg":"trace[223153832] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"138.938764ms","start":"2026-04-07T09:45:14.320566Z","end":"2026-04-07T09:45:14.459505Z","steps":["trace[223153832] 'process raft request' (duration: 138.875672ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:14.459646Z","caller":"traceutil/trace.go:171","msg":"trace[1859759945] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"142.780225ms","start":"2026-04-07T09:45:14.316843Z","end":"2026-04-07T09:45:14.459623Z","steps":["trace[1859759945] 'process raft request' (duration: 142.487308ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:14.459711Z","caller":"traceutil/trace.go:171","msg":"trace[1695478519] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"142.926289ms","start":"2026-04-07T09:45:14.316766Z","end":"2026-04-07T09:45:14.459693Z","steps":["trace[1695478519] 'process raft request' (duration: 95.731667ms)","trace[1695478519] 'compare' (duration: 46.69349ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:45:14.460034Z","caller":"traceutil/trace.go:171","msg":"trace[827878060] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"143.179405ms","start":"2026-04-07T09:45:14.316842Z","end":"2026-04-07T09:45:14.460021Z","steps":["trace[827878060] 'process raft request' (duration: 142.55319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:14.862818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.925809ms","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:45:14.862835Z","caller":"traceutil/trace.go:171","msg":"trace[1059933520] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"221.253101ms","start":"2026-04-07T09:45:14.641556Z","end":"2026-04-07T09:45:14.862809Z","steps":["trace[1059933520] 'process raft request' (duration: 181.463035ms)","trace[1059933520] 'compare' (duration: 39.499929ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:45:14.862896Z","caller":"traceutil/trace.go:171","msg":"trace[1855288063] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1878; }","duration":"233.051062ms","start":"2026-04-07T09:45:14.629828Z","end":"2026-04-07T09:45:14.862879Z","steps":["trace[1855288063] 'range keys from in-memory index tree' (duration: 232.780786ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:26.002878Z","caller":"traceutil/trace.go:171","msg":"trace[2067206175] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"128.027228ms","start":"2026-04-07T09:45:25.874821Z","end":"2026-04-07T09:45:26.002848Z","steps":["trace[2067206175] 'process raft request' (duration: 127.556437ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:53.106941Z","caller":"traceutil/trace.go:171","msg":"trace[199345188] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"117.841755ms","start":"2026-04-07T09:45:52.989082Z","end":"2026-04-07T09:45:53.106924Z","steps":["trace[199345188] 'process raft request' (duration: 117.708202ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:53.240847Z","caller":"traceutil/trace.go:171","msg":"trace[159748521] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"130.777844ms","start":"2026-04-07T09:45:53.110043Z","end":"2026-04-07T09:45:53.240821Z","steps":["trace[159748521] 'process raft request' (duration: 50.687383ms)","trace[159748521] 'compare' (duration: 79.66321ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:46:05.824755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.708982ms","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:46:05.824753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.114599ms","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:46:05.824841Z","caller":"traceutil/trace.go:171","msg":"trace[613075769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2198; }","duration":"484.821675ms","start":"2026-04-07T09:46:05.34Z","end":"2026-04-07T09:46:05.824822Z","steps":["trace[613075769] 'range keys from in-memory index tree' (duration: 484.570949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:05.824885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.339979Z","time spent":"484.897856ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T09:46:05.824889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.110974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-04-07T09:46:05.824919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.258513ms","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:46:05.825014Z","caller":"traceutil/trace.go:171","msg":"trace[936594080] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2198; }","duration":"464.248517ms","start":"2026-04-07T09:46:05.360738Z","end":"2026-04-07T09:46:05.824986Z","steps":["trace[936594080] 'range keys from in-memory index tree' (duration: 463.918109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:05.824994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.221551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-07T09:46:05.825033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.528447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-07T09:46:05.82507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.360704Z","time spent":"464.35486ms","remote":"127.0.0.1:49876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-07T09:46:05.825109Z","caller":"traceutil/trace.go:171","msg":"trace[1751905659] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2198; }","duration":"417.403765ms","start":"2026-04-07T09:46:05.407681Z","end":"2026-04-07T09:46:05.825085Z","steps":["trace[1751905659] 'range keys from in-memory index tree' (duration: 416.913603ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:46:05.825118Z","caller":"traceutil/trace.go:171","msg":"trace[1012464647] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2198; }","duration":"441.671461ms","start":"2026-04-07T09:46:05.383425Z","end":"2026-04-07T09:46:05.825097Z","steps":["trace[1012464647] 'range keys from in-memory index tree' (duration: 440.904873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:05.825106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.820794ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-04-07T09:46:05.825175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.383398Z","time spent":"441.767273ms","remote":"127.0.0.1:41530","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:46:05.825174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.40765Z","time spent":"417.512298ms","remote":"127.0.0.1:41530","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:46:05.825239Z","caller":"traceutil/trace.go:171","msg":"trace[2080051257] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"275.520868ms","start":"2026-04-07T09:46:05.549693Z","end":"2026-04-07T09:46:05.825214Z","steps":["trace[2080051257] 'process raft request' (duration: 144.476999ms)","trace[2080051257] 'compare' (duration: 130.386144ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:46:05.825037Z","caller":"traceutil/trace.go:171","msg":"trace[399019412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2198; }","duration":"412.419606ms","start":"2026-04-07T09:46:05.412588Z","end":"2026-04-07T09:46:05.825008Z","steps":["trace[399019412] 'range keys from in-memory index tree' (duration: 411.954615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:05.825329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.412575Z","time spent":"412.738565ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T09:46:05.824866Z","caller":"traceutil/trace.go:171","msg":"trace[1552900148] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2198; }","duration":"409.256991ms","start":"2026-04-07T09:46:05.415588Z","end":"2026-04-07T09:46:05.824845Z","steps":["trace[1552900148] 'range keys from in-memory index tree' (duration: 408.955134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:05.825636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.415578Z","time spent":"410.03881ms","remote":"127.0.0.1:41530","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:46:05.824269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.291176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:46:05.825726Z","caller":"traceutil/trace.go:171","msg":"trace[886994560] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2198; }","duration":"371.822653ms","start":"2026-04-07T09:46:05.453885Z","end":"2026-04-07T09:46:05.825707Z","steps":["trace[886994560] 'count revisions from in-memory index tree' (duration: 370.185824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:05.825774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.453867Z","time spent":"371.889004ms","remote":"127.0.0.1:41482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:46:06.307939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.001701ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:46:06.308148Z","caller":"traceutil/trace.go:171","msg":"trace[306610118] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"505.082185ms","start":"2026-04-07T09:46:05.803038Z","end":"2026-04-07T09:46:06.30812Z","steps":["trace[306610118] 'process raft request' (duration: 131.683065ms)","trace[306610118] 'compare' (duration: 372.648923ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:46:06.308258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.802994Z","time spent":"505.217249ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:46:06.390337Z","caller":"traceutil/trace.go:171","msg":"trace[117757812] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"560.955922ms","start":"2026-04-07T09:46:05.829345Z","end":"2026-04-07T09:46:06.390301Z","steps":["trace[117757812] 'process raft request' (duration: 560.658765ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:46:06.390361Z","caller":"traceutil/trace.go:171","msg":"trace[712540813] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"560.436809ms","start":"2026-04-07T09:46:05.829894Z","end":"2026-04-07T09:46:06.390331Z","steps":["trace[712540813] 'process raft request' (duration: 560.339797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:06.390503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.829319Z","time spent":"561.097375ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:46:06.390587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.82987Z","time spent":"560.579232ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:46:06.390789Z","caller":"traceutil/trace.go:171","msg":"trace[377274856] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"560.578613ms","start":"2026-04-07T09:46:05.830193Z","end":"2026-04-07T09:46:06.390772Z","steps":["trace[377274856] 'process raft request' (duration: 560.084301ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:46:06.390799Z","caller":"traceutil/trace.go:171","msg":"trace[1352028759] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"560.578762ms","start":"2026-04-07T09:46:05.830204Z","end":"2026-04-07T09:46:06.390783Z","steps":["trace[1352028759] 'process raft request' (duration: 560.379718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:06.390874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.830196Z","time spent":"560.641705ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:46:06.390819Z","caller":"traceutil/trace.go:171","msg":"trace[713437351] linearizableReadLoop","detail":"{readStateIndex:2289; appliedIndex:2284; }","duration":"401.063807ms","start":"2026-04-07T09:46:05.989719Z","end":"2026-04-07T09:46:06.390783Z","steps":["trace[713437351] 'read index received' (duration: 400.277979ms)","trace[713437351] 'applied index is now lower than readState.Index' (duration: 783.338µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:46:06.390913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.830176Z","time spent":"560.657134ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:46:06.390917Z","caller":"traceutil/trace.go:171","msg":"trace[1680134296] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"560.4975ms","start":"2026-04-07T09:46:05.830375Z","end":"2026-04-07T09:46:06.390873Z","steps":["trace[1680134296] 'process raft request' (duration: 560.338477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:06.391098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.634263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:46:06.391099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.369044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-04-07T09:46:06.391121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.83034Z","time spent":"560.669005ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:46:06.391157Z","caller":"traceutil/trace.go:171","msg":"trace[662082741] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2205; }","duration":"139.756236ms","start":"2026-04-07T09:46:06.251383Z","end":"2026-04-07T09:46:06.391139Z","steps":["trace[662082741] 'agreement among raft nodes before linearized reading' (duration: 139.629653ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:46:06.391185Z","caller":"traceutil/trace.go:171","msg":"trace[1109828290] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2205; }","duration":"401.497867ms","start":"2026-04-07T09:46:05.989666Z","end":"2026-04-07T09:46:06.391164Z","steps":["trace[1109828290] 'agreement among raft nodes before linearized reading' (duration: 401.286902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:06.391221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:05.989645Z","time spent":"401.56744ms","remote":"127.0.0.1:41530","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:47:41.277996Z","caller":"traceutil/trace.go:171","msg":"trace[742344259] linearizableReadLoop","detail":"{readStateIndex:3019; appliedIndex:3018; }","duration":"103.741711ms","start":"2026-04-07T09:47:41.174228Z","end":"2026-04-07T09:47:41.27797Z","steps":["trace[742344259] 'read index received' (duration: 103.537986ms)","trace[742344259] 'applied index is now lower than readState.Index' (duration: 202.055µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:47:41.278297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.053419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:47:41.278361Z","caller":"traceutil/trace.go:171","msg":"trace[1349591724] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:2908; }","duration":"104.182342ms","start":"2026-04-07T09:47:41.174163Z","end":"2026-04-07T09:47:41.278345Z","steps":["trace[1349591724] 'agreement among raft nodes before linearized reading' (duration: 103.914786ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:47:41.278569Z","caller":"traceutil/trace.go:171","msg":"trace[1633904306] transaction","detail":"{read_only:false; response_revision:2908; number_of_response:1; }","duration":"127.108059ms","start":"2026-04-07T09:47:41.151393Z","end":"2026-04-07T09:47:41.278501Z","steps":["trace[1633904306] 'process raft request' (duration: 126.386342ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:28.787793Z","caller":"traceutil/trace.go:171","msg":"trace[99458929] linearizableReadLoop","detail":"{readStateIndex:4976; appliedIndex:4975; }","duration":"122.258306ms","start":"2026-04-07T09:51:28.665481Z","end":"2026-04-07T09:51:28.78774Z","steps":["trace[99458929] 'read index received' (duration: 120.968215ms)","trace[99458929] 'applied index is now lower than readState.Index' (duration: 1.288781ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:28.787819Z","caller":"traceutil/trace.go:171","msg":"trace[565846248] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"124.062589ms","start":"2026-04-07T09:51:28.663716Z","end":"2026-04-07T09:51:28.787779Z","steps":["trace[565846248] 'process raft request' (duration: 122.642635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:28.788009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.629859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-07T09:51:28.788088Z","caller":"traceutil/trace.go:171","msg":"trace[1123660009] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4790; }","duration":"123.745332ms","start":"2026-04-07T09:51:28.664324Z","end":"2026-04-07T09:51:28.788069Z","steps":["trace[1123660009] 'agreement among raft nodes before linearized reading' (duration: 123.516016ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:28.819347Z","caller":"traceutil/trace.go:171","msg":"trace[879872771] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"153.758565ms","start":"2026-04-07T09:51:28.665565Z","end":"2026-04-07T09:51:28.819324Z","steps":["trace[879872771] 'process raft request' (duration: 153.536159ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:28.819411Z","caller":"traceutil/trace.go:171","msg":"trace[1401052573] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"152.546966ms","start":"2026-04-07T09:51:28.666845Z","end":"2026-04-07T09:51:28.819392Z","steps":["trace[1401052573] 'process raft request' (duration: 152.401173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:28.819605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.962872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/local-path-storage/\" range_end:\"/registry/resourcequotas/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:51:28.819618Z","caller":"traceutil/trace.go:171","msg":"trace[1623614043] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"152.405063ms","start":"2026-04-07T09:51:28.667167Z","end":"2026-04-07T09:51:28.819572Z","steps":["trace[1623614043] 'process raft request' (duration: 152.127626ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:28.819653Z","caller":"traceutil/trace.go:171","msg":"trace[1018861953] range","detail":"{range_begin:/registry/resourcequotas/local-path-storage/; range_end:/registry/resourcequotas/local-path-storage0; response_count:0; response_revision:4793; }","duration":"152.110235ms","start":"2026-04-07T09:51:28.66753Z","end":"2026-04-07T09:51:28.81964Z","steps":["trace[1018861953] 'agreement among raft nodes before linearized reading' (duration: 151.964472ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:34.800018Z","caller":"traceutil/trace.go:171","msg":"trace[1884409178] linearizableReadLoop","detail":"{readStateIndex:5137; appliedIndex:5136; }","duration":"128.976756ms","start":"2026-04-07T09:51:34.671017Z","end":"2026-04-07T09:51:34.799993Z","steps":["trace[1884409178] 'read index received' (duration: 128.816982ms)","trace[1884409178] 'applied index is now lower than readState.Index' (duration: 158.484µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:34.800166Z","caller":"traceutil/trace.go:171","msg":"trace[748117788] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"174.640862ms","start":"2026-04-07T09:51:34.625494Z","end":"2026-04-07T09:51:34.800135Z","steps":["trace[748117788] 'process raft request' (duration: 174.346044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:34.800236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.198031ms","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:51:34.800369Z","caller":"traceutil/trace.go:171","msg":"trace[411939156] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4945; }","duration":"129.371015ms","start":"2026-04-07T09:51:34.670973Z","end":"2026-04-07T09:51:34.800344Z","steps":["trace[411939156] 'agreement among raft nodes before linearized reading' (duration: 129.179571ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:34.801222Z","caller":"traceutil/trace.go:171","msg":"trace[1741703955] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"111.560742ms","start":"2026-04-07T09:51:34.689633Z","end":"2026-04-07T09:51:34.801194Z","steps":["trace[1741703955] 'process raft request' (duration: 111.47231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:34.801292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.839416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-d7wrc\" ","response":"range_response_count:1 size:9716"} {"level":"info","ts":"2026-04-07T09:51:34.801344Z","caller":"traceutil/trace.go:171","msg":"trace[93326215] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-d7wrc; range_end:; response_count:1; response_revision:4946; }","duration":"113.923858ms","start":"2026-04-07T09:51:34.687406Z","end":"2026-04-07T09:51:34.80133Z","steps":["trace[93326215] 'agreement among raft nodes before linearized reading' (duration: 113.761324ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:36.987508Z","caller":"traceutil/trace.go:171","msg":"trace[1370678767] transaction","detail":"{read_only:false; response_revision:5064; number_of_response:1; }","duration":"175.320408ms","start":"2026-04-07T09:51:36.812168Z","end":"2026-04-07T09:51:36.987488Z","steps":["trace[1370678767] 'process raft request' (duration: 175.218206ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:36.987589Z","caller":"traceutil/trace.go:171","msg":"trace[442336685] transaction","detail":"{read_only:false; response_revision:5063; number_of_response:1; }","duration":"179.857505ms","start":"2026-04-07T09:51:36.80767Z","end":"2026-04-07T09:51:36.987528Z","steps":["trace[442336685] 'process raft request' (duration: 179.590879ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:48.986774Z","caller":"traceutil/trace.go:171","msg":"trace[1824314573] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"105.322409ms","start":"2026-04-07T09:51:48.881415Z","end":"2026-04-07T09:51:48.986738Z","steps":["trace[1824314573] 'process raft request' (duration: 105.006842ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:48.998298Z","caller":"traceutil/trace.go:171","msg":"trace[1477043671] transaction","detail":"{read_only:false; response_revision:5302; number_of_response:1; }","duration":"101.053328ms","start":"2026-04-07T09:51:48.897217Z","end":"2026-04-07T09:51:48.998271Z","steps":["trace[1477043671] 'process raft request' (duration: 100.763531ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:49.116977Z","caller":"traceutil/trace.go:171","msg":"trace[1607117712] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"124.71594ms","start":"2026-04-07T09:51:48.992234Z","end":"2026-04-07T09:51:49.11695Z","steps":["trace[1607117712] 'process raft request' (duration: 48.01316ms)","trace[1607117712] 'compare' (duration: 76.392673ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:49.11716Z","caller":"traceutil/trace.go:171","msg":"trace[396446618] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"124.362332ms","start":"2026-04-07T09:51:48.992768Z","end":"2026-04-07T09:51:49.117131Z","steps":["trace[396446618] 'process raft request' (duration: 124.115026ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:49.117307Z","caller":"traceutil/trace.go:171","msg":"trace[15795612] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"123.84872ms","start":"2026-04-07T09:51:48.993444Z","end":"2026-04-07T09:51:49.117293Z","steps":["trace[15795612] 'process raft request' (duration: 123.645185ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:49.117534Z","caller":"traceutil/trace.go:171","msg":"trace[1302959000] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"124.7261ms","start":"2026-04-07T09:51:48.992796Z","end":"2026-04-07T09:51:49.117522Z","steps":["trace[1302959000] 'process raft request' (duration: 124.223718ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:49.117676Z","caller":"traceutil/trace.go:171","msg":"trace[1480040509] linearizableReadLoop","detail":"{readStateIndex:5508; appliedIndex:5504; }","duration":"119.483415ms","start":"2026-04-07T09:51:48.998181Z","end":"2026-04-07T09:51:49.117665Z","steps":["trace[1480040509] 'read index received' (duration: 42.039967ms)","trace[1480040509] 'applied index is now lower than readState.Index' (duration: 77.442238ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:51:49.117884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.748735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-d7wrc\" ","response":"range_response_count:1 size:9901"} {"level":"info","ts":"2026-04-07T09:51:49.118042Z","caller":"traceutil/trace.go:171","msg":"trace[487094768] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-d7wrc; range_end:; response_count:1; response_revision:5307; }","duration":"125.906778ms","start":"2026-04-07T09:51:48.992058Z","end":"2026-04-07T09:51:49.117965Z","steps":["trace[487094768] 'agreement among raft nodes before linearized reading' (duration: 125.656633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:49.130649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.244354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:51:49.130844Z","caller":"traceutil/trace.go:171","msg":"trace[675333525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5308; }","duration":"131.47257ms","start":"2026-04-07T09:51:48.999341Z","end":"2026-04-07T09:51:49.130814Z","steps":["trace[675333525] 'agreement among raft nodes before linearized reading' (duration: 130.675911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:56.575775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.511759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:51:56.575931Z","caller":"traceutil/trace.go:171","msg":"trace[1607099419] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"201.077312ms","start":"2026-04-07T09:51:56.374827Z","end":"2026-04-07T09:51:56.575904Z","steps":["trace[1607099419] 'process raft request' (duration: 16.328268ms)","trace[1607099419] 'compare' (duration: 184.347045ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:56.808537Z","caller":"traceutil/trace.go:171","msg":"trace[60510384] transaction","detail":"{read_only:false; response_revision:5433; number_of_response:1; }","duration":"432.822362ms","start":"2026-04-07T09:51:56.375692Z","end":"2026-04-07T09:51:56.808514Z","steps":["trace[60510384] 'process raft request' (duration: 432.73569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:56.80869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:51:56.375664Z","time spent":"432.949825ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:51:56.808816Z","caller":"traceutil/trace.go:171","msg":"trace[341067400] transaction","detail":"{read_only:false; response_revision:5434; number_of_response:1; }","duration":"186.416154ms","start":"2026-04-07T09:51:56.622374Z","end":"2026-04-07T09:51:56.80879Z","steps":["trace[341067400] 'process raft request' (duration: 186.105717ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:56.808884Z","caller":"traceutil/trace.go:171","msg":"trace[1929424836] transaction","detail":"{read_only:false; response_revision:5431; number_of_response:1; }","duration":"433.694433ms","start":"2026-04-07T09:51:56.375158Z","end":"2026-04-07T09:51:56.808852Z","steps":["trace[1929424836] 'process raft request' (duration: 433.128359ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:56.808945Z","caller":"traceutil/trace.go:171","msg":"trace[246072943] transaction","detail":"{read_only:false; response_revision:5432; number_of_response:1; }","duration":"433.722524ms","start":"2026-04-07T09:51:56.375206Z","end":"2026-04-07T09:51:56.808928Z","steps":["trace[246072943] 'process raft request' (duration: 433.15205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:56.809042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:51:56.375186Z","time spent":"433.808525ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:51:56.809087Z","caller":"traceutil/trace.go:171","msg":"trace[737754668] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"434.248886ms","start":"2026-04-07T09:51:56.37483Z","end":"2026-04-07T09:51:56.809079Z","steps":["trace[737754668] 'process raft request' (duration: 341.342761ms)","trace[737754668] 'compare' (duration: 91.662196ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:51:56.809123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:51:56.374792Z","time spent":"434.311148ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:51:56.809055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:51:56.37514Z","time spent":"433.820835ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:52:09.02503Z","caller":"traceutil/trace.go:171","msg":"trace[1688048773] transaction","detail":"{read_only:false; response_revision:5617; number_of_response:1; }","duration":"114.941517ms","start":"2026-04-07T09:52:08.910059Z","end":"2026-04-07T09:52:09.025Z","steps":["trace[1688048773] 'process raft request' (duration: 114.677581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:52:47.416377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.005347ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:52:47.416565Z","caller":"traceutil/trace.go:171","msg":"trace[1433680389] transaction","detail":"{read_only:false; response_revision:5962; number_of_response:1; }","duration":"106.775825ms","start":"2026-04-07T09:52:47.309775Z","end":"2026-04-07T09:52:47.41655Z","steps":["trace[1433680389] 'process raft request' (duration: 106.706793ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:47.416615Z","caller":"traceutil/trace.go:171","msg":"trace[850937720] transaction","detail":"{read_only:false; response_revision:5961; number_of_response:1; }","duration":"117.433797ms","start":"2026-04-07T09:52:47.299141Z","end":"2026-04-07T09:52:47.416575Z","steps":["trace[850937720] 'process raft request' (duration: 16.149693ms)","trace[850937720] 'compare' (duration: 100.898535ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:52:55.458015Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2985} {"level":"info","ts":"2026-04-07T09:52:55.530422Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2985,"took":"71.16815ms","hash":1110515820,"current-db-size-bytes":57991168,"current-db-size":"58 MB","current-db-size-in-use-bytes":33312768,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-07T09:52:55.530487Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1110515820,"revision":2985,"compact-revision":-1} {"level":"info","ts":"2026-04-07T09:57:55.468237Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6039} {"level":"info","ts":"2026-04-07T09:57:55.569283Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6039,"took":"98.612347ms","hash":2562281317,"current-db-size-bytes":57991168,"current-db-size":"58 MB","current-db-size-in-use-bytes":21266432,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-07T09:57:55.569367Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2562281317,"revision":6039,"compact-revision":2985} {"level":"warn","ts":"2026-04-07T09:58:16.947312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.588232ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:58:16.947737Z","caller":"traceutil/trace.go:171","msg":"trace[1015038004] transaction","detail":"{read_only:false; response_revision:8365; number_of_response:1; }","duration":"276.929141ms","start":"2026-04-07T09:58:16.67073Z","end":"2026-04-07T09:58:16.947659Z","steps":["trace[1015038004] 'process raft request' (duration: 97.8986ms)","trace[1015038004] 'compare' (duration: 177.185988ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:58:16.94818Z","caller":"traceutil/trace.go:171","msg":"trace[1369565772] linearizableReadLoop","detail":"{readStateIndex:8663; appliedIndex:8661; }","duration":"166.31142ms","start":"2026-04-07T09:58:16.781853Z","end":"2026-04-07T09:58:16.948164Z","steps":["trace[1369565772] 'read index received' (duration: 59.261µs)","trace[1369565772] 'applied index is now lower than readState.Index' (duration: 166.251089ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:58:16.948281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.425123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:58:16.948303Z","caller":"traceutil/trace.go:171","msg":"trace[549094684] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:8366; }","duration":"166.494685ms","start":"2026-04-07T09:58:16.781798Z","end":"2026-04-07T09:58:16.948293Z","steps":["trace[549094684] 'agreement among raft nodes before linearized reading' (duration: 166.418093ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:16.94838Z","caller":"traceutil/trace.go:171","msg":"trace[1933439886] transaction","detail":"{read_only:false; response_revision:8366; number_of_response:1; }","duration":"277.493084ms","start":"2026-04-07T09:58:16.670835Z","end":"2026-04-07T09:58:16.948328Z","steps":["trace[1933439886] 'process raft request' (duration: 276.659304ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:18.739979Z","caller":"traceutil/trace.go:171","msg":"trace[1762427021] transaction","detail":"{read_only:false; response_revision:8373; number_of_response:1; }","duration":"150.286821ms","start":"2026-04-07T09:58:18.589624Z","end":"2026-04-07T09:58:18.739911Z","steps":["trace[1762427021] 'process raft request' (duration: 85.703061ms)","trace[1762427021] 'compare' (duration: 64.291533ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:58:19.136967Z","caller":"traceutil/trace.go:171","msg":"trace[396102748] linearizableReadLoop","detail":"{readStateIndex:8675; appliedIndex:8674; }","duration":"144.35176ms","start":"2026-04-07T09:58:18.992582Z","end":"2026-04-07T09:58:19.136934Z","steps":["trace[396102748] 'read index received' (duration: 133.37852ms)","trace[396102748] 'applied index is now lower than readState.Index' (duration: 10.97212ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:58:19.137027Z","caller":"traceutil/trace.go:171","msg":"trace[304274734] transaction","detail":"{read_only:false; response_revision:8377; number_of_response:1; }","duration":"177.454654ms","start":"2026-04-07T09:58:18.959531Z","end":"2026-04-07T09:58:19.136986Z","steps":["trace[304274734] 'process raft request' (duration: 166.457233ms)","trace[304274734] 'compare' (duration: 10.793436ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:58:19.137173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.571616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:58:19.137235Z","caller":"traceutil/trace.go:171","msg":"trace[1618960055] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:8377; }","duration":"144.700899ms","start":"2026-04-07T09:58:18.992521Z","end":"2026-04-07T09:58:19.137222Z","steps":["trace[1618960055] 'agreement among raft nodes before linearized reading' (duration: 144.535435ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:45.51539Z","caller":"traceutil/trace.go:171","msg":"trace[610327659] transaction","detail":"{read_only:false; response_revision:8571; number_of_response:1; }","duration":"374.391451ms","start":"2026-04-07T09:58:45.140971Z","end":"2026-04-07T09:58:45.515363Z","steps":["trace[610327659] 'process raft request' (duration: 374.211437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:45.515578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:58:45.140945Z","time spent":"374.544205ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:58:45.520495Z","caller":"traceutil/trace.go:171","msg":"trace[1401711535] linearizableReadLoop","detail":"{readStateIndex:8877; appliedIndex:8875; }","duration":"163.814411ms","start":"2026-04-07T09:58:45.356628Z","end":"2026-04-07T09:58:45.520442Z","steps":["trace[1401711535] 'read index received' (duration: 158.629258ms)","trace[1401711535] 'applied index is now lower than readState.Index' (duration: 5.184083ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:58:45.520684Z","caller":"traceutil/trace.go:171","msg":"trace[216888381] transaction","detail":"{read_only:false; response_revision:8572; number_of_response:1; }","duration":"168.965294ms","start":"2026-04-07T09:58:45.351706Z","end":"2026-04-07T09:58:45.520671Z","steps":["trace[216888381] 'process raft request' (duration: 168.432911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:45.520879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.74597ms","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:58:45.520995Z","caller":"traceutil/trace.go:171","msg":"trace[904893189] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8572; }","duration":"163.918034ms","start":"2026-04-07T09:58:45.35705Z","end":"2026-04-07T09:58:45.520968Z","steps":["trace[904893189] 'agreement among raft nodes before linearized reading' (duration: 163.642537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:45.521187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.557869ms","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:58:45.521246Z","caller":"traceutil/trace.go:171","msg":"trace[766246799] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8572; }","duration":"164.611621ms","start":"2026-04-07T09:58:45.356618Z","end":"2026-04-07T09:58:45.52123Z","steps":["trace[766246799] 'agreement among raft nodes before linearized reading' (duration: 164.499928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:45.521482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.327229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-07T09:58:45.521511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.403248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-07T09:58:45.521572Z","caller":"traceutil/trace.go:171","msg":"trace[122549689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8572; }","duration":"162.48236ms","start":"2026-04-07T09:58:45.359074Z","end":"2026-04-07T09:58:45.521557Z","steps":["trace[122549689] 'agreement among raft nodes before linearized reading' (duration: 162.338726ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:45.521554Z","caller":"traceutil/trace.go:171","msg":"trace[33789141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8572; }","duration":"133.455602ms","start":"2026-04-07T09:58:45.388085Z","end":"2026-04-07T09:58:45.521541Z","steps":["trace[33789141] 'agreement among raft nodes before linearized reading' (duration: 133.291018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:45.521675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.084059ms","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:58:45.521779Z","caller":"traceutil/trace.go:171","msg":"trace[304840147] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8572; }","duration":"129.218241ms","start":"2026-04-07T09:58:45.392496Z","end":"2026-04-07T09:58:45.521714Z","steps":["trace[304840147] 'agreement among raft nodes before linearized reading' (duration: 128.958005ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:45.825479Z","caller":"traceutil/trace.go:171","msg":"trace[337140421] transaction","detail":"{read_only:false; response_revision:8575; number_of_response:1; }","duration":"299.500047ms","start":"2026-04-07T09:58:45.525945Z","end":"2026-04-07T09:58:45.825445Z","steps":["trace[337140421] 'process raft request' (duration: 299.397214ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:45.825486Z","caller":"traceutil/trace.go:171","msg":"trace[647456084] transaction","detail":"{read_only:false; response_revision:8574; number_of_response:1; }","duration":"299.626629ms","start":"2026-04-07T09:58:45.525807Z","end":"2026-04-07T09:58:45.825434Z","steps":["trace[647456084] 'process raft request' (duration: 299.338643ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:45.825793Z","caller":"traceutil/trace.go:171","msg":"trace[763409117] linearizableReadLoop","detail":"{readStateIndex:8882; appliedIndex:8878; }","duration":"202.361154ms","start":"2026-04-07T09:58:45.623412Z","end":"2026-04-07T09:58:45.825773Z","steps":["trace[763409117] 'read index received' (duration: 201.650278ms)","trace[763409117] 'applied index is now lower than readState.Index' (duration: 710.326µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:58:45.825805Z","caller":"traceutil/trace.go:171","msg":"trace[1380142142] transaction","detail":"{read_only:false; response_revision:8576; number_of_response:1; }","duration":"299.729331ms","start":"2026-04-07T09:58:45.526037Z","end":"2026-04-07T09:58:45.825766Z","steps":["trace[1380142142] 'process raft request' (duration: 299.359713ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:45.825837Z","caller":"traceutil/trace.go:171","msg":"trace[509793025] transaction","detail":"{read_only:false; response_revision:8577; number_of_response:1; }","duration":"299.741452ms","start":"2026-04-07T09:58:45.526057Z","end":"2026-04-07T09:58:45.825798Z","steps":["trace[509793025] 'process raft request' (duration: 299.575918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:45.825987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.865141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m5zdb\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-07T09:58:45.825984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.542979ms","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:58:45.826015Z","caller":"traceutil/trace.go:171","msg":"trace[1677503214] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m5zdb; range_end:; response_count:1; response_revision:8577; }","duration":"130.966713ms","start":"2026-04-07T09:58:45.695039Z","end":"2026-04-07T09:58:45.826006Z","steps":["trace[1677503214] 'agreement among raft nodes before linearized reading' (duration: 130.84498ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:45.826045Z","caller":"traceutil/trace.go:171","msg":"trace[263808323] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:8577; }","duration":"202.683292ms","start":"2026-04-07T09:58:45.623344Z","end":"2026-04-07T09:58:45.826027Z","steps":["trace[263808323] 'agreement among raft nodes before linearized reading' (duration: 202.528199ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:49.651551Z","caller":"traceutil/trace.go:171","msg":"trace[1933168018] transaction","detail":"{read_only:false; response_revision:8591; number_of_response:1; }","duration":"117.641367ms","start":"2026-04-07T09:58:49.533889Z","end":"2026-04-07T09:58:49.65153Z","steps":["trace[1933168018] 'process raft request' (duration: 117.495944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:49.969791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.725757ms","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:58:49.969977Z","caller":"traceutil/trace.go:171","msg":"trace[1579036585] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8591; }","duration":"157.931192ms","start":"2026-04-07T09:58:49.812024Z","end":"2026-04-07T09:58:49.969955Z","steps":["trace[1579036585] 'range keys from in-memory index tree' (duration: 157.699976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:49.970096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.856236ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:58:49.970307Z","caller":"traceutil/trace.go:171","msg":"trace[461203158] linearizableReadLoop","detail":"{readStateIndex:8898; appliedIndex:8896; }","duration":"405.627499ms","start":"2026-04-07T09:58:49.564651Z","end":"2026-04-07T09:58:49.970278Z","steps":["trace[461203158] 'read index received' (duration: 86.750585ms)","trace[461203158] 'applied index is now lower than readState.Index' (duration: 318.873764ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:58:49.970336Z","caller":"traceutil/trace.go:171","msg":"trace[519790042] transaction","detail":"{read_only:false; response_revision:8593; number_of_response:1; }","duration":"200.656293ms","start":"2026-04-07T09:58:49.769653Z","end":"2026-04-07T09:58:49.970309Z","steps":["trace[519790042] 'process raft request' (duration: 200.561121ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:49.970336Z","caller":"traceutil/trace.go:171","msg":"trace[1022589377] transaction","detail":"{read_only:false; response_revision:8592; number_of_response:1; }","duration":"434.825671ms","start":"2026-04-07T09:58:49.535458Z","end":"2026-04-07T09:58:49.970284Z","steps":["trace[1022589377] 'process raft request' (duration: 296.666208ms)","trace[1022589377] 'compare' (duration: 137.738583ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:58:49.970543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.877952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m5zdb\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-07T09:58:49.970578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.271293ms","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:58:49.970583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.667342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-07T09:58:49.97059Z","caller":"traceutil/trace.go:171","msg":"trace[1815216517] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m5zdb; range_end:; response_count:1; response_revision:8593; }","duration":"106.939423ms","start":"2026-04-07T09:58:49.86364Z","end":"2026-04-07T09:58:49.970579Z","steps":["trace[1815216517] 'agreement among raft nodes before linearized reading' (duration: 106.833401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:49.970596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.025231ms","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:58:49.970605Z","caller":"traceutil/trace.go:171","msg":"trace[1034243444] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8593; }","duration":"129.315514ms","start":"2026-04-07T09:58:49.841281Z","end":"2026-04-07T09:58:49.970597Z","steps":["trace[1034243444] 'agreement among raft nodes before linearized reading' (duration: 129.180131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:49.970587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:58:49.535429Z","time spent":"435.010526ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:58:49.970621Z","caller":"traceutil/trace.go:171","msg":"trace[1321188229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8593; }","duration":"129.731944ms","start":"2026-04-07T09:58:49.84088Z","end":"2026-04-07T09:58:49.970612Z","steps":["trace[1321188229] 'agreement among raft nodes before linearized reading' (duration: 129.586371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:49.970581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.913117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-07T09:58:49.970632Z","caller":"traceutil/trace.go:171","msg":"trace[5565651] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8593; }","duration":"130.128513ms","start":"2026-04-07T09:58:49.840495Z","end":"2026-04-07T09:58:49.970623Z","steps":["trace[5565651] 'agreement among raft nodes before linearized reading' (duration: 129.933149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:49.970632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.864942ms","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:58:49.970675Z","caller":"traceutil/trace.go:171","msg":"trace[314510799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8593; }","duration":"406.042149ms","start":"2026-04-07T09:58:49.564612Z","end":"2026-04-07T09:58:49.970654Z","steps":["trace[314510799] 'agreement among raft nodes before linearized reading' (duration: 405.781413ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:49.970712Z","caller":"traceutil/trace.go:171","msg":"trace[884089263] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8593; }","duration":"125.978035ms","start":"2026-04-07T09:58:49.84471Z","end":"2026-04-07T09:58:49.970688Z","steps":["trace[884089263] 'agreement among raft nodes before linearized reading' (duration: 125.737869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:49.970722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:58:49.564598Z","time spent":"406.115611ms","remote":"127.0.0.1:41530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T09:58:59.787301Z","caller":"traceutil/trace.go:171","msg":"trace[2130150942] transaction","detail":"{read_only:false; response_revision:8689; number_of_response:1; }","duration":"144.664248ms","start":"2026-04-07T09:58:59.642607Z","end":"2026-04-07T09:58:59.787271Z","steps":["trace[2130150942] 'process raft request' (duration: 143.770817ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:59:00.845906Z","caller":"traceutil/trace.go:171","msg":"trace[613650803] linearizableReadLoop","detail":"{readStateIndex:9010; appliedIndex:9009; }","duration":"366.923793ms","start":"2026-04-07T09:59:00.478955Z","end":"2026-04-07T09:59:00.845878Z","steps":["trace[613650803] 'read index received' (duration: 366.615886ms)","trace[613650803] 'applied index is now lower than readState.Index' (duration: 306.177µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:59:00.846039Z","caller":"traceutil/trace.go:171","msg":"trace[374607615] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"376.984411ms","start":"2026-04-07T09:59:00.469019Z","end":"2026-04-07T09:59:00.846003Z","steps":["trace[374607615] 'process raft request' (duration: 376.654603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:59:00.846098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.112677ms","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:59:00.846139Z","caller":"traceutil/trace.go:171","msg":"trace[683956069] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8700; }","duration":"367.21602ms","start":"2026-04-07T09:59:00.47891Z","end":"2026-04-07T09:59:00.846126Z","steps":["trace[683956069] 'agreement among raft nodes before linearized reading' (duration: 367.075547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:59:00.846182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:59:00.478894Z","time spent":"367.276381ms","remote":"127.0.0.1:49802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:59:00.846232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:59:00.468995Z","time spent":"377.142845ms","remote":"127.0.0.1:41452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19323,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:59:50.703973Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024ef.wal"} {"level":"info","ts":"2026-04-07T10:00:58.761856Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a31e123290fcf0df","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T10:00:58.768543Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T10:00:58.768716Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T10:02:55.474528Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8126} {"level":"info","ts":"2026-04-07T10:02:55.53638Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8126,"took":"58.903071ms","hash":990782568,"current-db-size-bytes":57991168,"current-db-size":"58 MB","current-db-size-in-use-bytes":27648000,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-07T10:02:55.536461Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":990782568,"revision":8126,"compact-revision":6039} {"level":"info","ts":"2026-04-07T10:07:55.482126Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10400} {"level":"info","ts":"2026-04-07T10:07:55.564523Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10400,"took":"79.495634ms","hash":1386349848,"current-db-size-bytes":57991168,"current-db-size":"58 MB","current-db-size-in-use-bytes":22106112,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-07T10:07:55.564594Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1386349848,"revision":10400,"compact-revision":8126}