{"level":"warn","ts":"2026-04-17T18:44:45.279048Z","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-17T18:44:45.279152Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.168: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.19.213.168:2380","--initial-cluster=instance=https://199.19.213.168:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.168:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.168: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-17T18:44:45.279229Z","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-17T18:44:45.279246Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.168:2380"]} {"level":"info","ts":"2026-04-17T18:44:45.27927Z","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-17T18:44:45.279978Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.168:2379"]} {"level":"info","ts":"2026-04-17T18:44:45.280064Z","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.19.213.168:2380"],"listen-peer-urls":["https://199.19.213.168:2380"],"advertise-client-urls":["https://199.19.213.168:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.168:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.168: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-17T18:44:45.283443Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.150106ms"} {"level":"info","ts":"2026-04-17T18:44:45.294032Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8ae391decac9b376","cluster-id":"d9b32c15a2c66ac"} {"level":"info","ts":"2026-04-17T18:44:45.294154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T18:44:45.294182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became follower at term 0"} {"level":"info","ts":"2026-04-17T18:44:45.294202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8ae391decac9b376 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T18:44:45.294219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became follower at term 1"} {"level":"info","ts":"2026-04-17T18:44:45.294277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 switched to configuration voters=(10008003183018357622)"} {"level":"warn","ts":"2026-04-17T18:44:45.302369Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T18:44:45.304351Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T18:44:45.305827Z","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-17T18:44:45.309216Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8ae391decac9b376","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T18:44:45.309507Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8ae391decac9b376","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T18:44:45.309591Z","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-17T18:44:45.309619Z","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-17T18:44:45.30963Z","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-17T18:44:45.311085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 switched to configuration voters=(10008003183018357622)"} {"level":"info","ts":"2026-04-17T18:44:45.311548Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d9b32c15a2c66ac","local-member-id":"8ae391decac9b376","added-peer-id":"8ae391decac9b376","added-peer-peer-urls":["https://199.19.213.168:2380"]} {"level":"info","ts":"2026-04-17T18:44:45.314232Z","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-17T18:44:45.314503Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8ae391decac9b376","initial-advertise-peer-urls":["https://199.19.213.168:2380"],"listen-peer-urls":["https://199.19.213.168:2380"],"advertise-client-urls":["https://199.19.213.168:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.168:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T18:44:45.314553Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T18:44:45.314615Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.168:2380"} {"level":"info","ts":"2026-04-17T18:44:45.314643Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.168:2380"} {"level":"info","ts":"2026-04-17T18:44:46.095397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T18:44:46.095516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T18:44:46.095553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 received MsgPreVoteResp from 8ae391decac9b376 at term 1"} {"level":"info","ts":"2026-04-17T18:44:46.095579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became candidate at term 2"} {"level":"info","ts":"2026-04-17T18:44:46.09559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 received MsgVoteResp from 8ae391decac9b376 at term 2"} {"level":"info","ts":"2026-04-17T18:44:46.095609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8ae391decac9b376 became leader at term 2"} {"level":"info","ts":"2026-04-17T18:44:46.095624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8ae391decac9b376 elected leader 8ae391decac9b376 at term 2"} {"level":"info","ts":"2026-04-17T18:44:46.097066Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T18:44:46.098562Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T18:44:46.098559Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8ae391decac9b376","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.168:2379]}","request-path":"/0/members/8ae391decac9b376/attributes","cluster-id":"d9b32c15a2c66ac","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T18:44:46.098692Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T18:44:46.099019Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T18:44:46.099104Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T18:44:46.099115Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d9b32c15a2c66ac","local-member-id":"8ae391decac9b376","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T18:44:46.099231Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T18:44:46.099273Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T18:44:46.10139Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.168:2379"} {"level":"info","ts":"2026-04-17T18:44:46.102508Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T18:45:24.650129Z","caller":"traceutil/trace.go:171","msg":"trace[1299029413] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"119.995521ms","start":"2026-04-17T18:45:24.530112Z","end":"2026-04-17T18:45:24.650108Z","steps":["trace[1299029413] 'process raft request' (duration: 119.874718ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:25.058078Z","caller":"traceutil/trace.go:171","msg":"trace[743920805] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"272.855456ms","start":"2026-04-17T18:45:24.7852Z","end":"2026-04-17T18:45:25.058056Z","steps":["trace[743920805] 'read index received' (duration: 271.425576ms)","trace[743920805] 'applied index is now lower than readState.Index' (duration: 1.42875ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:45:25.058215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.001651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:45:25.058197Z","caller":"traceutil/trace.go:171","msg":"trace[631287003] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"333.14845ms","start":"2026-04-17T18:45:24.724993Z","end":"2026-04-17T18:45:25.058141Z","steps":["trace[631287003] 'process raft request' (duration: 332.525853ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:45:25.058273Z","caller":"traceutil/trace.go:171","msg":"trace[1789461781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"273.110024ms","start":"2026-04-17T18:45:24.785156Z","end":"2026-04-17T18:45:25.058266Z","steps":["trace[1789461781] 'agreement among raft nodes before linearized reading' (duration: 272.988561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:45:25.059001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:24.724953Z","time spent":"333.375937ms","remote":"127.0.0.1:39684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:45:25.585281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.088574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rqlth\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-17T18:45:25.585398Z","caller":"traceutil/trace.go:171","msg":"trace[1080389747] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rqlth; range_end:; response_count:1; response_revision:580; }","duration":"330.263349ms","start":"2026-04-17T18:45:25.255106Z","end":"2026-04-17T18:45:25.585369Z","steps":["trace[1080389747] 'range keys from in-memory index tree' (duration: 329.856318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:45:25.585455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:45:25.255085Z","time spent":"330.357173ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-rqlth\" "} {"level":"warn","ts":"2026-04-17T18:47:00.749432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.91324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:47:00.749536Z","caller":"traceutil/trace.go:171","msg":"trace[1003450682] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1840; }","duration":"212.107336ms","start":"2026-04-17T18:47:00.537409Z","end":"2026-04-17T18:47:00.749516Z","steps":["trace[1003450682] 'count revisions from in-memory index tree' (duration: 211.791766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:47:00.750036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.799509ms","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-17T18:47:00.750174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.369875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5b2846ec-f111-4111-aca2-0c2e96778c48\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-17T18:47:00.750248Z","caller":"traceutil/trace.go:171","msg":"trace[1780503130] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5b2846ec-f111-4111-aca2-0c2e96778c48; range_end:; response_count:1; response_revision:1840; }","duration":"257.474637ms","start":"2026-04-17T18:47:00.492755Z","end":"2026-04-17T18:47:00.75023Z","steps":["trace[1780503130] 'range keys from in-memory index tree' (duration: 256.83787ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:47:00.75034Z","caller":"traceutil/trace.go:171","msg":"trace[2097560016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1840; }","duration":"232.084657ms","start":"2026-04-17T18:47:00.518131Z","end":"2026-04-17T18:47:00.750216Z","steps":["trace[2097560016] 'range keys from in-memory index tree' (duration: 231.48486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:47:00.750086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.865036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T18:47:00.750839Z","caller":"traceutil/trace.go:171","msg":"trace[213676484] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1840; }","duration":"188.654888ms","start":"2026-04-17T18:47:00.562154Z","end":"2026-04-17T18:47:00.750808Z","steps":["trace[213676484] 'range keys from in-memory index tree' (duration: 187.499946ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:47:13.446565Z","caller":"traceutil/trace.go:171","msg":"trace[1093120608] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"101.132081ms","start":"2026-04-17T18:47:13.345401Z","end":"2026-04-17T18:47:13.446533Z","steps":["trace[1093120608] 'process raft request' (duration: 100.904475ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:47:49.847369Z","caller":"traceutil/trace.go:171","msg":"trace[1811492042] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"133.025824ms","start":"2026-04-17T18:47:49.714302Z","end":"2026-04-17T18:47:49.847328Z","steps":["trace[1811492042] 'process raft request' (duration: 132.754527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:47:56.060496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.784674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-17T18:47:56.060637Z","caller":"traceutil/trace.go:171","msg":"trace[1185274278] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2186; }","duration":"172.36062ms","start":"2026-04-17T18:47:55.888251Z","end":"2026-04-17T18:47:56.060612Z","steps":["trace[1185274278] 'range keys from in-memory index tree' (duration: 171.588079ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:47:56.346199Z","caller":"traceutil/trace.go:171","msg":"trace[1831139874] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"344.692681ms","start":"2026-04-17T18:47:56.001464Z","end":"2026-04-17T18:47:56.346156Z","steps":["trace[1831139874] 'process raft request' (duration: 344.381873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:47:56.346415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:47:56.001427Z","time spent":"344.886347ms","remote":"127.0.0.1:39768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:47:56.497614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.794004ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T18:47:56.498088Z","caller":"traceutil/trace.go:171","msg":"trace[243907043] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"432.488236ms","start":"2026-04-17T18:47:56.065572Z","end":"2026-04-17T18:47:56.49806Z","steps":["trace[243907043] 'process raft request' (duration: 432.2815ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:47:56.498117Z","caller":"traceutil/trace.go:171","msg":"trace[1685392003] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"446.955625ms","start":"2026-04-17T18:47:56.05099Z","end":"2026-04-17T18:47:56.497945Z","steps":["trace[1685392003] 'process raft request' (duration: 328.528464ms)","trace[1685392003] 'compare' (duration: 117.66926ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:47:56.498282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:47:56.065546Z","time spent":"432.676861ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:47:56.498447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:47:56.050962Z","time spent":"447.375317ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T18:54:46.122207Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2752} {"level":"info","ts":"2026-04-17T18:54:46.191135Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2752,"took":"67.911405ms","hash":2246540539,"current-db-size-bytes":33136640,"current-db-size":"33 MB","current-db-size-in-use-bytes":8372224,"current-db-size-in-use":"8.4 MB"} {"level":"info","ts":"2026-04-17T18:54:46.191211Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2246540539,"revision":2752,"compact-revision":-1} {"level":"info","ts":"2026-04-17T18:58:09.661791Z","caller":"traceutil/trace.go:171","msg":"trace[263108596] linearizableReadLoop","detail":"{readStateIndex:5520; appliedIndex:5519; }","duration":"264.227386ms","start":"2026-04-17T18:58:09.397529Z","end":"2026-04-17T18:58:09.661756Z","steps":["trace[263108596] 'read index received' (duration: 263.935728ms)","trace[263108596] 'applied index is now lower than readState.Index' (duration: 290.438µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:09.661873Z","caller":"traceutil/trace.go:171","msg":"trace[785829636] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"287.349243ms","start":"2026-04-17T18:58:09.374484Z","end":"2026-04-17T18:58:09.661833Z","steps":["trace[785829636] 'process raft request' (duration: 287.066465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:09.662139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.525344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.168\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-17T18:58:09.662228Z","caller":"traceutil/trace.go:171","msg":"trace[171350642] range","detail":"{range_begin:/registry/masterleases/199.19.213.168; range_end:; response_count:1; response_revision:5308; }","duration":"264.726829ms","start":"2026-04-17T18:58:09.397486Z","end":"2026-04-17T18:58:09.662213Z","steps":["trace[171350642] 'agreement among raft nodes before linearized reading' (duration: 264.420881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:09.968705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.638231ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-17T18:58:09.968825Z","caller":"traceutil/trace.go:171","msg":"trace[171511745] linearizableReadLoop","detail":"{readStateIndex:5521; appliedIndex:5520; }","duration":"300.019913ms","start":"2026-04-17T18:58:09.668784Z","end":"2026-04-17T18:58:09.968804Z","steps":["trace[171511745] 'read index received' (duration: 136.275438ms)","trace[171511745] 'applied index is now lower than readState.Index' (duration: 163.742845ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:09.968884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:09.66426Z","time spent":"304.611479ms","remote":"127.0.0.1:39622","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-17T18:58:09.969052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.267399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-17T18:58:09.969095Z","caller":"traceutil/trace.go:171","msg":"trace[1103668622] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5308; }","duration":"300.336151ms","start":"2026-04-17T18:58:09.668747Z","end":"2026-04-17T18:58:09.969083Z","steps":["trace[1103668622] 'agreement among raft nodes before linearized reading' (duration: 300.151536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:09.96913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:09.668728Z","time spent":"300.394442ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T18:58:09.969391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.371299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-17T18:58:09.969454Z","caller":"traceutil/trace.go:171","msg":"trace[1434805894] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5308; }","duration":"297.450611ms","start":"2026-04-17T18:58:09.671989Z","end":"2026-04-17T18:58:09.96944Z","steps":["trace[1434805894] 'agreement among raft nodes before linearized reading' (duration: 297.303657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:10.243125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.413101ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T18:58:10.243559Z","caller":"traceutil/trace.go:171","msg":"trace[1909787628] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"269.433758ms","start":"2026-04-17T18:58:09.974095Z","end":"2026-04-17T18:58:10.243529Z","steps":["trace[1909787628] 'process raft request' (duration: 269.152021ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:10.243542Z","caller":"traceutil/trace.go:171","msg":"trace[315176024] transaction","detail":"{read_only:false; response_revision:5311; number_of_response:1; }","duration":"269.027577ms","start":"2026-04-17T18:58:09.974469Z","end":"2026-04-17T18:58:10.243496Z","steps":["trace[315176024] 'process raft request' (duration: 268.883233ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:10.243615Z","caller":"traceutil/trace.go:171","msg":"trace[1195729571] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"272.831822ms","start":"2026-04-17T18:58:09.970725Z","end":"2026-04-17T18:58:10.243557Z","steps":["trace[1195729571] 'process raft request' (duration: 131.819684ms)","trace[1195729571] 'compare' (duration: 140.160595ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:10.423174Z","caller":"traceutil/trace.go:171","msg":"trace[1874594054] linearizableReadLoop","detail":"{readStateIndex:5526; appliedIndex:5525; }","duration":"173.464533ms","start":"2026-04-17T18:58:10.249684Z","end":"2026-04-17T18:58:10.423149Z","steps":["trace[1874594054] 'read index received' (duration: 12.529015ms)","trace[1874594054] 'applied index is now lower than readState.Index' (duration: 160.934358ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:10.423316Z","caller":"traceutil/trace.go:171","msg":"trace[1710517235] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"174.334657ms","start":"2026-04-17T18:58:10.248942Z","end":"2026-04-17T18:58:10.423276Z","steps":["trace[1710517235] 'process raft request' (duration: 174.025919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:10.42341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.703199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-17T18:58:10.423455Z","caller":"traceutil/trace.go:171","msg":"trace[267559317] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:5313; }","duration":"173.844894ms","start":"2026-04-17T18:58:10.249599Z","end":"2026-04-17T18:58:10.423444Z","steps":["trace[267559317] 'agreement among raft nodes before linearized reading' (duration: 173.657749ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:10.83455Z","caller":"traceutil/trace.go:171","msg":"trace[530514321] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"135.256259ms","start":"2026-04-17T18:58:10.699253Z","end":"2026-04-17T18:58:10.834509Z","steps":["trace[530514321] 'process raft request' (duration: 135.172216ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:10.834572Z","caller":"traceutil/trace.go:171","msg":"trace[1023021481] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"135.275969ms","start":"2026-04-17T18:58:10.699254Z","end":"2026-04-17T18:58:10.83453Z","steps":["trace[1023021481] 'process raft request' (duration: 134.93226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:11.234401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.525472ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T18:58:11.234645Z","caller":"traceutil/trace.go:171","msg":"trace[1712814977] linearizableReadLoop","detail":"{readStateIndex:5529; appliedIndex:5526; }","duration":"450.45127ms","start":"2026-04-17T18:58:10.784168Z","end":"2026-04-17T18:58:11.234619Z","steps":["trace[1712814977] 'read index received' (duration: 49.993508ms)","trace[1712814977] 'applied index is now lower than readState.Index' (duration: 400.455982ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:11.234736Z","caller":"traceutil/trace.go:171","msg":"trace[1896881022] transaction","detail":"{read_only:false; response_revision:5317; number_of_response:1; }","duration":"409.06924ms","start":"2026-04-17T18:58:10.825636Z","end":"2026-04-17T18:58:11.234705Z","steps":["trace[1896881022] 'process raft request' (duration: 408.885545ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:11.234741Z","caller":"traceutil/trace.go:171","msg":"trace[1684525215] transaction","detail":"{read_only:false; response_revision:5316; number_of_response:1; }","duration":"532.78505ms","start":"2026-04-17T18:58:10.701909Z","end":"2026-04-17T18:58:11.234694Z","steps":["trace[1684525215] 'process raft request' (duration: 266.822347ms)","trace[1684525215] 'compare' (duration: 265.358877ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:11.234906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.054265ms","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-17T18:58:11.23487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.672666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:58:11.234974Z","caller":"traceutil/trace.go:171","msg":"trace[1960734135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5317; }","duration":"345.189658ms","start":"2026-04-17T18:58:10.889767Z","end":"2026-04-17T18:58:11.234957Z","steps":["trace[1960734135] 'agreement among raft nodes before linearized reading' (duration: 345.002283ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:11.235008Z","caller":"traceutil/trace.go:171","msg":"trace[572387305] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5317; }","duration":"450.857561ms","start":"2026-04-17T18:58:10.784117Z","end":"2026-04-17T18:58:11.234975Z","steps":["trace[572387305] 'agreement among raft nodes before linearized reading' (duration: 450.621705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:11.235026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:10.889731Z","time spent":"345.28238ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T18:58:11.234909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:10.825618Z","time spent":"409.201953ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:58:11.235016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:10.701869Z","time spent":"532.987746ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:58:11.23507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:10.784102Z","time spent":"450.959715ms","remote":"127.0.0.1:39592","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-17T18:58:11.400853Z","caller":"traceutil/trace.go:171","msg":"trace[467598996] linearizableReadLoop","detail":"{readStateIndex:5531; appliedIndex:5530; }","duration":"149.118451ms","start":"2026-04-17T18:58:11.251713Z","end":"2026-04-17T18:58:11.400831Z","steps":["trace[467598996] 'read index received' (duration: 148.906295ms)","trace[467598996] 'applied index is now lower than readState.Index' (duration: 211.396µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:11.400959Z","caller":"traceutil/trace.go:171","msg":"trace[1659670399] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"160.681381ms","start":"2026-04-17T18:58:11.240242Z","end":"2026-04-17T18:58:11.400923Z","steps":["trace[1659670399] 'process raft request' (duration: 160.448704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:11.401011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.288426ms","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-17T18:58:11.401046Z","caller":"traceutil/trace.go:171","msg":"trace[1901303411] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5318; }","duration":"149.363868ms","start":"2026-04-17T18:58:11.25167Z","end":"2026-04-17T18:58:11.401034Z","steps":["trace[1901303411] 'agreement among raft nodes before linearized reading' (duration: 149.249295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:12.762816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.426381ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T18:58:12.762957Z","caller":"traceutil/trace.go:171","msg":"trace[317607981] linearizableReadLoop","detail":"{readStateIndex:5533; appliedIndex:5531; }","duration":"496.169601ms","start":"2026-04-17T18:58:12.266762Z","end":"2026-04-17T18:58:12.762932Z","steps":["trace[317607981] 'read index received' (duration: 58.712259ms)","trace[317607981] 'applied index is now lower than readState.Index' (duration: 437.455462ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:12.762992Z","caller":"traceutil/trace.go:171","msg":"trace[1211244034] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"509.724324ms","start":"2026-04-17T18:58:12.253218Z","end":"2026-04-17T18:58:12.762942Z","steps":["trace[1211244034] 'process raft request' (duration: 208.045126ms)","trace[1211244034] 'compare' (duration: 301.268567ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:12.763133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.686789ms","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-17T18:58:12.763162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.399317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T18:58:12.763198Z","caller":"traceutil/trace.go:171","msg":"trace[556087048] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5320; }","duration":"354.787313ms","start":"2026-04-17T18:58:12.408384Z","end":"2026-04-17T18:58:12.763172Z","steps":["trace[556087048] 'agreement among raft nodes before linearized reading' (duration: 354.67719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:12.763207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:12.253191Z","time spent":"509.90408ms","remote":"127.0.0.1:39852","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-17T18:58:12.763243Z","caller":"traceutil/trace.go:171","msg":"trace[1155249500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5320; }","duration":"496.554931ms","start":"2026-04-17T18:58:12.26667Z","end":"2026-04-17T18:58:12.763225Z","steps":["trace[1155249500] 'agreement among raft nodes before linearized reading' (duration: 496.361636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:12.76326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:12.408355Z","time spent":"354.889786ms","remote":"127.0.0.1:37978","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":"warn","ts":"2026-04-17T18:58:12.763292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:12.266634Z","time spent":"496.650244ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T18:58:12.763496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.865231ms","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-17T18:58:12.763557Z","caller":"traceutil/trace.go:171","msg":"trace[1842848281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5320; }","duration":"335.983104ms","start":"2026-04-17T18:58:12.427555Z","end":"2026-04-17T18:58:12.763538Z","steps":["trace[1842848281] 'agreement among raft nodes before linearized reading' (duration: 335.794819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:12.763613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:12.427514Z","time spent":"336.087197ms","remote":"127.0.0.1:39852","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-17T18:58:12.939388Z","caller":"traceutil/trace.go:171","msg":"trace[1017646309] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"171.331184ms","start":"2026-04-17T18:58:12.768023Z","end":"2026-04-17T18:58:12.939354Z","steps":["trace[1017646309] 'process raft request' (duration: 127.873436ms)","trace[1017646309] 'compare' (duration: 43.290554ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:13.170269Z","caller":"traceutil/trace.go:171","msg":"trace[999833077] transaction","detail":"{read_only:false; response_revision:5323; number_of_response:1; }","duration":"329.959408ms","start":"2026-04-17T18:58:12.840266Z","end":"2026-04-17T18:58:13.170225Z","steps":["trace[999833077] 'process raft request' (duration: 329.849885ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:13.170358Z","caller":"traceutil/trace.go:171","msg":"trace[1535725611] transaction","detail":"{read_only:false; response_revision:5322; number_of_response:1; }","duration":"402.125878ms","start":"2026-04-17T18:58:12.768191Z","end":"2026-04-17T18:58:13.170317Z","steps":["trace[1535725611] 'process raft request' (duration: 314.037999ms)","trace[1535725611] 'compare' (duration: 87.675837ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:13.170523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:12.840237Z","time spent":"330.145043ms","remote":"127.0.0.1:39852","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-17T18:58:13.170694Z","caller":"traceutil/trace.go:171","msg":"trace[1772318330] transaction","detail":"{read_only:false; response_revision:5324; number_of_response:1; }","duration":"330.347278ms","start":"2026-04-17T18:58:12.840283Z","end":"2026-04-17T18:58:13.170631Z","steps":["trace[1772318330] 'process raft request' (duration: 329.886795ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:13.170683Z","caller":"traceutil/trace.go:171","msg":"trace[654223168] linearizableReadLoop","detail":"{readStateIndex:5535; appliedIndex:5533; }","duration":"385.849699ms","start":"2026-04-17T18:58:12.784795Z","end":"2026-04-17T18:58:13.170645Z","steps":["trace[654223168] 'read index received' (duration: 111.176315ms)","trace[654223168] 'applied index is now lower than readState.Index' (duration: 274.669843ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:13.170884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:12.84024Z","time spent":"330.540344ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:58:13.171021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.143417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:58:13.171107Z","caller":"traceutil/trace.go:171","msg":"trace[653440781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5324; }","duration":"386.366013ms","start":"2026-04-17T18:58:12.784725Z","end":"2026-04-17T18:58:13.171091Z","steps":["trace[653440781] 'agreement among raft nodes before linearized reading' (duration: 386.090195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:13.171175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:12.784698Z","time spent":"386.441085ms","remote":"127.0.0.1:39590","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-17T18:58:13.171432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:12.768144Z","time spent":"402.291832ms","remote":"127.0.0.1:39852","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-17T18:58:13.363891Z","caller":"traceutil/trace.go:171","msg":"trace[1363624494] transaction","detail":"{read_only:false; response_revision:5326; number_of_response:1; }","duration":"122.973541ms","start":"2026-04-17T18:58:13.24088Z","end":"2026-04-17T18:58:13.363853Z","steps":["trace[1363624494] 'process raft request' (duration: 122.863468ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:13.363978Z","caller":"traceutil/trace.go:171","msg":"trace[949471503] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"123.392042ms","start":"2026-04-17T18:58:13.240539Z","end":"2026-04-17T18:58:13.363931Z","steps":["trace[949471503] 'process raft request' (duration: 100.373328ms)","trace[949471503] 'compare' (duration: 22.624734ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:13.666841Z","caller":"traceutil/trace.go:171","msg":"trace[2002186771] transaction","detail":"{read_only:false; response_revision:5327; number_of_response:1; }","duration":"256.905863ms","start":"2026-04-17T18:58:13.409896Z","end":"2026-04-17T18:58:13.666801Z","steps":["trace[2002186771] 'process raft request' (duration: 246.780464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:13.945061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.094185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:58:13.94516Z","caller":"traceutil/trace.go:171","msg":"trace[2012324574] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5327; }","duration":"143.233579ms","start":"2026-04-17T18:58:13.8019Z","end":"2026-04-17T18:58:13.945134Z","steps":["trace[2012324574] 'count revisions from in-memory index tree' (duration: 143.020253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:13.945151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.795933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:58:13.945279Z","caller":"traceutil/trace.go:171","msg":"trace[658200205] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5327; }","duration":"160.986799ms","start":"2026-04-17T18:58:13.784269Z","end":"2026-04-17T18:58:13.945256Z","steps":["trace[658200205] 'range keys from in-memory index tree' (duration: 160.67681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:13.945404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.608924ms","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-17T18:58:13.945472Z","caller":"traceutil/trace.go:171","msg":"trace[1522303029] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5327; }","duration":"174.723037ms","start":"2026-04-17T18:58:13.770734Z","end":"2026-04-17T18:58:13.945457Z","steps":["trace[1522303029] 'range keys from in-memory index tree' (duration: 174.475701ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:13.94564Z","caller":"traceutil/trace.go:171","msg":"trace[149795198] transaction","detail":"{read_only:false; response_revision:5328; number_of_response:1; }","duration":"142.993972ms","start":"2026-04-17T18:58:13.80262Z","end":"2026-04-17T18:58:13.945614Z","steps":["trace[149795198] 'process raft request' (duration: 134.659223ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:14.55897Z","caller":"traceutil/trace.go:171","msg":"trace[305707884] transaction","detail":"{read_only:false; response_revision:5329; number_of_response:1; }","duration":"224.696916ms","start":"2026-04-17T18:58:14.334251Z","end":"2026-04-17T18:58:14.558948Z","steps":["trace[305707884] 'process raft request' (duration: 224.538611ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:15.301067Z","caller":"traceutil/trace.go:171","msg":"trace[1966407769] transaction","detail":"{read_only:false; response_revision:5333; number_of_response:1; }","duration":"125.027598ms","start":"2026-04-17T18:58:15.176005Z","end":"2026-04-17T18:58:15.301033Z","steps":["trace[1966407769] 'process raft request' (duration: 122.723954ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:15.301242Z","caller":"traceutil/trace.go:171","msg":"trace[773474550] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"124.872073ms","start":"2026-04-17T18:58:15.176345Z","end":"2026-04-17T18:58:15.301217Z","steps":["trace[773474550] 'process raft request' (duration: 124.614046ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:15.44148Z","caller":"traceutil/trace.go:171","msg":"trace[1673200803] linearizableReadLoop","detail":"{readStateIndex:5549; appliedIndex:5546; }","duration":"164.153016ms","start":"2026-04-17T18:58:15.277288Z","end":"2026-04-17T18:58:15.441441Z","steps":["trace[1673200803] 'read index received' (duration: 21.459792ms)","trace[1673200803] 'applied index is now lower than readState.Index' (duration: 142.691074ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:15.441551Z","caller":"traceutil/trace.go:171","msg":"trace[1324298880] transaction","detail":"{read_only:false; response_revision:5335; number_of_response:1; }","duration":"224.14922ms","start":"2026-04-17T18:58:15.21736Z","end":"2026-04-17T18:58:15.44151Z","steps":["trace[1324298880] 'process raft request' (duration: 223.726098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:15.441693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.366161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:58:15.441744Z","caller":"traceutil/trace.go:171","msg":"trace[379451444] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:5335; }","duration":"164.508886ms","start":"2026-04-17T18:58:15.277221Z","end":"2026-04-17T18:58:15.44173Z","steps":["trace[379451444] 'agreement among raft nodes before linearized reading' (duration: 164.368672ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:41.534776Z","caller":"traceutil/trace.go:171","msg":"trace[1056065716] transaction","detail":"{read_only:false; response_revision:5467; number_of_response:1; }","duration":"140.632008ms","start":"2026-04-17T18:58:41.394116Z","end":"2026-04-17T18:58:41.534748Z","steps":["trace[1056065716] 'process raft request' (duration: 140.478653ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:41.684266Z","caller":"traceutil/trace.go:171","msg":"trace[709786547] transaction","detail":"{read_only:false; response_revision:5468; number_of_response:1; }","duration":"283.820966ms","start":"2026-04-17T18:58:41.400421Z","end":"2026-04-17T18:58:41.684242Z","steps":["trace[709786547] 'process raft request' (duration: 283.659281ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:41.684487Z","caller":"traceutil/trace.go:171","msg":"trace[22216078] transaction","detail":"{read_only:false; response_revision:5469; number_of_response:1; }","duration":"151.780965ms","start":"2026-04-17T18:58:41.532671Z","end":"2026-04-17T18:58:41.684452Z","steps":["trace[22216078] 'process raft request' (duration: 151.533349ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:41.695012Z","caller":"traceutil/trace.go:171","msg":"trace[1006065821] linearizableReadLoop","detail":"{readStateIndex:5689; appliedIndex:5686; }","duration":"141.154732ms","start":"2026-04-17T18:58:41.553837Z","end":"2026-04-17T18:58:41.694992Z","steps":["trace[1006065821] 'read index received' (duration: 130.257691ms)","trace[1006065821] 'applied index is now lower than readState.Index' (duration: 10.896031ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:41.695078Z","caller":"traceutil/trace.go:171","msg":"trace[1284059344] transaction","detail":"{read_only:false; response_revision:5470; number_of_response:1; }","duration":"159.648971ms","start":"2026-04-17T18:58:41.535399Z","end":"2026-04-17T18:58:41.695048Z","steps":["trace[1284059344] 'process raft request' (duration: 159.498287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:41.69514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.295816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-17T18:58:41.695181Z","caller":"traceutil/trace.go:171","msg":"trace[271356538] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5470; }","duration":"141.394629ms","start":"2026-04-17T18:58:41.553775Z","end":"2026-04-17T18:58:41.69517Z","steps":["trace[271356538] 'agreement among raft nodes before linearized reading' (duration: 141.293236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:42.020451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.69228ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T18:58:42.020581Z","caller":"traceutil/trace.go:171","msg":"trace[1572996849] linearizableReadLoop","detail":"{readStateIndex:5690; appliedIndex:5689; }","duration":"235.671729ms","start":"2026-04-17T18:58:41.784856Z","end":"2026-04-17T18:58:42.020528Z","steps":["trace[1572996849] 'read index received' (duration: 45.851445ms)","trace[1572996849] 'applied index is now lower than readState.Index' (duration: 189.819154ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:42.020869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.000227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:58:42.020936Z","caller":"traceutil/trace.go:171","msg":"trace[732967239] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5471; }","duration":"236.12349ms","start":"2026-04-17T18:58:41.784796Z","end":"2026-04-17T18:58:42.02092Z","steps":["trace[732967239] 'agreement among raft nodes before linearized reading' (duration: 235.998607ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:42.020913Z","caller":"traceutil/trace.go:171","msg":"trace[1266436670] transaction","detail":"{read_only:false; response_revision:5471; number_of_response:1; }","duration":"321.530605ms","start":"2026-04-17T18:58:41.699331Z","end":"2026-04-17T18:58:42.020862Z","steps":["trace[1266436670] 'process raft request' (duration: 131.352091ms)","trace[1266436670] 'compare' (duration: 189.363291ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:42.021075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:41.699307Z","time spent":"321.681469ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:58:42.021234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.379086ms","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-17T18:58:42.021379Z","caller":"traceutil/trace.go:171","msg":"trace[1824137363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5471; }","duration":"224.529101ms","start":"2026-04-17T18:58:41.796823Z","end":"2026-04-17T18:58:42.021353Z","steps":["trace[1824137363] 'agreement among raft nodes before linearized reading' (duration: 224.196192ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:42.228963Z","caller":"traceutil/trace.go:171","msg":"trace[1857257777] linearizableReadLoop","detail":"{readStateIndex:5691; appliedIndex:5690; }","duration":"192.510808ms","start":"2026-04-17T18:58:42.036422Z","end":"2026-04-17T18:58:42.228933Z","steps":["trace[1857257777] 'read index received' (duration: 188.668802ms)","trace[1857257777] 'applied index is now lower than readState.Index' (duration: 3.840626ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:42.229178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.724924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:58:42.22922Z","caller":"traceutil/trace.go:171","msg":"trace[1142280929] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:5472; }","duration":"192.802767ms","start":"2026-04-17T18:58:42.036406Z","end":"2026-04-17T18:58:42.229209Z","steps":["trace[1142280929] 'agreement among raft nodes before linearized reading' (duration: 192.682153ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:42.229051Z","caller":"traceutil/trace.go:171","msg":"trace[827464774] transaction","detail":"{read_only:false; response_revision:5472; number_of_response:1; }","duration":"202.362519ms","start":"2026-04-17T18:58:42.02665Z","end":"2026-04-17T18:58:42.229012Z","steps":["trace[827464774] 'process raft request' (duration: 198.529283ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:42.864447Z","caller":"traceutil/trace.go:171","msg":"trace[1159354279] transaction","detail":"{read_only:false; response_revision:5473; number_of_response:1; }","duration":"166.999654ms","start":"2026-04-17T18:58:42.697403Z","end":"2026-04-17T18:58:42.864402Z","steps":["trace[1159354279] 'process raft request' (duration: 166.664435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:43.164826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.250265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-17T18:58:43.164919Z","caller":"traceutil/trace.go:171","msg":"trace[43979134] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5473; }","duration":"215.394709ms","start":"2026-04-17T18:58:42.949492Z","end":"2026-04-17T18:58:43.164887Z","steps":["trace[43979134] 'range keys from in-memory index tree' (duration: 215.039519ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:43.306708Z","caller":"traceutil/trace.go:171","msg":"trace[2132801431] transaction","detail":"{read_only:false; response_revision:5474; number_of_response:1; }","duration":"138.18753ms","start":"2026-04-17T18:58:43.168492Z","end":"2026-04-17T18:58:43.30668Z","steps":["trace[2132801431] 'process raft request' (duration: 138.026206ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:43.547312Z","caller":"traceutil/trace.go:171","msg":"trace[1296084107] linearizableReadLoop","detail":"{readStateIndex:5694; appliedIndex:5692; }","duration":"310.293346ms","start":"2026-04-17T18:58:43.236994Z","end":"2026-04-17T18:58:43.547287Z","steps":["trace[1296084107] 'read index received' (duration: 69.529087ms)","trace[1296084107] 'applied index is now lower than readState.Index' (duration: 240.763029ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:43.547464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.460691ms","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-17T18:58:43.547497Z","caller":"traceutil/trace.go:171","msg":"trace[1950239925] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5475; }","duration":"310.533032ms","start":"2026-04-17T18:58:43.236953Z","end":"2026-04-17T18:58:43.547486Z","steps":["trace[1950239925] 'agreement among raft nodes before linearized reading' (duration: 310.429459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:43.547538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:43.23694Z","time spent":"310.589684ms","remote":"127.0.0.1:37978","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-17T18:58:43.547455Z","caller":"traceutil/trace.go:171","msg":"trace[706507422] transaction","detail":"{read_only:false; response_revision:5475; number_of_response:1; }","duration":"377.866869ms","start":"2026-04-17T18:58:43.169547Z","end":"2026-04-17T18:58:43.547414Z","steps":["trace[706507422] 'process raft request' (duration: 377.594042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:43.547768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:43.169521Z","time spent":"378.148787ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T18:58:44.215976Z","caller":"traceutil/trace.go:171","msg":"trace[336374272] transaction","detail":"{read_only:false; response_revision:5480; number_of_response:1; }","duration":"186.281686ms","start":"2026-04-17T18:58:44.029666Z","end":"2026-04-17T18:58:44.215948Z","steps":["trace[336374272] 'process raft request' (duration: 185.977218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:44.602788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.9463ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T18:58:44.602951Z","caller":"traceutil/trace.go:171","msg":"trace[1815373367] transaction","detail":"{read_only:false; response_revision:5482; number_of_response:1; }","duration":"283.974229ms","start":"2026-04-17T18:58:44.318947Z","end":"2026-04-17T18:58:44.602921Z","steps":["trace[1815373367] 'process raft request' (duration: 115.784962ms)","trace[1815373367] 'compare' (duration: 167.824067ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:45.21031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.162226ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-17T18:58:45.210422Z","caller":"traceutil/trace.go:171","msg":"trace[342055928] linearizableReadLoop","detail":"{readStateIndex:5702; appliedIndex:5701; }","duration":"341.99666ms","start":"2026-04-17T18:58:44.868405Z","end":"2026-04-17T18:58:45.210402Z","steps":["trace[342055928] 'read index received' (duration: 119.646559ms)","trace[342055928] 'applied index is now lower than readState.Index' (duration: 222.348641ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:45.210574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.157272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:58:45.210615Z","caller":"traceutil/trace.go:171","msg":"trace[1796873434] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:5482; }","duration":"310.247744ms","start":"2026-04-17T18:58:44.900354Z","end":"2026-04-17T18:58:45.210602Z","steps":["trace[1796873434] 'agreement among raft nodes before linearized reading' (duration: 310.148192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:45.210655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:44.900328Z","time spent":"310.317646ms","remote":"127.0.0.1:36924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "} {"level":"warn","ts":"2026-04-17T18:58:45.210701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.271948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-17T18:58:45.210806Z","caller":"traceutil/trace.go:171","msg":"trace[2070363681] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5482; }","duration":"342.428572ms","start":"2026-04-17T18:58:44.868353Z","end":"2026-04-17T18:58:45.210782Z","steps":["trace[2070363681] 'agreement among raft nodes before linearized reading' (duration: 342.113554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:45.210875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:44.868331Z","time spent":"342.528154ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-17T18:58:45.399656Z","caller":"traceutil/trace.go:171","msg":"trace[2118175859] transaction","detail":"{read_only:false; response_revision:5483; number_of_response:1; }","duration":"184.102296ms","start":"2026-04-17T18:58:45.21553Z","end":"2026-04-17T18:58:45.399632Z","steps":["trace[2118175859] 'process raft request' (duration: 183.959912ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:45.603102Z","caller":"traceutil/trace.go:171","msg":"trace[1082575672] linearizableReadLoop","detail":"{readStateIndex:5704; appliedIndex:5703; }","duration":"358.895536ms","start":"2026-04-17T18:58:45.244179Z","end":"2026-04-17T18:58:45.603074Z","steps":["trace[1082575672] 'read index received' (duration: 155.445326ms)","trace[1082575672] 'applied index is now lower than readState.Index' (duration: 203.44915ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:45.603161Z","caller":"traceutil/trace.go:171","msg":"trace[1676758504] transaction","detail":"{read_only:false; response_revision:5484; number_of_response:1; }","duration":"360.587712ms","start":"2026-04-17T18:58:45.242535Z","end":"2026-04-17T18:58:45.603123Z","steps":["trace[1676758504] 'process raft request' (duration: 299.786826ms)","trace[1676758504] 'compare' (duration: 60.523759ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:45.603232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.038539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T18:58:45.603301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:45.242519Z","time spent":"360.710146ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T18:58:45.603309Z","caller":"traceutil/trace.go:171","msg":"trace[1441190562] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5484; }","duration":"359.166973ms","start":"2026-04-17T18:58:45.244123Z","end":"2026-04-17T18:58:45.60329Z","steps":["trace[1441190562] 'agreement among raft nodes before linearized reading' (duration: 359.032399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:45.603412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:45.244101Z","time spent":"359.297647ms","remote":"127.0.0.1:41972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-17T18:58:45.906322Z","caller":"traceutil/trace.go:171","msg":"trace[275126021] linearizableReadLoop","detail":"{readStateIndex:5705; appliedIndex:5704; }","duration":"303.123888ms","start":"2026-04-17T18:58:45.60317Z","end":"2026-04-17T18:58:45.906294Z","steps":["trace[275126021] 'read index received' (duration: 303.003645ms)","trace[275126021] 'applied index is now lower than readState.Index' (duration: 119.273µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:45.906424Z","caller":"traceutil/trace.go:171","msg":"trace[1545644736] transaction","detail":"{read_only:false; response_revision:5485; number_of_response:1; }","duration":"342.750891ms","start":"2026-04-17T18:58:45.563626Z","end":"2026-04-17T18:58:45.906376Z","steps":["trace[1545644736] 'process raft request' (duration: 342.530775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:45.906599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.922486ms","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-17T18:58:45.906646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.536541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-17T18:58:45.906677Z","caller":"traceutil/trace.go:171","msg":"trace[749526641] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5485; }","duration":"355.012528ms","start":"2026-04-17T18:58:45.551647Z","end":"2026-04-17T18:58:45.906659Z","steps":["trace[749526641] 'agreement among raft nodes before linearized reading' (duration: 354.792812ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:45.906707Z","caller":"traceutil/trace.go:171","msg":"trace[1422085684] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5485; }","duration":"595.653394ms","start":"2026-04-17T18:58:45.311028Z","end":"2026-04-17T18:58:45.906682Z","steps":["trace[1422085684] 'agreement among raft nodes before linearized reading' (duration: 595.441698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:45.906635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:45.563604Z","time spent":"342.954156ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T18:58:45.906734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:45.311008Z","time spent":"595.719955ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T18:58:45.90673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:45.551577Z","time spent":"355.140382ms","remote":"127.0.0.1:39852","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-17T18:58:46.02034Z","caller":"traceutil/trace.go:171","msg":"trace[1701268536] linearizableReadLoop","detail":"{readStateIndex:5708; appliedIndex:5705; }","duration":"113.828458ms","start":"2026-04-17T18:58:45.906491Z","end":"2026-04-17T18:58:46.020319Z","steps":["trace[1701268536] 'read index received' (duration: 112.520612ms)","trace[1701268536] 'applied index is now lower than readState.Index' (duration: 1.306936ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:46.020481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.639802ms","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-17T18:58:46.020522Z","caller":"traceutil/trace.go:171","msg":"trace[752875707] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5488; }","duration":"410.734835ms","start":"2026-04-17T18:58:45.609776Z","end":"2026-04-17T18:58:46.020511Z","steps":["trace[752875707] 'agreement among raft nodes before linearized reading' (duration: 410.628553ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:46.020525Z","caller":"traceutil/trace.go:171","msg":"trace[1399854265] transaction","detail":"{read_only:false; response_revision:5486; number_of_response:1; }","duration":"288.808563ms","start":"2026-04-17T18:58:45.731699Z","end":"2026-04-17T18:58:46.020508Z","steps":["trace[1399854265] 'process raft request' (duration: 287.278581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:46.020562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:45.609752Z","time spent":"410.802277ms","remote":"127.0.0.1:37978","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":"warn","ts":"2026-04-17T18:58:46.020611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.324076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:58:46.020721Z","caller":"traceutil/trace.go:171","msg":"trace[106367468] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5488; }","duration":"236.487341ms","start":"2026-04-17T18:58:45.784218Z","end":"2026-04-17T18:58:46.020705Z","steps":["trace[106367468] 'agreement among raft nodes before linearized reading' (duration: 236.321566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:46.020785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.892958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12500"} {"level":"info","ts":"2026-04-17T18:58:46.020774Z","caller":"traceutil/trace.go:171","msg":"trace[210899575] transaction","detail":"{read_only:false; response_revision:5488; number_of_response:1; }","duration":"288.662839ms","start":"2026-04-17T18:58:45.731986Z","end":"2026-04-17T18:58:46.020649Z","steps":["trace[210899575] 'process raft request' (duration: 288.296649ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:46.020851Z","caller":"traceutil/trace.go:171","msg":"trace[233269116] transaction","detail":"{read_only:false; response_revision:5489; number_of_response:1; }","duration":"109.835479ms","start":"2026-04-17T18:58:45.911006Z","end":"2026-04-17T18:58:46.020841Z","steps":["trace[233269116] 'process raft request' (duration: 109.50913ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:46.020802Z","caller":"traceutil/trace.go:171","msg":"trace[1420182500] transaction","detail":"{read_only:false; response_revision:5490; number_of_response:1; }","duration":"109.344725ms","start":"2026-04-17T18:58:45.911439Z","end":"2026-04-17T18:58:46.020784Z","steps":["trace[1420182500] 'process raft request' (duration: 109.269733ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:46.020442Z","caller":"traceutil/trace.go:171","msg":"trace[821122685] transaction","detail":"{read_only:false; response_revision:5487; number_of_response:1; }","duration":"288.574167ms","start":"2026-04-17T18:58:45.731841Z","end":"2026-04-17T18:58:46.020416Z","steps":["trace[821122685] 'process raft request' (duration: 288.404662ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:46.020819Z","caller":"traceutil/trace.go:171","msg":"trace[811923097] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5488; }","duration":"320.95221ms","start":"2026-04-17T18:58:45.699857Z","end":"2026-04-17T18:58:46.020809Z","steps":["trace[811923097] 'agreement among raft nodes before linearized reading' (duration: 320.738104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:46.021035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:45.699843Z","time spent":"321.180436ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12523,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-17T18:58:46.461297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.523913ms","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-17T18:58:46.461375Z","caller":"traceutil/trace.go:171","msg":"trace[1294312096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5490; }","duration":"153.652807ms","start":"2026-04-17T18:58:46.307704Z","end":"2026-04-17T18:58:46.461357Z","steps":["trace[1294312096] 'range keys from in-memory index tree' (duration: 153.315477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:46.461395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.097532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T18:58:46.461498Z","caller":"traceutil/trace.go:171","msg":"trace[962466018] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:5490; }","duration":"338.243616ms","start":"2026-04-17T18:58:46.123223Z","end":"2026-04-17T18:58:46.461467Z","steps":["trace[962466018] 'count revisions from in-memory index tree' (duration: 338.02027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:46.461574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:46.123203Z","time spent":"338.351949ms","remote":"127.0.0.1:36968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "} {"level":"warn","ts":"2026-04-17T18:58:46.461656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.007613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T18:58:46.462154Z","caller":"traceutil/trace.go:171","msg":"trace[148810746] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5490; }","duration":"242.585009ms","start":"2026-04-17T18:58:46.219538Z","end":"2026-04-17T18:58:46.462123Z","steps":["trace[148810746] 'range keys from in-memory index tree' (duration: 241.623172ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:46.617313Z","caller":"traceutil/trace.go:171","msg":"trace[1142402162] transaction","detail":"{read_only:false; response_revision:5491; number_of_response:1; }","duration":"151.246451ms","start":"2026-04-17T18:58:46.46603Z","end":"2026-04-17T18:58:46.617276Z","steps":["trace[1142402162] 'process raft request' (duration: 150.977894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:46.840807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.97675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T18:58:46.841265Z","caller":"traceutil/trace.go:171","msg":"trace[2052953011] transaction","detail":"{read_only:false; response_revision:5492; number_of_response:1; }","duration":"374.962349ms","start":"2026-04-17T18:58:46.466049Z","end":"2026-04-17T18:58:46.841011Z","steps":["trace[2052953011] 'process raft request' (duration: 201.661361ms)","trace[2052953011] 'compare' (duration: 172.65217ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T18:58:46.841419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T18:58:46.466024Z","time spent":"375.318639ms","remote":"127.0.0.1:39852","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-17T18:58:47.172993Z","caller":"traceutil/trace.go:171","msg":"trace[2001349187] linearizableReadLoop","detail":"{readStateIndex:5713; appliedIndex:5712; }","duration":"144.764482ms","start":"2026-04-17T18:58:47.028203Z","end":"2026-04-17T18:58:47.172967Z","steps":["trace[2001349187] 'read index received' (duration: 144.548926ms)","trace[2001349187] 'applied index is now lower than readState.Index' (duration: 214.686µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T18:58:47.173047Z","caller":"traceutil/trace.go:171","msg":"trace[311734017] transaction","detail":"{read_only:false; response_revision:5493; number_of_response:1; }","duration":"175.391846ms","start":"2026-04-17T18:58:46.997637Z","end":"2026-04-17T18:58:47.173029Z","steps":["trace[311734017] 'process raft request' (duration: 175.18647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T18:58:47.173126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.910795ms","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-17T18:58:47.173168Z","caller":"traceutil/trace.go:171","msg":"trace[508182383] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5493; }","duration":"145.002548ms","start":"2026-04-17T18:58:47.028152Z","end":"2026-04-17T18:58:47.173155Z","steps":["trace[508182383] 'agreement among raft nodes before linearized reading' (duration: 144.909835ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:58:47.511624Z","caller":"traceutil/trace.go:171","msg":"trace[417745782] transaction","detail":"{read_only:false; response_revision:5494; number_of_response:1; }","duration":"102.779413ms","start":"2026-04-17T18:58:47.40882Z","end":"2026-04-17T18:58:47.511599Z","steps":["trace[417745782] 'process raft request' (duration: 102.6385ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T18:59:46.141351Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4280} {"level":"info","ts":"2026-04-17T18:59:46.216496Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4280,"took":"73.918438ms","hash":557749140,"current-db-size-bytes":33136640,"current-db-size":"33 MB","current-db-size-in-use-bytes":8146944,"current-db-size-in-use":"8.1 MB"} {"level":"info","ts":"2026-04-17T18:59:46.216577Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":557749140,"revision":4280,"compact-revision":2752} {"level":"info","ts":"2026-04-17T19:00:15.527237Z","caller":"traceutil/trace.go:171","msg":"trace[1003635699] transaction","detail":"{read_only:false; response_revision:6076; number_of_response:1; }","duration":"125.669785ms","start":"2026-04-17T19:00:15.401536Z","end":"2026-04-17T19:00:15.527206Z","steps":["trace[1003635699] 'process raft request' (duration: 123.001782ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:16.12984Z","caller":"traceutil/trace.go:171","msg":"trace[1861753352] transaction","detail":"{read_only:false; response_revision:6082; number_of_response:1; }","duration":"124.275758ms","start":"2026-04-17T19:00:16.00553Z","end":"2026-04-17T19:00:16.129806Z","steps":["trace[1861753352] 'process raft request' (duration: 81.757305ms)","trace[1861753352] 'compare' (duration: 42.238985ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:00:19.418786Z","caller":"traceutil/trace.go:171","msg":"trace[194794369] transaction","detail":"{read_only:false; response_revision:6112; number_of_response:1; }","duration":"148.966429ms","start":"2026-04-17T19:00:19.26979Z","end":"2026-04-17T19:00:19.418757Z","steps":["trace[194794369] 'process raft request' (duration: 148.884527ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:19.41882Z","caller":"traceutil/trace.go:171","msg":"trace[2087677812] transaction","detail":"{read_only:false; response_revision:6111; number_of_response:1; }","duration":"149.00101ms","start":"2026-04-17T19:00:19.269779Z","end":"2026-04-17T19:00:19.41878Z","steps":["trace[2087677812] 'process raft request' (duration: 148.747723ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:19.483734Z","caller":"traceutil/trace.go:171","msg":"trace[513992146] transaction","detail":"{read_only:false; response_revision:6113; number_of_response:1; }","duration":"178.130703ms","start":"2026-04-17T19:00:19.305569Z","end":"2026-04-17T19:00:19.4837Z","steps":["trace[513992146] 'process raft request' (duration: 177.890936ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:19.596453Z","caller":"traceutil/trace.go:171","msg":"trace[1586772291] transaction","detail":"{read_only:false; response_revision:6114; number_of_response:1; }","duration":"106.066945ms","start":"2026-04-17T19:00:19.490348Z","end":"2026-04-17T19:00:19.596415Z","steps":["trace[1586772291] 'process raft request' (duration: 14.086459ms)","trace[1586772291] 'compare' (duration: 91.796141ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:00:19.842688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.916137ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T19:00:19.843Z","caller":"traceutil/trace.go:171","msg":"trace[933467692] transaction","detail":"{read_only:false; response_revision:6117; number_of_response:1; }","duration":"350.035823ms","start":"2026-04-17T19:00:19.492944Z","end":"2026-04-17T19:00:19.84298Z","steps":["trace[933467692] 'process raft request' (duration: 349.939291ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:19.842977Z","caller":"traceutil/trace.go:171","msg":"trace[1653845064] transaction","detail":"{read_only:false; response_revision:6115; number_of_response:1; }","duration":"350.792224ms","start":"2026-04-17T19:00:19.492105Z","end":"2026-04-17T19:00:19.842898Z","steps":["trace[1653845064] 'process raft request' (duration: 242.399065ms)","trace[1653845064] 'compare' (duration: 107.478654ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:00:19.843095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:00:19.492936Z","time spent":"350.111985ms","remote":"127.0.0.1:39622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T19:00:19.843162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:00:19.49208Z","time spent":"350.9882ms","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1140,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T19:00:19.84318Z","caller":"traceutil/trace.go:171","msg":"trace[1102515305] transaction","detail":"{read_only:false; response_revision:6116; number_of_response:1; }","duration":"350.593879ms","start":"2026-04-17T19:00:19.492534Z","end":"2026-04-17T19:00:19.843127Z","steps":["trace[1102515305] 'process raft request' (duration: 350.273111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:00:19.843415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:00:19.492513Z","time spent":"350.781304ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T19:00:20.063882Z","caller":"traceutil/trace.go:171","msg":"trace[99878194] transaction","detail":"{read_only:false; response_revision:6120; number_of_response:1; }","duration":"198.487975ms","start":"2026-04-17T19:00:19.865347Z","end":"2026-04-17T19:00:20.063835Z","steps":["trace[99878194] 'process raft request' (duration: 176.702304ms)","trace[99878194] 'compare' (duration: 21.241556ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:00:20.063877Z","caller":"traceutil/trace.go:171","msg":"trace[2005423284] transaction","detail":"{read_only:false; response_revision:6121; number_of_response:1; }","duration":"196.87627ms","start":"2026-04-17T19:00:19.866965Z","end":"2026-04-17T19:00:20.063842Z","steps":["trace[2005423284] 'process raft request' (duration: 196.718136ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:20.20951Z","caller":"traceutil/trace.go:171","msg":"trace[1775709142] transaction","detail":"{read_only:false; response_revision:6124; number_of_response:1; }","duration":"139.364024ms","start":"2026-04-17T19:00:20.070109Z","end":"2026-04-17T19:00:20.209474Z","steps":["trace[1775709142] 'process raft request' (duration: 96.272585ms)","trace[1775709142] 'compare' (duration: 42.736249ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:00:20.209624Z","caller":"traceutil/trace.go:171","msg":"trace[715391809] transaction","detail":"{read_only:false; response_revision:6125; number_of_response:1; }","duration":"107.011642ms","start":"2026-04-17T19:00:20.102569Z","end":"2026-04-17T19:00:20.209581Z","steps":["trace[715391809] 'process raft request' (duration: 106.733844ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:20.52652Z","caller":"traceutil/trace.go:171","msg":"trace[560923963] linearizableReadLoop","detail":"{readStateIndex:6383; appliedIndex:6381; }","duration":"129.171343ms","start":"2026-04-17T19:00:20.397314Z","end":"2026-04-17T19:00:20.526485Z","steps":["trace[560923963] 'read index received' (duration: 31.021376ms)","trace[560923963] 'applied index is now lower than readState.Index' (duration: 98.148387ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:00:20.5267Z","caller":"traceutil/trace.go:171","msg":"trace[599840423] transaction","detail":"{read_only:false; response_revision:6136; number_of_response:1; }","duration":"141.841212ms","start":"2026-04-17T19:00:20.384801Z","end":"2026-04-17T19:00:20.526642Z","steps":["trace[599840423] 'process raft request' (duration: 123.733823ms)","trace[599840423] 'compare' (duration: 17.747559ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:00:20.526969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.633285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-17T19:00:20.527047Z","caller":"traceutil/trace.go:171","msg":"trace[166795060] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:6136; }","duration":"129.78727ms","start":"2026-04-17T19:00:20.397241Z","end":"2026-04-17T19:00:20.527029Z","steps":["trace[166795060] 'agreement among raft nodes before linearized reading' (duration: 129.472821ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:20.676012Z","caller":"traceutil/trace.go:171","msg":"trace[1326206422] transaction","detail":"{read_only:false; response_revision:6143; number_of_response:1; }","duration":"142.13007ms","start":"2026-04-17T19:00:20.533858Z","end":"2026-04-17T19:00:20.675988Z","steps":["trace[1326206422] 'process raft request' (duration: 142.005607ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:20.676122Z","caller":"traceutil/trace.go:171","msg":"trace[1393599835] transaction","detail":"{read_only:false; response_revision:6142; number_of_response:1; }","duration":"143.520809ms","start":"2026-04-17T19:00:20.532548Z","end":"2026-04-17T19:00:20.676069Z","steps":["trace[1393599835] 'process raft request' (duration: 143.179609ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:20.675916Z","caller":"traceutil/trace.go:171","msg":"trace[482820819] transaction","detail":"{read_only:false; response_revision:6141; number_of_response:1; }","duration":"143.888068ms","start":"2026-04-17T19:00:20.531993Z","end":"2026-04-17T19:00:20.675881Z","steps":["trace[482820819] 'process raft request' (duration: 131.003103ms)","trace[482820819] 'compare' (duration: 12.562526ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:00:23.896182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.718493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:00:23.896295Z","caller":"traceutil/trace.go:171","msg":"trace[380122846] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6173; }","duration":"110.903689ms","start":"2026-04-17T19:00:23.785367Z","end":"2026-04-17T19:00:23.896271Z","steps":["trace[380122846] 'range keys from in-memory index tree' (duration: 110.5985ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:56.687688Z","caller":"traceutil/trace.go:171","msg":"trace[980042088] transaction","detail":"{read_only:false; response_revision:6370; number_of_response:1; }","duration":"112.962456ms","start":"2026-04-17T19:00:56.574704Z","end":"2026-04-17T19:00:56.687667Z","steps":["trace[980042088] 'process raft request' (duration: 112.805751ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:57.228387Z","caller":"traceutil/trace.go:171","msg":"trace[1231224306] linearizableReadLoop","detail":"{readStateIndex:6628; appliedIndex:6627; }","duration":"158.79462ms","start":"2026-04-17T19:00:57.069557Z","end":"2026-04-17T19:00:57.228352Z","steps":["trace[1231224306] 'read index received' (duration: 158.450061ms)","trace[1231224306] 'applied index is now lower than readState.Index' (duration: 343.129µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:00:57.228515Z","caller":"traceutil/trace.go:171","msg":"trace[673073651] transaction","detail":"{read_only:false; response_revision:6374; number_of_response:1; }","duration":"266.012186ms","start":"2026-04-17T19:00:56.962455Z","end":"2026-04-17T19:00:57.228467Z","steps":["trace[673073651] 'process raft request' (duration: 265.690068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:00:57.228559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.988235ms","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-17T19:00:57.228617Z","caller":"traceutil/trace.go:171","msg":"trace[1927515454] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6374; }","duration":"159.119329ms","start":"2026-04-17T19:00:57.069483Z","end":"2026-04-17T19:00:57.228602Z","steps":["trace[1927515454] 'agreement among raft nodes before linearized reading' (duration: 158.997996ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:00:57.446545Z","caller":"traceutil/trace.go:171","msg":"trace[839399784] linearizableReadLoop","detail":"{readStateIndex:6629; appliedIndex:6628; }","duration":"185.233029ms","start":"2026-04-17T19:00:57.261279Z","end":"2026-04-17T19:00:57.446512Z","steps":["trace[839399784] 'read index received' (duration: 135.736914ms)","trace[839399784] 'applied index is now lower than readState.Index' (duration: 49.494755ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:00:57.446706Z","caller":"traceutil/trace.go:171","msg":"trace[493328325] transaction","detail":"{read_only:false; response_revision:6375; number_of_response:1; }","duration":"212.979604ms","start":"2026-04-17T19:00:57.233667Z","end":"2026-04-17T19:00:57.446646Z","steps":["trace[493328325] 'process raft request' (duration: 163.413657ms)","trace[493328325] 'compare' (duration: 49.293249ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:00:57.446772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.470435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/valkey-node-0.18a73a14620351a1\" ","response":"range_response_count:1 size:765"} {"level":"info","ts":"2026-04-17T19:00:57.446798Z","caller":"traceutil/trace.go:171","msg":"trace[1263559819] range","detail":"{range_begin:/registry/events/openstack/valkey-node-0.18a73a14620351a1; range_end:; response_count:1; response_revision:6375; }","duration":"185.583269ms","start":"2026-04-17T19:00:57.261208Z","end":"2026-04-17T19:00:57.446792Z","steps":["trace[1263559819] 'agreement among raft nodes before linearized reading' (duration: 185.417474ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:01:02.877852Z","caller":"traceutil/trace.go:171","msg":"trace[1698650267] transaction","detail":"{read_only:false; response_revision:6407; number_of_response:1; }","duration":"107.33568ms","start":"2026-04-17T19:01:02.770489Z","end":"2026-04-17T19:01:02.877825Z","steps":["trace[1698650267] 'process raft request' (duration: 107.281749ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:01:02.87798Z","caller":"traceutil/trace.go:171","msg":"trace[1073399033] transaction","detail":"{read_only:false; response_revision:6406; number_of_response:1; }","duration":"107.67797ms","start":"2026-04-17T19:01:02.770239Z","end":"2026-04-17T19:01:02.877917Z","steps":["trace[1073399033] 'process raft request' (duration: 57.307001ms)","trace[1073399033] 'compare' (duration: 50.085951ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:02:28.277325Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12931696676644498888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T19:02:28.778095Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12931696676644498888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T19:02:29.2783Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12931696676644498888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T19:02:29.778517Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12931696676644498888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T19:02:29.781322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00019045s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-17T19:02:29.781399Z","caller":"traceutil/trace.go:171","msg":"trace[1366902857] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000301412s","start":"2026-04-17T19:02:27.781081Z","end":"2026-04-17T19:02:29.781383Z","steps":["trace[1366902857] 'agreement among raft nodes before linearized reading' (duration: 2.00020809s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:29.781442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:27.781071Z","time spent":"2.000363395s","remote":"127.0.0.1:39590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/17 19:02:29 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-17T19:02:30.279071Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12931696676644498888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T19:02:30.688383Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.623794096s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T19:02:30.688822Z","caller":"traceutil/trace.go:171","msg":"trace[1442216561] transaction","detail":"{read_only:false; response_revision:6851; number_of_response:1; }","duration":"3.624309281s","start":"2026-04-17T19:02:27.064486Z","end":"2026-04-17T19:02:30.688795Z","steps":["trace[1442216561] 'process raft request' (duration: 3.624152156s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.688978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:27.064469Z","time spent":"3.624431474s","remote":"127.0.0.1:39852","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-17T19:02:30.69378Z","caller":"traceutil/trace.go:171","msg":"trace[285490835] linearizableReadLoop","detail":"{readStateIndex:7131; appliedIndex:7124; }","duration":"2.916703385s","start":"2026-04-17T19:02:27.77706Z","end":"2026-04-17T19:02:30.693763Z","steps":["trace[285490835] 'read index received' (duration: 2.911594994s)","trace[285490835] 'applied index is now lower than readState.Index' (duration: 5.107201ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:02:30.693983Z","caller":"traceutil/trace.go:171","msg":"trace[33872947] transaction","detail":"{read_only:false; response_revision:6854; number_of_response:1; }","duration":"3.458709356s","start":"2026-04-17T19:02:27.23525Z","end":"2026-04-17T19:02:30.693959Z","steps":["trace[33872947] 'process raft request' (duration: 3.458420408s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.696214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:27.235232Z","time spent":"3.460860295s","remote":"127.0.0.1:39852","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-17T19:02:30.694146Z","caller":"traceutil/trace.go:171","msg":"trace[455702267] transaction","detail":"{read_only:false; response_revision:6853; number_of_response:1; }","duration":"3.568152289s","start":"2026-04-17T19:02:27.125986Z","end":"2026-04-17T19:02:30.694139Z","steps":["trace[455702267] 'process raft request' (duration: 3.567661266s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.69655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:27.125959Z","time spent":"3.570562855s","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T19:02:30.694107Z","caller":"traceutil/trace.go:171","msg":"trace[1153679642] transaction","detail":"{read_only:false; response_revision:6852; number_of_response:1; }","duration":"3.612710009s","start":"2026-04-17T19:02:27.08136Z","end":"2026-04-17T19:02:30.69407Z","steps":["trace[1153679642] 'process raft request' (duration: 3.612173674s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.69668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:27.081346Z","time spent":"3.615309982s","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T19:02:30.694183Z","caller":"traceutil/trace.go:171","msg":"trace[1086960206] transaction","detail":"{read_only:false; response_revision:6856; number_of_response:1; }","duration":"908.872924ms","start":"2026-04-17T19:02:29.785303Z","end":"2026-04-17T19:02:30.694176Z","steps":["trace[1086960206] 'process raft request' (duration: 908.409901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.696913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:29.785273Z","time spent":"911.616799ms","remote":"127.0.0.1:39658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T19:02:30.694207Z","caller":"traceutil/trace.go:171","msg":"trace[1912505098] transaction","detail":"{read_only:false; response_revision:6855; number_of_response:1; }","duration":"3.435965577s","start":"2026-04-17T19:02:27.258234Z","end":"2026-04-17T19:02:30.6942Z","steps":["trace[1912505098] 'process raft request' (duration: 3.435457023s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.697124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:27.258216Z","time spent":"3.438883448s","remote":"127.0.0.1:39852","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-17T19:02:30.694232Z","caller":"traceutil/trace.go:171","msg":"trace[1885125984] transaction","detail":"{read_only:false; response_revision:6857; number_of_response:1; }","duration":"562.477677ms","start":"2026-04-17T19:02:30.13175Z","end":"2026-04-17T19:02:30.694227Z","steps":["trace[1885125984] 'process raft request' (duration: 561.991493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.697235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:30.131719Z","time spent":"565.4951ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T19:02:30.694375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.917317461s","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-17T19:02:30.697334Z","caller":"traceutil/trace.go:171","msg":"trace[208293203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6857; }","duration":"2.920333965s","start":"2026-04-17T19:02:27.776981Z","end":"2026-04-17T19:02:30.697315Z","steps":["trace[208293203] 'agreement among raft nodes before linearized reading' (duration: 2.917284291s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.697392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:27.776956Z","time spent":"2.920427657s","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T19:02:30.69557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.764727487s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-17T19:02:30.697487Z","caller":"traceutil/trace.go:171","msg":"trace[1913779264] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6857; }","duration":"2.766717171s","start":"2026-04-17T19:02:27.93076Z","end":"2026-04-17T19:02:30.697478Z","steps":["trace[1913779264] 'agreement among raft nodes before linearized reading' (duration: 2.764670915s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.697509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:27.930736Z","time spent":"2.766766213s","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T19:02:30.695636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.400221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T19:02:30.697611Z","caller":"traceutil/trace.go:171","msg":"trace[428969063] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:6857; }","duration":"124.417887ms","start":"2026-04-17T19:02:30.573176Z","end":"2026-04-17T19:02:30.697594Z","steps":["trace[428969063] 'agreement among raft nodes before linearized reading' (duration: 122.424892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.695674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.75857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:02:30.697735Z","caller":"traceutil/trace.go:171","msg":"trace[64927248] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:6857; }","duration":"734.873408ms","start":"2026-04-17T19:02:29.96285Z","end":"2026-04-17T19:02:30.697723Z","steps":["trace[64927248] 'agreement among raft nodes before linearized reading' (duration: 732.803741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.697765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:29.962825Z","time spent":"734.92915ms","remote":"127.0.0.1:39896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-17T19:02:30.695699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.247014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:02:30.697924Z","caller":"traceutil/trace.go:171","msg":"trace[1844489824] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6857; }","duration":"907.517617ms","start":"2026-04-17T19:02:29.790399Z","end":"2026-04-17T19:02:30.697917Z","steps":["trace[1844489824] 'agreement among raft nodes before linearized reading' (duration: 905.285555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.697967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:29.790378Z","time spent":"907.579889ms","remote":"127.0.0.1:39592","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-17T19:02:30.695748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.284769147s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.168\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-17T19:02:30.698075Z","caller":"traceutil/trace.go:171","msg":"trace[143134084] range","detail":"{range_begin:/registry/masterleases/199.19.213.168; range_end:; response_count:1; response_revision:6857; }","duration":"1.287138373s","start":"2026-04-17T19:02:29.410926Z","end":"2026-04-17T19:02:30.698064Z","steps":["trace[143134084] 'agreement among raft nodes before linearized reading' (duration: 1.284784418s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.698114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:29.410909Z","time spent":"1.287191424s","remote":"127.0.0.1:39622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.168\" "} {"level":"warn","ts":"2026-04-17T19:02:30.695822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.810930461s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-17T19:02:30.698181Z","caller":"traceutil/trace.go:171","msg":"trace[274448558] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:6857; }","duration":"1.813270515s","start":"2026-04-17T19:02:28.884887Z","end":"2026-04-17T19:02:30.698157Z","steps":["trace[274448558] 'agreement among raft nodes before linearized reading' (duration: 1.810873599s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.698227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:28.884815Z","time spent":"1.813387069s","remote":"127.0.0.1:39782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-04-17T19:02:30.695851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.306307374s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:02:30.698349Z","caller":"traceutil/trace.go:171","msg":"trace[844980488] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:6857; }","duration":"2.308864824s","start":"2026-04-17T19:02:28.389474Z","end":"2026-04-17T19:02:30.698339Z","steps":["trace[844980488] 'agreement among raft nodes before linearized reading' (duration: 2.306358995s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.698388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:28.389449Z","time spent":"2.308924966s","remote":"127.0.0.1:42004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-17T19:02:30.695894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.335861721s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-17T19:02:30.698525Z","caller":"traceutil/trace.go:171","msg":"trace[283990934] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6857; }","duration":"2.338522144s","start":"2026-04-17T19:02:28.359991Z","end":"2026-04-17T19:02:30.698514Z","steps":["trace[283990934] 'agreement among raft nodes before linearized reading' (duration: 2.335869771s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.698555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:28.359972Z","time spent":"2.338573995s","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T19:02:30.695917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.535859574s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:02:30.698706Z","caller":"traceutil/trace.go:171","msg":"trace[1791838542] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:6857; }","duration":"2.538692593s","start":"2026-04-17T19:02:28.160003Z","end":"2026-04-17T19:02:30.698696Z","steps":["trace[1791838542] 'agreement among raft nodes before linearized reading' (duration: 2.535900046s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.698741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:28.159986Z","time spent":"2.538742754s","remote":"127.0.0.1:41976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-17T19:02:30.69596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.602620598s","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-17T19:02:30.698916Z","caller":"traceutil/trace.go:171","msg":"trace[1948591921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6857; }","duration":"2.605606161s","start":"2026-04-17T19:02:28.093301Z","end":"2026-04-17T19:02:30.698907Z","steps":["trace[1948591921] 'agreement among raft nodes before linearized reading' (duration: 2.602626899s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:02:30.698951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:02:28.093286Z","time spent":"2.605655852s","remote":"127.0.0.1:39852","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-17T19:03:23.347407Z","caller":"traceutil/trace.go:171","msg":"trace[968994315] transaction","detail":"{read_only:false; response_revision:7262; number_of_response:1; }","duration":"165.132051ms","start":"2026-04-17T19:03:23.18224Z","end":"2026-04-17T19:03:23.347372Z","steps":["trace[968994315] 'process raft request' (duration: 118.683008ms)","trace[968994315] 'compare' (duration: 46.234437ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:03:23.381121Z","caller":"traceutil/trace.go:171","msg":"trace[1215839218] transaction","detail":"{read_only:false; response_revision:7263; number_of_response:1; }","duration":"196.035215ms","start":"2026-04-17T19:03:23.18506Z","end":"2026-04-17T19:03:23.381096Z","steps":["trace[1215839218] 'process raft request' (duration: 195.921812ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:03:35.132113Z","caller":"traceutil/trace.go:171","msg":"trace[1632258183] transaction","detail":"{read_only:false; response_revision:7378; number_of_response:1; }","duration":"165.368858ms","start":"2026-04-17T19:03:34.966715Z","end":"2026-04-17T19:03:35.132084Z","steps":["trace[1632258183] 'process raft request' (duration: 149.248303ms)","trace[1632258183] 'compare' (duration: 15.745995ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:03:35.132473Z","caller":"traceutil/trace.go:171","msg":"trace[285724331] transaction","detail":"{read_only:false; response_revision:7380; number_of_response:1; }","duration":"106.874662ms","start":"2026-04-17T19:03:35.025569Z","end":"2026-04-17T19:03:35.132443Z","steps":["trace[285724331] 'process raft request' (duration: 106.733318ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:03:35.132489Z","caller":"traceutil/trace.go:171","msg":"trace[1852880248] transaction","detail":"{read_only:false; response_revision:7379; number_of_response:1; }","duration":"156.848312ms","start":"2026-04-17T19:03:34.975601Z","end":"2026-04-17T19:03:35.132449Z","steps":["trace[1852880248] 'process raft request' (duration: 156.355189ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:03:35.329266Z","caller":"traceutil/trace.go:171","msg":"trace[2078316432] linearizableReadLoop","detail":"{readStateIndex:7675; appliedIndex:7674; }","duration":"121.299061ms","start":"2026-04-17T19:03:35.207929Z","end":"2026-04-17T19:03:35.329228Z","steps":["trace[2078316432] 'read index received' (duration: 32.915239ms)","trace[2078316432] 'applied index is now lower than readState.Index' (duration: 88.380562ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:03:35.329387Z","caller":"traceutil/trace.go:171","msg":"trace[301859836] transaction","detail":"{read_only:false; response_revision:7382; number_of_response:1; }","duration":"129.905658ms","start":"2026-04-17T19:03:35.199434Z","end":"2026-04-17T19:03:35.32934Z","steps":["trace[301859836] 'process raft request' (duration: 41.508966ms)","trace[301859836] 'compare' (duration: 88.146455ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:03:35.329564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.502866ms","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-17T19:03:35.329622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.658801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-17T19:03:35.329651Z","caller":"traceutil/trace.go:171","msg":"trace[2125301488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7382; }","duration":"121.64088ms","start":"2026-04-17T19:03:35.207983Z","end":"2026-04-17T19:03:35.329624Z","steps":["trace[2125301488] 'agreement among raft nodes before linearized reading' (duration: 121.445004ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:03:35.329734Z","caller":"traceutil/trace.go:171","msg":"trace[456463310] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7382; }","duration":"121.742112ms","start":"2026-04-17T19:03:35.207902Z","end":"2026-04-17T19:03:35.329644Z","steps":["trace[456463310] 'agreement among raft nodes before linearized reading' (duration: 121.429024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:03:35.329893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.465536ms","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-17T19:03:35.329961Z","caller":"traceutil/trace.go:171","msg":"trace[1028273347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7382; }","duration":"104.552588ms","start":"2026-04-17T19:03:35.22538Z","end":"2026-04-17T19:03:35.329932Z","steps":["trace[1028273347] 'agreement among raft nodes before linearized reading' (duration: 104.424895ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:04:09.310219Z","caller":"traceutil/trace.go:171","msg":"trace[720278884] transaction","detail":"{read_only:false; response_revision:7578; number_of_response:1; }","duration":"104.323402ms","start":"2026-04-17T19:04:09.205861Z","end":"2026-04-17T19:04:09.310185Z","steps":["trace[720278884] 'process raft request' (duration: 104.112236ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:04:14.883774Z","caller":"traceutil/trace.go:171","msg":"trace[1134163970] linearizableReadLoop","detail":"{readStateIndex:7908; appliedIndex:7906; }","duration":"110.197013ms","start":"2026-04-17T19:04:14.773552Z","end":"2026-04-17T19:04:14.883749Z","steps":["trace[1134163970] 'read index received' (duration: 11.433356ms)","trace[1134163970] 'applied index is now lower than readState.Index' (duration: 98.762027ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:04:14.884111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.548914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5xbjt\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-17T19:04:14.884134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.413593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:04:14.884144Z","caller":"traceutil/trace.go:171","msg":"trace[1562445482] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5xbjt; range_end:; response_count:1; response_revision:7607; }","duration":"110.654156ms","start":"2026-04-17T19:04:14.773481Z","end":"2026-04-17T19:04:14.884136Z","steps":["trace[1562445482] 'agreement among raft nodes before linearized reading' (duration: 110.411899ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:04:14.884243Z","caller":"traceutil/trace.go:171","msg":"trace[2025161247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7607; }","duration":"100.566338ms","start":"2026-04-17T19:04:14.783665Z","end":"2026-04-17T19:04:14.884232Z","steps":["trace[2025161247] 'agreement among raft nodes before linearized reading' (duration: 100.401463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:04:15.163383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.923198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:04:15.163496Z","caller":"traceutil/trace.go:171","msg":"trace[1275231529] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:7609; }","duration":"105.082573ms","start":"2026-04-17T19:04:15.058385Z","end":"2026-04-17T19:04:15.163467Z","steps":["trace[1275231529] 'count revisions from in-memory index tree' (duration: 104.808935ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:04:15.855745Z","caller":"traceutil/trace.go:171","msg":"trace[918851403] transaction","detail":"{read_only:false; response_revision:7619; number_of_response:1; }","duration":"120.136618ms","start":"2026-04-17T19:04:15.735589Z","end":"2026-04-17T19:04:15.855725Z","steps":["trace[918851403] 'process raft request' (duration: 120.064486ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:04:15.855827Z","caller":"traceutil/trace.go:171","msg":"trace[717491488] transaction","detail":"{read_only:false; response_revision:7617; number_of_response:1; }","duration":"120.343603ms","start":"2026-04-17T19:04:15.735382Z","end":"2026-04-17T19:04:15.855726Z","steps":["trace[717491488] 'process raft request' (duration: 68.750308ms)","trace[717491488] 'compare' (duration: 51.331838ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:04:15.855724Z","caller":"traceutil/trace.go:171","msg":"trace[1115608736] transaction","detail":"{read_only:false; response_revision:7618; number_of_response:1; }","duration":"120.224151ms","start":"2026-04-17T19:04:15.735468Z","end":"2026-04-17T19:04:15.855692Z","steps":["trace[1115608736] 'process raft request' (duration: 120.128578ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:04:21.528962Z","caller":"traceutil/trace.go:171","msg":"trace[1308418257] transaction","detail":"{read_only:false; response_revision:7646; number_of_response:1; }","duration":"112.252901ms","start":"2026-04-17T19:04:21.416673Z","end":"2026-04-17T19:04:21.528925Z","steps":["trace[1308418257] 'process raft request' (duration: 94.667375ms)","trace[1308418257] 'compare' (duration: 17.441462ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:04:21.537409Z","caller":"traceutil/trace.go:171","msg":"trace[850275065] transaction","detail":"{read_only:false; response_revision:7647; number_of_response:1; }","duration":"111.018916ms","start":"2026-04-17T19:04:21.426364Z","end":"2026-04-17T19:04:21.537382Z","steps":["trace[850275065] 'process raft request' (duration: 110.848522ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:04:21.537634Z","caller":"traceutil/trace.go:171","msg":"trace[403031079] transaction","detail":"{read_only:false; response_revision:7648; number_of_response:1; }","duration":"101.580476ms","start":"2026-04-17T19:04:21.436042Z","end":"2026-04-17T19:04:21.537623Z","steps":["trace[403031079] 'process raft request' (duration: 101.310418ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:04:46.150612Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5808} {"level":"info","ts":"2026-04-17T19:04:46.189864Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5808,"took":"37.990678ms","hash":1697157851,"current-db-size-bytes":33136640,"current-db-size":"33 MB","current-db-size-in-use-bytes":17805312,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-17T19:04:46.189946Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1697157851,"revision":5808,"compact-revision":4280} {"level":"info","ts":"2026-04-17T19:05:07.881978Z","caller":"traceutil/trace.go:171","msg":"trace[603116800] transaction","detail":"{read_only:false; response_revision:7984; number_of_response:1; }","duration":"126.028327ms","start":"2026-04-17T19:05:07.755919Z","end":"2026-04-17T19:05:07.881947Z","steps":["trace[603116800] 'process raft request' (duration: 125.850522ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.126258Z","caller":"traceutil/trace.go:171","msg":"trace[82117239] transaction","detail":"{read_only:false; response_revision:8273; number_of_response:1; }","duration":"100.315388ms","start":"2026-04-17T19:05:13.025909Z","end":"2026-04-17T19:05:13.126225Z","steps":["trace[82117239] 'process raft request' (duration: 100.02291ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.126387Z","caller":"traceutil/trace.go:171","msg":"trace[1015207016] transaction","detail":"{read_only:false; response_revision:8275; number_of_response:1; }","duration":"100.269256ms","start":"2026-04-17T19:05:13.026082Z","end":"2026-04-17T19:05:13.126351Z","steps":["trace[1015207016] 'process raft request' (duration: 100.111992ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.126479Z","caller":"traceutil/trace.go:171","msg":"trace[1311663602] transaction","detail":"{read_only:false; response_revision:8276; number_of_response:1; }","duration":"100.139043ms","start":"2026-04-17T19:05:13.026309Z","end":"2026-04-17T19:05:13.126448Z","steps":["trace[1311663602] 'process raft request' (duration: 99.921587ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.126453Z","caller":"traceutil/trace.go:171","msg":"trace[1927967268] transaction","detail":"{read_only:false; response_revision:8274; number_of_response:1; }","duration":"100.389009ms","start":"2026-04-17T19:05:13.026004Z","end":"2026-04-17T19:05:13.126393Z","steps":["trace[1927967268] 'process raft request' (duration: 100.145863ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.126571Z","caller":"traceutil/trace.go:171","msg":"trace[1733998943] transaction","detail":"{read_only:false; response_revision:8279; number_of_response:1; }","duration":"100.032ms","start":"2026-04-17T19:05:13.026527Z","end":"2026-04-17T19:05:13.126559Z","steps":["trace[1733998943] 'process raft request' (duration: 99.794943ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.126565Z","caller":"traceutil/trace.go:171","msg":"trace[773374645] transaction","detail":"{read_only:false; response_revision:8278; number_of_response:1; }","duration":"100.047301ms","start":"2026-04-17T19:05:13.026467Z","end":"2026-04-17T19:05:13.126514Z","steps":["trace[773374645] 'process raft request' (duration: 99.827915ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.126509Z","caller":"traceutil/trace.go:171","msg":"trace[1058811369] transaction","detail":"{read_only:false; response_revision:8277; number_of_response:1; }","duration":"100.098782ms","start":"2026-04-17T19:05:13.026395Z","end":"2026-04-17T19:05:13.126493Z","steps":["trace[1058811369] 'process raft request' (duration: 99.866776ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.126749Z","caller":"traceutil/trace.go:171","msg":"trace[1831594651] transaction","detail":"{read_only:false; response_revision:8280; number_of_response:1; }","duration":"100.201255ms","start":"2026-04-17T19:05:13.026529Z","end":"2026-04-17T19:05:13.12673Z","steps":["trace[1831594651] 'process raft request' (duration: 99.917487ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.126971Z","caller":"traceutil/trace.go:171","msg":"trace[15895264] transaction","detail":"{read_only:false; response_revision:8282; number_of_response:1; }","duration":"100.347259ms","start":"2026-04-17T19:05:13.026603Z","end":"2026-04-17T19:05:13.126951Z","steps":["trace[15895264] 'process raft request' (duration: 100.235876ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.126954Z","caller":"traceutil/trace.go:171","msg":"trace[1121750079] transaction","detail":"{read_only:false; response_revision:8281; number_of_response:1; }","duration":"100.3803ms","start":"2026-04-17T19:05:13.026536Z","end":"2026-04-17T19:05:13.126916Z","steps":["trace[1121750079] 'process raft request' (duration: 100.062851ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.127015Z","caller":"traceutil/trace.go:171","msg":"trace[1765682181] transaction","detail":"{read_only:false; response_revision:8283; number_of_response:1; }","duration":"100.295907ms","start":"2026-04-17T19:05:13.026695Z","end":"2026-04-17T19:05:13.126991Z","steps":["trace[1765682181] 'process raft request' (duration: 100.202644ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.127144Z","caller":"traceutil/trace.go:171","msg":"trace[909850483] transaction","detail":"{read_only:false; response_revision:8284; number_of_response:1; }","duration":"100.36928ms","start":"2026-04-17T19:05:13.026753Z","end":"2026-04-17T19:05:13.127122Z","steps":["trace[909850483] 'process raft request' (duration: 100.184884ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.127203Z","caller":"traceutil/trace.go:171","msg":"trace[1182849425] transaction","detail":"{read_only:false; response_revision:8285; number_of_response:1; }","duration":"100.156623ms","start":"2026-04-17T19:05:13.027026Z","end":"2026-04-17T19:05:13.127182Z","steps":["trace[1182849425] 'process raft request' (duration: 99.955228ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.127293Z","caller":"traceutil/trace.go:171","msg":"trace[1029763870] transaction","detail":"{read_only:false; response_revision:8286; number_of_response:1; }","duration":"100.218265ms","start":"2026-04-17T19:05:13.027061Z","end":"2026-04-17T19:05:13.127279Z","steps":["trace[1029763870] 'process raft request' (duration: 100.04169ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.127403Z","caller":"traceutil/trace.go:171","msg":"trace[1312243164] transaction","detail":"{read_only:false; response_revision:8287; number_of_response:1; }","duration":"100.300147ms","start":"2026-04-17T19:05:13.027087Z","end":"2026-04-17T19:05:13.127387Z","steps":["trace[1312243164] 'process raft request' (duration: 100.073091ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.127504Z","caller":"traceutil/trace.go:171","msg":"trace[162381375] transaction","detail":"{read_only:false; response_revision:8288; number_of_response:1; }","duration":"100.237026ms","start":"2026-04-17T19:05:13.027188Z","end":"2026-04-17T19:05:13.127425Z","steps":["trace[162381375] 'process raft request' (duration: 100.102112ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:13.168095Z","caller":"traceutil/trace.go:171","msg":"trace[1701209434] transaction","detail":"{read_only:false; response_revision:8289; number_of_response:1; }","duration":"120.643999ms","start":"2026-04-17T19:05:13.047419Z","end":"2026-04-17T19:05:13.168063Z","steps":["trace[1701209434] 'process raft request' (duration: 120.29986ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:18.773431Z","caller":"traceutil/trace.go:171","msg":"trace[355084995] transaction","detail":"{read_only:false; response_revision:8390; number_of_response:1; }","duration":"107.851996ms","start":"2026-04-17T19:05:18.665544Z","end":"2026-04-17T19:05:18.773396Z","steps":["trace[355084995] 'process raft request' (duration: 107.624399ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:19.52847Z","caller":"traceutil/trace.go:171","msg":"trace[916553339] linearizableReadLoop","detail":"{readStateIndex:8725; appliedIndex:8724; }","duration":"108.73281ms","start":"2026-04-17T19:05:19.419699Z","end":"2026-04-17T19:05:19.528432Z","steps":["trace[916553339] 'read index received' (duration: 108.545525ms)","trace[916553339] 'applied index is now lower than readState.Index' (duration: 184.945µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:05:19.528737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.031699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.168\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-17T19:05:19.52878Z","caller":"traceutil/trace.go:171","msg":"trace[325383532] range","detail":"{range_begin:/registry/masterleases/199.19.213.168; range_end:; response_count:1; response_revision:8391; }","duration":"109.165842ms","start":"2026-04-17T19:05:19.419603Z","end":"2026-04-17T19:05:19.528769Z","steps":["trace[325383532] 'agreement among raft nodes before linearized reading' (duration: 108.967137ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:19.52927Z","caller":"traceutil/trace.go:171","msg":"trace[1859603975] transaction","detail":"{read_only:false; response_revision:8391; number_of_response:1; }","duration":"190.312481ms","start":"2026-04-17T19:05:19.338944Z","end":"2026-04-17T19:05:19.529257Z","steps":["trace[1859603975] 'process raft request' (duration: 189.236301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:19.682498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.101142ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-17T19:05:19.682582Z","caller":"traceutil/trace.go:171","msg":"trace[1465858693] linearizableReadLoop","detail":"{readStateIndex:8726; appliedIndex:8725; }","duration":"104.268217ms","start":"2026-04-17T19:05:19.578298Z","end":"2026-04-17T19:05:19.682566Z","steps":["trace[1465858693] 'read index received' (duration: 4.684569ms)","trace[1465858693] 'applied index is now lower than readState.Index' (duration: 99.582478ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:05:19.682838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.538955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:05:19.682862Z","caller":"traceutil/trace.go:171","msg":"trace[217058581] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:8391; }","duration":"104.607977ms","start":"2026-04-17T19:05:19.578246Z","end":"2026-04-17T19:05:19.682854Z","steps":["trace[217058581] 'agreement among raft nodes before linearized reading' (duration: 104.552225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:28.788543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.264319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-17T19:05:28.788656Z","caller":"traceutil/trace.go:171","msg":"trace[593275602] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8726; }","duration":"215.410683ms","start":"2026-04-17T19:05:28.573223Z","end":"2026-04-17T19:05:28.788633Z","steps":["trace[593275602] 'range keys from in-memory index tree' (duration: 215.059633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:28.788657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.564765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3dbe68d4-0dda-4ec6-8ea2-a7227e2a2b9c\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-17T19:05:28.788718Z","caller":"traceutil/trace.go:171","msg":"trace[1929389555] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3dbe68d4-0dda-4ec6-8ea2-a7227e2a2b9c; range_end:; response_count:1; response_revision:8726; }","duration":"166.664928ms","start":"2026-04-17T19:05:28.622032Z","end":"2026-04-17T19:05:28.788697Z","steps":["trace[1929389555] 'range keys from in-memory index tree' (duration: 166.426641ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:29.094452Z","caller":"traceutil/trace.go:171","msg":"trace[986394693] linearizableReadLoop","detail":"{readStateIndex:9072; appliedIndex:9071; }","duration":"104.03225ms","start":"2026-04-17T19:05:28.990387Z","end":"2026-04-17T19:05:29.094419Z","steps":["trace[986394693] 'read index received' (duration: 103.722731ms)","trace[986394693] 'applied index is now lower than readState.Index' (duration: 308.549µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:05:29.094592Z","caller":"traceutil/trace.go:171","msg":"trace[1279242984] transaction","detail":"{read_only:false; response_revision:8727; number_of_response:1; }","duration":"301.829466ms","start":"2026-04-17T19:05:28.792705Z","end":"2026-04-17T19:05:29.094534Z","steps":["trace[1279242984] 'process raft request' (duration: 301.509907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:29.094673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.255576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:05:29.094768Z","caller":"traceutil/trace.go:171","msg":"trace[356012436] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:8727; }","duration":"104.424281ms","start":"2026-04-17T19:05:28.990321Z","end":"2026-04-17T19:05:29.094746Z","steps":["trace[356012436] 'agreement among raft nodes before linearized reading' (duration: 104.242146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:29.094867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:28.792688Z","time spent":"302.022252ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T19:05:29.778541Z","caller":"traceutil/trace.go:171","msg":"trace[1303071656] transaction","detail":"{read_only:false; response_revision:8729; number_of_response:1; }","duration":"311.191026ms","start":"2026-04-17T19:05:29.467329Z","end":"2026-04-17T19:05:29.77852Z","steps":["trace[1303071656] 'process raft request' (duration: 311.046862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:29.778671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:29.467302Z","time spent":"311.301209ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3706,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T19:05:29.793248Z","caller":"traceutil/trace.go:171","msg":"trace[759186955] transaction","detail":"{read_only:false; response_revision:8730; number_of_response:1; }","duration":"209.544801ms","start":"2026-04-17T19:05:29.58367Z","end":"2026-04-17T19:05:29.793215Z","steps":["trace[759186955] 'process raft request' (duration: 209.311984ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:33.005566Z","caller":"traceutil/trace.go:171","msg":"trace[1625873142] transaction","detail":"{read_only:false; response_revision:8789; number_of_response:1; }","duration":"157.105834ms","start":"2026-04-17T19:05:32.84843Z","end":"2026-04-17T19:05:33.005536Z","steps":["trace[1625873142] 'process raft request' (duration: 156.93313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:37.030837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.210346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T19:05:37.03099Z","caller":"traceutil/trace.go:171","msg":"trace[938538196] transaction","detail":"{read_only:false; response_revision:8860; number_of_response:1; }","duration":"289.525718ms","start":"2026-04-17T19:05:36.741422Z","end":"2026-04-17T19:05:37.030948Z","steps":["trace[938538196] 'process raft request' (duration: 115.142197ms)","trace[938538196] 'compare' (duration: 173.96595ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:05:37.16836Z","caller":"traceutil/trace.go:171","msg":"trace[1741139866] transaction","detail":"{read_only:false; response_revision:8862; number_of_response:1; }","duration":"129.278077ms","start":"2026-04-17T19:05:37.039052Z","end":"2026-04-17T19:05:37.16833Z","steps":["trace[1741139866] 'process raft request' (duration: 128.084824ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:37.16865Z","caller":"traceutil/trace.go:171","msg":"trace[1909354185] transaction","detail":"{read_only:false; response_revision:8863; number_of_response:1; }","duration":"129.537484ms","start":"2026-04-17T19:05:37.03907Z","end":"2026-04-17T19:05:37.168607Z","steps":["trace[1909354185] 'process raft request' (duration: 129.201955ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:37.168863Z","caller":"traceutil/trace.go:171","msg":"trace[1809176462] transaction","detail":"{read_only:false; response_revision:8864; number_of_response:1; }","duration":"102.886529ms","start":"2026-04-17T19:05:37.065963Z","end":"2026-04-17T19:05:37.16885Z","steps":["trace[1809176462] 'process raft request' (duration: 102.56937ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:39.594876Z","caller":"traceutil/trace.go:171","msg":"trace[790341845] transaction","detail":"{read_only:false; response_revision:8918; number_of_response:1; }","duration":"117.018557ms","start":"2026-04-17T19:05:39.477825Z","end":"2026-04-17T19:05:39.594844Z","steps":["trace[790341845] 'process raft request' (duration: 68.939032ms)","trace[790341845] 'compare' (duration: 47.89318ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:05:39.884878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.414434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T19:05:39.885042Z","caller":"traceutil/trace.go:171","msg":"trace[10309111] linearizableReadLoop","detail":"{readStateIndex:9271; appliedIndex:9270; }","duration":"246.82236ms","start":"2026-04-17T19:05:39.6382Z","end":"2026-04-17T19:05:39.885023Z","steps":["trace[10309111] 'read index received' (duration: 102.048126ms)","trace[10309111] 'applied index is now lower than readState.Index' (duration: 144.772564ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:05:39.885312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.103748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-04-17T19:05:39.88539Z","caller":"traceutil/trace.go:171","msg":"trace[758912879] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:8919; }","duration":"247.243281ms","start":"2026-04-17T19:05:39.638131Z","end":"2026-04-17T19:05:39.885375Z","steps":["trace[758912879] 'agreement among raft nodes before linearized reading' (duration: 246.999444ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:39.885657Z","caller":"traceutil/trace.go:171","msg":"trace[2090168488] transaction","detail":"{read_only:false; response_revision:8919; number_of_response:1; }","duration":"250.871512ms","start":"2026-04-17T19:05:39.634202Z","end":"2026-04-17T19:05:39.885074Z","steps":["trace[2090168488] 'process raft request' (duration: 106.18614ms)","trace[2090168488] 'compare' (duration: 144.016393ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:05:39.905626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.876925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:05:39.905686Z","caller":"traceutil/trace.go:171","msg":"trace[1886997423] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8920; }","duration":"120.979238ms","start":"2026-04-17T19:05:39.784693Z","end":"2026-04-17T19:05:39.905672Z","steps":["trace[1886997423] 'agreement among raft nodes before linearized reading' (duration: 120.888746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:39.906025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.884128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-17T19:05:39.906077Z","caller":"traceutil/trace.go:171","msg":"trace[123768575] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:8920; }","duration":"214.963691ms","start":"2026-04-17T19:05:39.691097Z","end":"2026-04-17T19:05:39.906061Z","steps":["trace[123768575] 'agreement among raft nodes before linearized reading' (duration: 214.449627ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:40.239457Z","caller":"traceutil/trace.go:171","msg":"trace[1422680956] linearizableReadLoop","detail":"{readStateIndex:9273; appliedIndex:9272; }","duration":"332.073793ms","start":"2026-04-17T19:05:39.907354Z","end":"2026-04-17T19:05:40.239428Z","steps":["trace[1422680956] 'read index received' (duration: 331.950859ms)","trace[1422680956] 'applied index is now lower than readState.Index' (duration: 121.374µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:05:40.239659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.272158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:05:40.239831Z","caller":"traceutil/trace.go:171","msg":"trace[719327864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8921; }","duration":"332.511914ms","start":"2026-04-17T19:05:39.907299Z","end":"2026-04-17T19:05:40.239811Z","steps":["trace[719327864] 'agreement among raft nodes before linearized reading' (duration: 332.238027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.239896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:39.907268Z","time spent":"332.617297ms","remote":"127.0.0.1:39590","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-17T19:05:40.239962Z","caller":"traceutil/trace.go:171","msg":"trace[1475145576] transaction","detail":"{read_only:false; response_revision:8921; number_of_response:1; }","duration":"337.875202ms","start":"2026-04-17T19:05:39.901647Z","end":"2026-04-17T19:05:40.239522Z","steps":["trace[1475145576] 'process raft request' (duration: 337.578154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.240557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:39.901603Z","time spent":"338.665334ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16542,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T19:05:40.55717Z","caller":"traceutil/trace.go:171","msg":"trace[1837034356] transaction","detail":"{read_only:false; response_revision:8922; number_of_response:1; }","duration":"536.467641ms","start":"2026-04-17T19:05:40.020679Z","end":"2026-04-17T19:05:40.557147Z","steps":["trace[1837034356] 'process raft request' (duration: 536.189464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.557373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.020655Z","time spent":"536.628945ms","remote":"127.0.0.1:39852","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-17T19:05:40.557462Z","caller":"traceutil/trace.go:171","msg":"trace[822367712] linearizableReadLoop","detail":"{readStateIndex:9276; appliedIndex:9273; }","duration":"317.910531ms","start":"2026-04-17T19:05:40.239531Z","end":"2026-04-17T19:05:40.557441Z","steps":["trace[822367712] 'read index received' (duration: 317.395697ms)","trace[822367712] 'applied index is now lower than readState.Index' (duration: 514.074µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:05:40.557478Z","caller":"traceutil/trace.go:171","msg":"trace[1359386884] transaction","detail":"{read_only:false; response_revision:8923; number_of_response:1; }","duration":"434.57893ms","start":"2026-04-17T19:05:40.12287Z","end":"2026-04-17T19:05:40.557449Z","steps":["trace[1359386884] 'process raft request' (duration: 434.188639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.557629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.122821Z","time spent":"434.725214ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T19:05:40.557701Z","caller":"traceutil/trace.go:171","msg":"trace[1432271508] transaction","detail":"{read_only:false; response_revision:8924; number_of_response:1; }","duration":"424.790239ms","start":"2026-04-17T19:05:40.132868Z","end":"2026-04-17T19:05:40.557658Z","steps":["trace[1432271508] 'process raft request' (duration: 424.45992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.557824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.132827Z","time spent":"424.946694ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T19:05:40.557839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.779477ms","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-17T19:05:40.557883Z","caller":"traceutil/trace.go:171","msg":"trace[16904326] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8924; }","duration":"417.950741ms","start":"2026-04-17T19:05:40.139917Z","end":"2026-04-17T19:05:40.557868Z","steps":["trace[16904326] 'agreement among raft nodes before linearized reading' (duration: 417.640403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.557989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.139899Z","time spent":"418.078255ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T19:05:40.558084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.717208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-d31a3000-bd04-455b-8c14-762d38cb21bc\" ","response":"range_response_count:1 size:1435"} {"level":"warn","ts":"2026-04-17T19:05:40.558083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.924583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12330"} {"level":"info","ts":"2026-04-17T19:05:40.558326Z","caller":"traceutil/trace.go:171","msg":"trace[740713050] range","detail":"{range_begin:/registry/persistentvolumes/pvc-d31a3000-bd04-455b-8c14-762d38cb21bc; range_end:; response_count:1; response_revision:8924; }","duration":"648.944724ms","start":"2026-04-17T19:05:39.909283Z","end":"2026-04-17T19:05:40.558228Z","steps":["trace[740713050] 'agreement among raft nodes before linearized reading' (duration: 648.392639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.558404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:39.909259Z","time spent":"649.12988ms","remote":"127.0.0.1:39740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1458,"request content":"key:\"/registry/persistentvolumes/pvc-d31a3000-bd04-455b-8c14-762d38cb21bc\" "} {"level":"info","ts":"2026-04-17T19:05:40.558436Z","caller":"traceutil/trace.go:171","msg":"trace[1533272848] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8924; }","duration":"388.277992ms","start":"2026-04-17T19:05:40.1701Z","end":"2026-04-17T19:05:40.558378Z","steps":["trace[1533272848] 'agreement among raft nodes before linearized reading' (duration: 387.444069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.558515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.17003Z","time spent":"388.461718ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12353,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-17T19:05:40.877818Z","caller":"traceutil/trace.go:171","msg":"trace[1363343663] transaction","detail":"{read_only:false; response_revision:8925; number_of_response:1; }","duration":"630.081214ms","start":"2026-04-17T19:05:40.247705Z","end":"2026-04-17T19:05:40.877787Z","steps":["trace[1363343663] 'process raft request' (duration: 629.767805ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:40.877973Z","caller":"traceutil/trace.go:171","msg":"trace[2079398990] transaction","detail":"{read_only:false; response_revision:8927; number_of_response:1; }","duration":"630.012802ms","start":"2026-04-17T19:05:40.24795Z","end":"2026-04-17T19:05:40.877962Z","steps":["trace[2079398990] 'process raft request' (duration: 629.788206ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:40.878033Z","caller":"traceutil/trace.go:171","msg":"trace[1134603595] transaction","detail":"{read_only:false; response_revision:8928; number_of_response:1; }","duration":"629.93174ms","start":"2026-04-17T19:05:40.248081Z","end":"2026-04-17T19:05:40.878013Z","steps":["trace[1134603595] 'process raft request' (duration: 629.755325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.878117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.247941Z","time spent":"630.096404ms","remote":"127.0.0.1:39760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":850,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T19:05:40.878126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.247675Z","time spent":"630.322641ms","remote":"127.0.0.1:39868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T19:05:40.878304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.24807Z","time spent":"630.122035ms","remote":"127.0.0.1:39868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1853,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T19:05:40.87789Z","caller":"traceutil/trace.go:171","msg":"trace[1698080591] transaction","detail":"{read_only:false; response_revision:8926; number_of_response:1; }","duration":"630.131196ms","start":"2026-04-17T19:05:40.247721Z","end":"2026-04-17T19:05:40.877852Z","steps":["trace[1698080591] 'process raft request' (duration: 629.958011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.878664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.151714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:05:40.878704Z","caller":"traceutil/trace.go:171","msg":"trace[1724173331] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:8928; }","duration":"444.240897ms","start":"2026-04-17T19:05:40.434452Z","end":"2026-04-17T19:05:40.878693Z","steps":["trace[1724173331] 'agreement among raft nodes before linearized reading' (duration: 444.157575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.878741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.434403Z","time spent":"444.324269ms","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-04-17T19:05:40.878788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.247706Z","time spent":"630.975379ms","remote":"127.0.0.1:39760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1273,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T19:05:40.878985Z","caller":"traceutil/trace.go:171","msg":"trace[1900779858] linearizableReadLoop","detail":"{readStateIndex:9280; appliedIndex:9276; }","duration":"320.444511ms","start":"2026-04-17T19:05:40.557528Z","end":"2026-04-17T19:05:40.877973Z","steps":["trace[1900779858] 'read index received' (duration: 320.05989ms)","trace[1900779858] 'applied index is now lower than readState.Index' (duration: 383.691µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:05:40.879129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.729682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T19:05:40.879173Z","caller":"traceutil/trace.go:171","msg":"trace[96733896] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:8928; }","duration":"572.800664ms","start":"2026-04-17T19:05:40.306356Z","end":"2026-04-17T19:05:40.879157Z","steps":["trace[96733896] 'agreement among raft nodes before linearized reading' (duration: 572.67503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.879217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.30634Z","time spent":"572.869255ms","remote":"127.0.0.1:40020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-17T19:05:40.879387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.944996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-17T19:05:40.879437Z","caller":"traceutil/trace.go:171","msg":"trace[636743518] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8928; }","duration":"325.032998ms","start":"2026-04-17T19:05:40.554389Z","end":"2026-04-17T19:05:40.879422Z","steps":["trace[636743518] 'agreement among raft nodes before linearized reading' (duration: 324.716729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.879468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.554365Z","time spent":"325.096609ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T19:05:40.87953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.05375ms","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-17T19:05:40.879621Z","caller":"traceutil/trace.go:171","msg":"trace[160306157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8928; }","duration":"631.212605ms","start":"2026-04-17T19:05:40.248384Z","end":"2026-04-17T19:05:40.879597Z","steps":["trace[160306157] 'agreement among raft nodes before linearized reading' (duration: 630.820964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.879721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.248374Z","time spent":"631.307998ms","remote":"127.0.0.1:39852","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-17T19:05:40.964844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.665026ms","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-17T19:05:40.964833Z","caller":"traceutil/trace.go:171","msg":"trace[1319379030] transaction","detail":"{read_only:false; response_revision:8929; number_of_response:1; }","duration":"400.065138ms","start":"2026-04-17T19:05:40.564715Z","end":"2026-04-17T19:05:40.964781Z","steps":["trace[1319379030] 'process raft request' (duration: 386.998628ms)","trace[1319379030] 'compare' (duration: 12.550256ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:05:40.96493Z","caller":"traceutil/trace.go:171","msg":"trace[248502124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8929; }","duration":"138.792869ms","start":"2026-04-17T19:05:40.826116Z","end":"2026-04-17T19:05:40.964909Z","steps":["trace[248502124] 'agreement among raft nodes before linearized reading' (duration: 138.559173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.965062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.564688Z","time spent":"400.253093ms","remote":"127.0.0.1:39852","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-17T19:05:40.964846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.111224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-04-17T19:05:40.965252Z","caller":"traceutil/trace.go:171","msg":"trace[1363568776] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:8929; }","duration":"319.573416ms","start":"2026-04-17T19:05:40.64566Z","end":"2026-04-17T19:05:40.965234Z","steps":["trace[1363568776] 'agreement among raft nodes before linearized reading' (duration: 319.042742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.965299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.645629Z","time spent":"319.657309ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12998,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-04-17T19:05:40.964844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.480551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"warn","ts":"2026-04-17T19:05:40.964844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.880448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12330"} {"level":"info","ts":"2026-04-17T19:05:40.9656Z","caller":"traceutil/trace.go:171","msg":"trace[1894732002] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:8929; }","duration":"301.18627ms","start":"2026-04-17T19:05:40.664329Z","end":"2026-04-17T19:05:40.965515Z","steps":["trace[1894732002] 'agreement among raft nodes before linearized reading' (duration: 300.372468ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:40.965657Z","caller":"traceutil/trace.go:171","msg":"trace[374528376] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8929; }","duration":"402.762163ms","start":"2026-04-17T19:05:40.562879Z","end":"2026-04-17T19:05:40.965641Z","steps":["trace[374528376] 'agreement among raft nodes before linearized reading' (duration: 401.763645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:40.965724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.562847Z","time spent":"402.862735ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12353,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-17T19:05:40.965768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:40.664318Z","time spent":"301.392846ms","remote":"127.0.0.1:39746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-04-17T19:05:46.704042Z","caller":"traceutil/trace.go:171","msg":"trace[351898543] transaction","detail":"{read_only:false; response_revision:8976; number_of_response:1; }","duration":"121.78433ms","start":"2026-04-17T19:05:46.582229Z","end":"2026-04-17T19:05:46.704013Z","steps":["trace[351898543] 'process raft request' (duration: 121.600495ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:47.089876Z","caller":"traceutil/trace.go:171","msg":"trace[989139811] linearizableReadLoop","detail":"{readStateIndex:9331; appliedIndex:9329; }","duration":"303.066211ms","start":"2026-04-17T19:05:46.786781Z","end":"2026-04-17T19:05:47.089847Z","steps":["trace[989139811] 'read index received' (duration: 295.606726ms)","trace[989139811] 'applied index is now lower than readState.Index' (duration: 7.458285ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:05:47.089931Z","caller":"traceutil/trace.go:171","msg":"trace[11419419] transaction","detail":"{read_only:false; response_revision:8977; number_of_response:1; }","duration":"503.977333ms","start":"2026-04-17T19:05:46.585906Z","end":"2026-04-17T19:05:47.089884Z","steps":["trace[11419419] 'process raft request' (duration: 496.549269ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:47.090025Z","caller":"traceutil/trace.go:171","msg":"trace[1616091039] transaction","detail":"{read_only:false; response_revision:8978; number_of_response:1; }","duration":"503.344266ms","start":"2026-04-17T19:05:46.586666Z","end":"2026-04-17T19:05:47.09001Z","steps":["trace[1616091039] 'process raft request' (duration: 503.13104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:47.09015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:46.585874Z","time spent":"504.149148ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T19:05:47.090178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:46.586643Z","time spent":"503.422718ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T19:05:47.090455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.680089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:05:47.090499Z","caller":"traceutil/trace.go:171","msg":"trace[1042912104] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8978; }","duration":"303.761701ms","start":"2026-04-17T19:05:46.786727Z","end":"2026-04-17T19:05:47.090489Z","steps":["trace[1042912104] 'agreement among raft nodes before linearized reading' (duration: 303.688969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:47.090528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:05:46.786707Z","time spent":"303.814102ms","remote":"127.0.0.1:39592","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-17T19:05:50.104221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.224426ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T19:05:50.104323Z","caller":"traceutil/trace.go:171","msg":"trace[42887826] transaction","detail":"{read_only:false; response_revision:9070; number_of_response:1; }","duration":"147.555401ms","start":"2026-04-17T19:05:49.956746Z","end":"2026-04-17T19:05:50.104301Z","steps":["trace[42887826] 'process raft request' (duration: 39.182691ms)","trace[42887826] 'compare' (duration: 107.743903ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:05:56.945955Z","caller":"traceutil/trace.go:171","msg":"trace[587288919] transaction","detail":"{read_only:false; response_revision:9147; number_of_response:1; }","duration":"131.588281ms","start":"2026-04-17T19:05:56.81435Z","end":"2026-04-17T19:05:56.945938Z","steps":["trace[587288919] 'process raft request' (duration: 131.352104ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:56.945902Z","caller":"traceutil/trace.go:171","msg":"trace[863735420] linearizableReadLoop","detail":"{readStateIndex:9503; appliedIndex:9502; }","duration":"117.621266ms","start":"2026-04-17T19:05:56.828249Z","end":"2026-04-17T19:05:56.94587Z","steps":["trace[863735420] 'read index received' (duration: 117.375669ms)","trace[863735420] 'applied index is now lower than readState.Index' (duration: 243.357µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:05:56.946134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.879282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-04-17T19:05:56.9463Z","caller":"traceutil/trace.go:171","msg":"trace[1148651539] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:9147; }","duration":"118.103429ms","start":"2026-04-17T19:05:56.828177Z","end":"2026-04-17T19:05:56.946281Z","steps":["trace[1148651539] 'agreement among raft nodes before linearized reading' (duration: 117.811891ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:05:56.990774Z","caller":"traceutil/trace.go:171","msg":"trace[995453489] transaction","detail":"{read_only:false; response_revision:9148; number_of_response:1; }","duration":"149.220147ms","start":"2026-04-17T19:05:56.841534Z","end":"2026-04-17T19:05:56.990754Z","steps":["trace[995453489] 'process raft request' (duration: 131.57356ms)","trace[995453489] 'compare' (duration: 17.555975ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:05:58.944432Z","caller":"traceutil/trace.go:171","msg":"trace[1381351302] transaction","detail":"{read_only:false; response_revision:9170; number_of_response:1; }","duration":"113.214123ms","start":"2026-04-17T19:05:58.831189Z","end":"2026-04-17T19:05:58.944403Z","steps":["trace[1381351302] 'process raft request' (duration: 112.982667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:59.905867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.785323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:05:59.905965Z","caller":"traceutil/trace.go:171","msg":"trace[45558699] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:9193; }","duration":"128.937397ms","start":"2026-04-17T19:05:59.777006Z","end":"2026-04-17T19:05:59.905944Z","steps":["trace[45558699] 'count revisions from in-memory index tree' (duration: 128.688531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:05:59.905873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.356418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:05:59.906091Z","caller":"traceutil/trace.go:171","msg":"trace[991451000] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9193; }","duration":"121.595245ms","start":"2026-04-17T19:05:59.784473Z","end":"2026-04-17T19:05:59.906068Z","steps":["trace[991451000] 'range keys from in-memory index tree' (duration: 121.298107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:06:11.867656Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12931696676644504545,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T19:06:11.996971Z","caller":"traceutil/trace.go:171","msg":"trace[348923277] transaction","detail":"{read_only:false; response_revision:9318; number_of_response:1; }","duration":"722.941394ms","start":"2026-04-17T19:06:11.273992Z","end":"2026-04-17T19:06:11.996933Z","steps":["trace[348923277] 'process raft request' (duration: 690.077438ms)","trace[348923277] 'compare' (duration: 32.62861ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:06:11.997121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:06:11.273958Z","time spent":"723.084319ms","remote":"127.0.0.1:39852","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-17T19:06:12.043707Z","caller":"traceutil/trace.go:171","msg":"trace[1954950208] linearizableReadLoop","detail":"{readStateIndex:9681; appliedIndex:9679; }","duration":"676.546945ms","start":"2026-04-17T19:06:11.367133Z","end":"2026-04-17T19:06:12.04368Z","steps":["trace[1954950208] 'read index received' (duration: 596.876147ms)","trace[1954950208] 'applied index is now lower than readState.Index' (duration: 79.669718ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:06:12.043961Z","caller":"traceutil/trace.go:171","msg":"trace[1336125873] transaction","detail":"{read_only:false; response_revision:9319; number_of_response:1; }","duration":"739.865832ms","start":"2026-04-17T19:06:11.303905Z","end":"2026-04-17T19:06:12.04377Z","steps":["trace[1336125873] 'process raft request' (duration: 739.546943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:06:12.044095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.945056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-17T19:06:12.044124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.743881ms","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-17T19:06:12.044159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.043268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12330"} {"level":"warn","ts":"2026-04-17T19:06:12.044189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.775768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-17T19:06:12.044203Z","caller":"traceutil/trace.go:171","msg":"trace[1571945137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9319; }","duration":"677.09284ms","start":"2026-04-17T19:06:11.36708Z","end":"2026-04-17T19:06:12.044173Z","steps":["trace[1571945137] 'agreement among raft nodes before linearized reading' (duration: 676.835593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:06:12.044237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.232799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:06:12.04424Z","caller":"traceutil/trace.go:171","msg":"trace[1501956227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9319; }","duration":"676.862153ms","start":"2026-04-17T19:06:11.367333Z","end":"2026-04-17T19:06:12.044195Z","steps":["trace[1501956227] 'agreement among raft nodes before linearized reading' (duration: 676.592106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:06:12.044149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.704518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5xbjt\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-17T19:06:12.044262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:06:11.367057Z","time spent":"677.195823ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T19:06:12.044257Z","caller":"traceutil/trace.go:171","msg":"trace[1087740837] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9319; }","duration":"337.894462ms","start":"2026-04-17T19:06:11.706345Z","end":"2026-04-17T19:06:12.044239Z","steps":["trace[1087740837] 'agreement among raft nodes before linearized reading' (duration: 337.703466ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:06:12.044289Z","caller":"traceutil/trace.go:171","msg":"trace[931049603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9319; }","duration":"260.319981ms","start":"2026-04-17T19:06:11.783949Z","end":"2026-04-17T19:06:12.044269Z","steps":["trace[931049603] 'agreement among raft nodes before linearized reading' (duration: 260.25228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:06:12.04428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.258983ms","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-17T19:06:12.044301Z","caller":"traceutil/trace.go:171","msg":"trace[831691770] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5xbjt; range_end:; response_count:1; response_revision:9319; }","duration":"336.898344ms","start":"2026-04-17T19:06:11.707385Z","end":"2026-04-17T19:06:12.044283Z","steps":["trace[831691770] 'agreement among raft nodes before linearized reading' (duration: 336.569665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:06:12.04432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:06:11.706321Z","time spent":"337.983633ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-17T19:06:12.044357Z","caller":"traceutil/trace.go:171","msg":"trace[59310182] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9319; }","duration":"640.356846ms","start":"2026-04-17T19:06:11.403982Z","end":"2026-04-17T19:06:12.044339Z","steps":["trace[59310182] 'agreement among raft nodes before linearized reading' (duration: 640.145721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:06:12.044373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:06:11.707366Z","time spent":"336.988977ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-5xbjt\" "} {"level":"warn","ts":"2026-04-17T19:06:12.044407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:06:11.403976Z","time spent":"640.420818ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T19:06:12.044289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:06:11.367326Z","time spent":"676.950967ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T19:06:12.044454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.123547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-17T19:06:12.044226Z","caller":"traceutil/trace.go:171","msg":"trace[1922119070] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9319; }","duration":"478.165172ms","start":"2026-04-17T19:06:11.566044Z","end":"2026-04-17T19:06:12.04421Z","steps":["trace[1922119070] 'agreement among raft nodes before linearized reading' (duration: 477.936305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:06:12.044523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:06:11.566019Z","time spent":"478.49764ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12353,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-17T19:06:12.044523Z","caller":"traceutil/trace.go:171","msg":"trace[2014761295] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9319; }","duration":"641.22501ms","start":"2026-04-17T19:06:11.403284Z","end":"2026-04-17T19:06:12.044509Z","steps":["trace[2014761295] 'agreement among raft nodes before linearized reading' (duration: 641.060466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:06:12.044595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:06:11.403262Z","time spent":"641.323063ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T19:06:12.044727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:06:11.30387Z","time spent":"740.588802ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T19:06:44.435928Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8ae391decac9b376","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-17T19:06:44.441442Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-17T19:06:44.441575Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-17T19:09:22.129136Z","caller":"traceutil/trace.go:171","msg":"trace[1262529524] transaction","detail":"{read_only:false; response_revision:10630; number_of_response:1; }","duration":"108.977753ms","start":"2026-04-17T19:09:22.020137Z","end":"2026-04-17T19:09:22.129114Z","steps":["trace[1262529524] 'process raft request' (duration: 108.845609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:22.46443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.177778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/identity\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:09:22.464507Z","caller":"traceutil/trace.go:171","msg":"trace[2105089124] range","detail":"{range_begin:/registry/ingress/openstack/identity; range_end:; response_count:0; response_revision:10630; }","duration":"270.300681ms","start":"2026-04-17T19:09:22.194192Z","end":"2026-04-17T19:09:22.464493Z","steps":["trace[2105089124] 'range keys from in-memory index tree' (duration: 270.110646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.28298Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12931696676644508007,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T19:09:23.784149Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12931696676644508007,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T19:09:23.811924Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.327177814s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T19:09:23.813789Z","caller":"traceutil/trace.go:171","msg":"trace[72271346] linearizableReadLoop","detail":"{readStateIndex:11040; appliedIndex:11035; }","duration":"1.031296866s","start":"2026-04-17T19:09:22.782481Z","end":"2026-04-17T19:09:23.813778Z","steps":["trace[72271346] 'read index received' (duration: 1.029858196s)","trace[72271346] 'applied index is now lower than readState.Index' (duration: 1.43798ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:09:23.813758Z","caller":"traceutil/trace.go:171","msg":"trace[93601279] transaction","detail":"{read_only:false; response_revision:10632; number_of_response:1; }","duration":"1.329154519s","start":"2026-04-17T19:09:22.48455Z","end":"2026-04-17T19:09:23.813704Z","steps":["trace[93601279] 'process raft request' (duration: 1.32776489s)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:23.81387Z","caller":"traceutil/trace.go:171","msg":"trace[462599263] transaction","detail":"{read_only:false; response_revision:10635; number_of_response:1; }","duration":"1.012005023s","start":"2026-04-17T19:09:22.801857Z","end":"2026-04-17T19:09:23.813862Z","steps":["trace[462599263] 'process raft request' (duration: 1.011865059s)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:23.813843Z","caller":"traceutil/trace.go:171","msg":"trace[1111472856] transaction","detail":"{read_only:false; response_revision:10633; number_of_response:1; }","duration":"1.316291013s","start":"2026-04-17T19:09:22.497475Z","end":"2026-04-17T19:09:23.813766Z","steps":["trace[1111472856] 'process raft request' (duration: 1.3161532s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.813967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:22.801839Z","time spent":"1.012045214s","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T19:09:23.814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031493321s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:09:23.81405Z","caller":"traceutil/trace.go:171","msg":"trace[2086648265] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10636; }","duration":"1.031600234s","start":"2026-04-17T19:09:22.782439Z","end":"2026-04-17T19:09:23.81404Z","steps":["trace[2086648265] 'agreement among raft nodes before linearized reading' (duration: 1.031483371s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.814052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:22.497459Z","time spent":"1.316496449s","remote":"127.0.0.1:45128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1176,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T19:09:23.814075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:22.484512Z","time spent":"1.329338725s","remote":"127.0.0.1:39658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":656,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T19:09:23.814052Z","caller":"traceutil/trace.go:171","msg":"trace[2137819309] transaction","detail":"{read_only:false; response_revision:10636; number_of_response:1; }","duration":"726.963023ms","start":"2026-04-17T19:09:23.087056Z","end":"2026-04-17T19:09:23.814019Z","steps":["trace[2137819309] 'process raft request' (duration: 726.700706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.814084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:22.782418Z","time spent":"1.031658746s","remote":"127.0.0.1:39592","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-17T19:09:23.814135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.713069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T19:09:23.814183Z","caller":"traceutil/trace.go:171","msg":"trace[944059226] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:10636; }","duration":"772.805241ms","start":"2026-04-17T19:09:23.041364Z","end":"2026-04-17T19:09:23.814169Z","steps":["trace[944059226] 'agreement among raft nodes before linearized reading' (duration: 772.689087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.814184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:23.087025Z","time spent":"727.096427ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T19:09:23.814205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:23.041348Z","time spent":"772.851642ms","remote":"127.0.0.1:45128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":12,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-04-17T19:09:23.814221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.357556ms","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-17T19:09:23.814291Z","caller":"traceutil/trace.go:171","msg":"trace[1322368748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:10636; }","duration":"561.486729ms","start":"2026-04-17T19:09:23.252786Z","end":"2026-04-17T19:09:23.814273Z","steps":["trace[1322368748] 'agreement among raft nodes before linearized reading' (duration: 561.313555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.814326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:23.252741Z","time spent":"561.577483ms","remote":"127.0.0.1:39852","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-17T19:09:23.814344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.371045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5xbjt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-17T19:09:23.813849Z","caller":"traceutil/trace.go:171","msg":"trace[2127271090] transaction","detail":"{read_only:false; response_revision:10634; number_of_response:1; }","duration":"1.021269669s","start":"2026-04-17T19:09:22.792538Z","end":"2026-04-17T19:09:23.813808Z","steps":["trace[2127271090] 'process raft request' (duration: 1.021133045s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.814406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.566927ms","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-17T19:09:23.814422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.370254ms","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-17T19:09:23.814438Z","caller":"traceutil/trace.go:171","msg":"trace[1783506581] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:10636; }","duration":"614.65821ms","start":"2026-04-17T19:09:23.199772Z","end":"2026-04-17T19:09:23.81443Z","steps":["trace[1783506581] 'agreement among raft nodes before linearized reading' (duration: 614.589718ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:23.814444Z","caller":"traceutil/trace.go:171","msg":"trace[1349510561] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:10636; }","duration":"749.479626ms","start":"2026-04-17T19:09:23.064956Z","end":"2026-04-17T19:09:23.814436Z","steps":["trace[1349510561] 'agreement among raft nodes before linearized reading' (duration: 749.422594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.814457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.075193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-17T19:09:23.814462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:23.064921Z","time spent":"749.536068ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T19:09:23.814459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:23.199751Z","time spent":"614.702682ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-17T19:09:23.814479Z","caller":"traceutil/trace.go:171","msg":"trace[304034923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:10636; }","duration":"491.139526ms","start":"2026-04-17T19:09:23.323333Z","end":"2026-04-17T19:09:23.814473Z","steps":["trace[304034923] 'agreement among raft nodes before linearized reading' (duration: 491.077384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.814486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.030924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-17T19:09:23.814494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:23.323298Z","time spent":"491.192848ms","remote":"127.0.0.1:39852","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-17T19:09:23.814368Z","caller":"traceutil/trace.go:171","msg":"trace[456420230] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5xbjt; range_end:; response_count:1; response_revision:10636; }","duration":"642.428567ms","start":"2026-04-17T19:09:23.171933Z","end":"2026-04-17T19:09:23.814361Z","steps":["trace[456420230] 'agreement among raft nodes before linearized reading' (duration: 642.343065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.814485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:22.79252Z","time spent":"1.021869846s","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T19:09:23.814521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:23.171912Z","time spent":"642.603822ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-5xbjt\" "} {"level":"info","ts":"2026-04-17T19:09:23.814518Z","caller":"traceutil/trace.go:171","msg":"trace[636327296] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:10636; }","duration":"431.111676ms","start":"2026-04-17T19:09:23.383395Z","end":"2026-04-17T19:09:23.814507Z","steps":["trace[636327296] 'agreement among raft nodes before linearized reading' (duration: 430.963222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.814753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:23.383362Z","time spent":"431.375483ms","remote":"127.0.0.1:39852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-17T19:09:23.814347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.318872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/ingress-nginx/ingress-nginx-controller-cbbld.18a73950bd4a3184\" ","response":"range_response_count:1 size:765"} {"level":"info","ts":"2026-04-17T19:09:23.814854Z","caller":"traceutil/trace.go:171","msg":"trace[11721937] range","detail":"{range_begin:/registry/events/ingress-nginx/ingress-nginx-controller-cbbld.18a73950bd4a3184; range_end:; response_count:1; response_revision:10636; }","duration":"630.834917ms","start":"2026-04-17T19:09:23.184004Z","end":"2026-04-17T19:09:23.814839Z","steps":["trace[11721937] 'agreement among raft nodes before linearized reading' (duration: 630.269912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:09:23.814892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T19:09:23.183908Z","time spent":"630.97629ms","remote":"127.0.0.1:39658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":788,"request content":"key:\"/registry/events/ingress-nginx/ingress-nginx-controller-cbbld.18a73950bd4a3184\" "} {"level":"warn","ts":"2026-04-17T19:09:23.814583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.528042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T19:09:23.814933Z","caller":"traceutil/trace.go:171","msg":"trace[1037930529] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:10636; }","duration":"124.928333ms","start":"2026-04-17T19:09:23.689993Z","end":"2026-04-17T19:09:23.814921Z","steps":["trace[1037930529] 'agreement among raft nodes before linearized reading' (duration: 124.542173ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:24.105959Z","caller":"traceutil/trace.go:171","msg":"trace[933020745] transaction","detail":"{read_only:false; response_revision:10651; number_of_response:1; }","duration":"148.413312ms","start":"2026-04-17T19:09:23.957517Z","end":"2026-04-17T19:09:24.10593Z","steps":["trace[933020745] 'process raft request' (duration: 147.58796ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:24.109849Z","caller":"traceutil/trace.go:171","msg":"trace[185078380] transaction","detail":"{read_only:false; response_revision:10652; number_of_response:1; }","duration":"150.586033ms","start":"2026-04-17T19:09:23.959224Z","end":"2026-04-17T19:09:24.10981Z","steps":["trace[185078380] 'process raft request' (duration: 150.389567ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:24.109949Z","caller":"traceutil/trace.go:171","msg":"trace[987327851] transaction","detail":"{read_only:false; response_revision:10654; number_of_response:1; }","duration":"150.280434ms","start":"2026-04-17T19:09:23.959655Z","end":"2026-04-17T19:09:24.109936Z","steps":["trace[987327851] 'process raft request' (duration: 150.13154ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:24.109985Z","caller":"traceutil/trace.go:171","msg":"trace[525364029] transaction","detail":"{read_only:false; response_revision:10655; number_of_response:1; }","duration":"150.235273ms","start":"2026-04-17T19:09:23.959719Z","end":"2026-04-17T19:09:24.109954Z","steps":["trace[525364029] 'process raft request' (duration: 150.102979ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:24.110014Z","caller":"traceutil/trace.go:171","msg":"trace[1363250638] transaction","detail":"{read_only:false; response_revision:10653; number_of_response:1; }","duration":"150.702055ms","start":"2026-04-17T19:09:23.959306Z","end":"2026-04-17T19:09:24.110008Z","steps":["trace[1363250638] 'process raft request' (duration: 150.442028ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:24.11006Z","caller":"traceutil/trace.go:171","msg":"trace[565517317] transaction","detail":"{read_only:false; response_revision:10657; number_of_response:1; }","duration":"140.156463ms","start":"2026-04-17T19:09:23.969898Z","end":"2026-04-17T19:09:24.110054Z","steps":["trace[565517317] 'process raft request' (duration: 140.000529ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:24.110036Z","caller":"traceutil/trace.go:171","msg":"trace[1636484174] transaction","detail":"{read_only:false; response_revision:10656; number_of_response:1; }","duration":"150.13486ms","start":"2026-04-17T19:09:23.959873Z","end":"2026-04-17T19:09:24.110008Z","steps":["trace[1636484174] 'process raft request' (duration: 149.981486ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:24.110072Z","caller":"traceutil/trace.go:171","msg":"trace[668353160] linearizableReadLoop","detail":"{readStateIndex:11061; appliedIndex:11055; }","duration":"149.693417ms","start":"2026-04-17T19:09:23.960355Z","end":"2026-04-17T19:09:24.110048Z","steps":["trace[668353160] 'read index received' (duration: 144.745421ms)","trace[668353160] 'applied index is now lower than readState.Index' (duration: 4.946596ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:09:24.110307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.932635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-17T19:09:24.110346Z","caller":"traceutil/trace.go:171","msg":"trace[343343560] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:10658; }","duration":"150.026497ms","start":"2026-04-17T19:09:23.960307Z","end":"2026-04-17T19:09:24.110333Z","steps":["trace[343343560] 'agreement among raft nodes before linearized reading' (duration: 149.851172ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:09:46.158411Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7851} {"level":"info","ts":"2026-04-17T19:09:46.221426Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7851,"took":"61.315125ms","hash":4128185038,"current-db-size-bytes":39313408,"current-db-size":"39 MB","current-db-size-in-use-bytes":37683200,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-04-17T19:09:46.221515Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4128185038,"revision":7851,"compact-revision":5808} {"level":"info","ts":"2026-04-17T19:12:07.740517Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000003076.wal"} {"level":"warn","ts":"2026-04-17T19:12:22.973149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.58125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T19:12:22.973384Z","caller":"traceutil/trace.go:171","msg":"trace[687371296] transaction","detail":"{read_only:false; response_revision:12087; number_of_response:1; }","duration":"131.144937ms","start":"2026-04-17T19:12:22.842213Z","end":"2026-04-17T19:12:22.973358Z","steps":["trace[687371296] 'process raft request' (duration: 16.207957ms)","trace[687371296] 'compare' (duration: 114.412956ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:12:22.973602Z","caller":"traceutil/trace.go:171","msg":"trace[2074382460] transaction","detail":"{read_only:false; response_revision:12088; number_of_response:1; }","duration":"131.269691ms","start":"2026-04-17T19:12:22.842315Z","end":"2026-04-17T19:12:22.973585Z","steps":["trace[2074382460] 'process raft request' (duration: 130.970892ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:12:22.973718Z","caller":"traceutil/trace.go:171","msg":"trace[963077333] transaction","detail":"{read_only:false; response_revision:12089; number_of_response:1; }","duration":"131.060335ms","start":"2026-04-17T19:12:22.842648Z","end":"2026-04-17T19:12:22.973709Z","steps":["trace[963077333] 'process raft request' (duration: 130.86518ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:12:22.97371Z","caller":"traceutil/trace.go:171","msg":"trace[2108289329] linearizableReadLoop","detail":"{readStateIndex:12539; appliedIndex:12536; }","duration":"129.874003ms","start":"2026-04-17T19:12:22.84382Z","end":"2026-04-17T19:12:22.973694Z","steps":["trace[2108289329] 'read index received' (duration: 14.520571ms)","trace[2108289329] 'applied index is now lower than readState.Index' (duration: 115.352122ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:12:22.973858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.066678ms","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-17T19:12:22.973915Z","caller":"traceutil/trace.go:171","msg":"trace[1528554169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12089; }","duration":"130.15063ms","start":"2026-04-17T19:12:22.843749Z","end":"2026-04-17T19:12:22.973899Z","steps":["trace[1528554169] 'agreement among raft nodes before linearized reading' (duration: 129.992186ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:12:24.985122Z","caller":"traceutil/trace.go:171","msg":"trace[456401466] transaction","detail":"{read_only:false; response_revision:12096; number_of_response:1; }","duration":"168.824167ms","start":"2026-04-17T19:12:24.816253Z","end":"2026-04-17T19:12:24.985078Z","steps":["trace[456401466] 'process raft request' (duration: 124.614957ms)","trace[456401466] 'compare' (duration: 43.87659ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:12:57.253274Z","caller":"traceutil/trace.go:171","msg":"trace[1566472587] transaction","detail":"{read_only:false; response_revision:12325; number_of_response:1; }","duration":"157.083243ms","start":"2026-04-17T19:12:57.096151Z","end":"2026-04-17T19:12:57.253234Z","steps":["trace[1566472587] 'process raft request' (duration: 156.658341ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:12:57.471704Z","caller":"traceutil/trace.go:171","msg":"trace[62005411] transaction","detail":"{read_only:false; response_revision:12326; number_of_response:1; }","duration":"215.01722ms","start":"2026-04-17T19:12:57.25666Z","end":"2026-04-17T19:12:57.471678Z","steps":["trace[62005411] 'process raft request' (duration: 182.086782ms)","trace[62005411] 'compare' (duration: 32.825896ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:12:57.52623Z","caller":"traceutil/trace.go:171","msg":"trace[2123052406] transaction","detail":"{read_only:false; response_revision:12327; number_of_response:1; }","duration":"268.98034ms","start":"2026-04-17T19:12:57.257221Z","end":"2026-04-17T19:12:57.526202Z","steps":["trace[2123052406] 'process raft request' (duration: 268.736153ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:12:57.526411Z","caller":"traceutil/trace.go:171","msg":"trace[1618240229] linearizableReadLoop","detail":"{readStateIndex:12788; appliedIndex:12785; }","duration":"261.327618ms","start":"2026-04-17T19:12:57.265068Z","end":"2026-04-17T19:12:57.526395Z","steps":["trace[1618240229] 'read index received' (duration: 173.746862ms)","trace[1618240229] 'applied index is now lower than readState.Index' (duration: 87.579966ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:12:57.526404Z","caller":"traceutil/trace.go:171","msg":"trace[440422870] transaction","detail":"{read_only:false; response_revision:12328; number_of_response:1; }","duration":"269.116463ms","start":"2026-04-17T19:12:57.257261Z","end":"2026-04-17T19:12:57.526378Z","steps":["trace[440422870] 'process raft request' (duration: 268.835976ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:12:57.526535Z","caller":"traceutil/trace.go:171","msg":"trace[1890726316] transaction","detail":"{read_only:false; response_revision:12329; number_of_response:1; }","duration":"154.861132ms","start":"2026-04-17T19:12:57.371666Z","end":"2026-04-17T19:12:57.526527Z","steps":["trace[1890726316] 'process raft request' (duration: 154.477911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:12:57.526634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.389205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:12:57.526678Z","caller":"traceutil/trace.go:171","msg":"trace[1596369468] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:12329; }","duration":"255.479667ms","start":"2026-04-17T19:12:57.271185Z","end":"2026-04-17T19:12:57.526665Z","steps":["trace[1596369468] 'agreement among raft nodes before linearized reading' (duration: 255.402245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:12:57.526816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.73017ms","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-17T19:12:57.526861Z","caller":"traceutil/trace.go:171","msg":"trace[1533696303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12329; }","duration":"261.813461ms","start":"2026-04-17T19:12:57.265036Z","end":"2026-04-17T19:12:57.52685Z","steps":["trace[1533696303] 'agreement among raft nodes before linearized reading' (duration: 261.687088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:12:57.526909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.583355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5xbjt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-17T19:12:57.526993Z","caller":"traceutil/trace.go:171","msg":"trace[401380593] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5xbjt; range_end:; response_count:1; response_revision:12329; }","duration":"253.700338ms","start":"2026-04-17T19:12:57.273269Z","end":"2026-04-17T19:12:57.52697Z","steps":["trace[401380593] 'agreement among raft nodes before linearized reading' (duration: 253.43365ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:13:07.746661Z","caller":"traceutil/trace.go:171","msg":"trace[1255164181] linearizableReadLoop","detail":"{readStateIndex:12889; appliedIndex:12887; }","duration":"171.456969ms","start":"2026-04-17T19:13:07.575184Z","end":"2026-04-17T19:13:07.746641Z","steps":["trace[1255164181] 'read index received' (duration: 40.547368ms)","trace[1255164181] 'applied index is now lower than readState.Index' (duration: 130.908801ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:13:07.746765Z","caller":"traceutil/trace.go:171","msg":"trace[184045277] transaction","detail":"{read_only:false; response_revision:12424; number_of_response:1; }","duration":"184.479398ms","start":"2026-04-17T19:13:07.562278Z","end":"2026-04-17T19:13:07.746757Z","steps":["trace[184045277] 'process raft request' (duration: 184.219921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:13:07.746976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.436416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5xbjt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-17T19:13:07.747063Z","caller":"traceutil/trace.go:171","msg":"trace[1087424529] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5xbjt; range_end:; response_count:1; response_revision:12424; }","duration":"160.549418ms","start":"2026-04-17T19:13:07.586495Z","end":"2026-04-17T19:13:07.747044Z","steps":["trace[1087424529] 'agreement among raft nodes before linearized reading' (duration: 160.392404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T19:13:07.747097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.8671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-17T19:13:07.747148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.956614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-17T19:13:07.746966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.9671ms","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-17T19:13:07.747164Z","caller":"traceutil/trace.go:171","msg":"trace[59064398] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12424; }","duration":"167.977403ms","start":"2026-04-17T19:13:07.57917Z","end":"2026-04-17T19:13:07.747147Z","steps":["trace[59064398] 'agreement among raft nodes before linearized reading' (duration: 167.841299ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:13:07.747196Z","caller":"traceutil/trace.go:171","msg":"trace[170767108] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12424; }","duration":"172.039445ms","start":"2026-04-17T19:13:07.575143Z","end":"2026-04-17T19:13:07.747183Z","steps":["trace[170767108] 'agreement among raft nodes before linearized reading' (duration: 171.881051ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:13:07.747196Z","caller":"traceutil/trace.go:171","msg":"trace[2088739868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12424; }","duration":"169.227238ms","start":"2026-04-17T19:13:07.57796Z","end":"2026-04-17T19:13:07.747187Z","steps":["trace[2088739868] 'agreement among raft nodes before linearized reading' (duration: 168.861668ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:13:07.861457Z","caller":"traceutil/trace.go:171","msg":"trace[76709451] transaction","detail":"{read_only:false; response_revision:12425; number_of_response:1; }","duration":"107.609249ms","start":"2026-04-17T19:13:07.753823Z","end":"2026-04-17T19:13:07.861432Z","steps":["trace[76709451] 'process raft request' (duration: 85.074867ms)","trace[76709451] 'compare' (duration: 22.300985ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T19:13:07.87812Z","caller":"traceutil/trace.go:171","msg":"trace[842722566] transaction","detail":"{read_only:false; response_revision:12427; number_of_response:1; }","duration":"124.137434ms","start":"2026-04-17T19:13:07.753952Z","end":"2026-04-17T19:13:07.878089Z","steps":["trace[842722566] 'process raft request' (duration: 124.030251ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:13:07.87812Z","caller":"traceutil/trace.go:171","msg":"trace[2046072251] transaction","detail":"{read_only:false; response_revision:12426; number_of_response:1; }","duration":"124.212486ms","start":"2026-04-17T19:13:07.753858Z","end":"2026-04-17T19:13:07.87807Z","steps":["trace[2046072251] 'process raft request' (duration: 123.961039ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:13:08.551886Z","caller":"traceutil/trace.go:171","msg":"trace[1074915920] transaction","detail":"{read_only:false; response_revision:12431; number_of_response:1; }","duration":"161.286469ms","start":"2026-04-17T19:13:08.390573Z","end":"2026-04-17T19:13:08.55186Z","steps":["trace[1074915920] 'process raft request' (duration: 161.045802ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:14:17.691903Z","caller":"traceutil/trace.go:171","msg":"trace[1827842352] linearizableReadLoop","detail":"{readStateIndex:13621; appliedIndex:13620; }","duration":"129.312457ms","start":"2026-04-17T19:14:17.56256Z","end":"2026-04-17T19:14:17.691873Z","steps":["trace[1827842352] 'read index received' (duration: 128.907915ms)","trace[1827842352] 'applied index is now lower than readState.Index' (duration: 402.952µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T19:14:17.692091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.517033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T19:14:17.692066Z","caller":"traceutil/trace.go:171","msg":"trace[387581920] transaction","detail":"{read_only:false; response_revision:13136; number_of_response:1; }","duration":"133.095851ms","start":"2026-04-17T19:14:17.558916Z","end":"2026-04-17T19:14:17.692012Z","steps":["trace[387581920] 'process raft request' (duration: 132.68036ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:14:17.692135Z","caller":"traceutil/trace.go:171","msg":"trace[1154625579] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:13136; }","duration":"129.636805ms","start":"2026-04-17T19:14:17.562486Z","end":"2026-04-17T19:14:17.692123Z","steps":["trace[1154625579] 'agreement among raft nodes before linearized reading' (duration: 129.535813ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T19:14:46.16823Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10841} {"level":"info","ts":"2026-04-17T19:14:46.288761Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10841,"took":"117.337677ms","hash":143014243,"current-db-size-bytes":42950656,"current-db-size":"43 MB","current-db-size-in-use-bytes":25534464,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-17T19:14:46.288944Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":143014243,"revision":10841,"compact-revision":7851} {"level":"info","ts":"2026-04-17T19:19:46.174059Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13349} {"level":"info","ts":"2026-04-17T19:19:46.25633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13349,"took":"80.309741ms","hash":3888744569,"current-db-size-bytes":42950656,"current-db-size":"43 MB","current-db-size-in-use-bytes":24334336,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-17T19:19:46.256417Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3888744569,"revision":13349,"compact-revision":10841} {"level":"info","ts":"2026-04-17T19:24:46.180832Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15228} {"level":"info","ts":"2026-04-17T19:24:46.254531Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15228,"took":"70.968757ms","hash":258714826,"current-db-size-bytes":42950656,"current-db-size":"43 MB","current-db-size-in-use-bytes":19709952,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-17T19:24:46.254613Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":258714826,"revision":15228,"compact-revision":13349}