{"level":"warn","ts":"2026-05-27T09:51:30.834037Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T09:51:30.834173Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-05-27T09:51:30.834277Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T09:51:30.8343Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-27T09:51:30.834329Z","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-05-27T09:51:30.83527Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-05-27T09:51:30.835395Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-05-27T09:51:30.839771Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.006773ms"} {"level":"info","ts":"2026-05-27T09:51:30.846342Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-05-27T09:51:30.846527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T09:51:30.846566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-05-27T09:51:30.846585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T09:51:30.846597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-05-27T09:51:30.846658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-05-27T09:51:30.852517Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T09:51:30.853854Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T09:51:30.855425Z","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-05-27T09:51:30.858949Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T09:51:30.859174Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T09:51:30.859403Z","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-05-27T09:51:30.859514Z","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-05-27T09:51:30.859531Z","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-05-27T09:51:30.860317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-05-27T09:51:30.860629Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-27T09:51:30.865192Z","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-05-27T09:51:30.865486Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T09:51:30.865538Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T09:51:30.865629Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-27T09:51:30.865653Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-27T09:51:31.147092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T09:51:31.147189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T09:51:31.147247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-05-27T09:51:31.147461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-05-27T09:51:31.147487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-27T09:51:31.147506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-05-27T09:51:31.147614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-27T09:51:31.148833Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T09:51:31.148857Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T09:51:31.148877Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T09:51:31.148889Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T09:51:31.149094Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T09:51:31.149144Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T09:51:31.150477Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T09:51:31.150619Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T09:51:31.150686Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T09:51:31.151294Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T09:51:31.151975Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-05-27T09:51:44.746925Z","caller":"traceutil/trace.go:171","msg":"trace[620602457] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"172.248915ms","start":"2026-05-27T09:51:44.574644Z","end":"2026-05-27T09:51:44.746893Z","steps":["trace[620602457] 'process raft request' (duration: 145.314532ms)","trace[620602457] 'compare' (duration: 26.790188ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T09:51:44.954153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.578855ms","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-05-27T09:51:44.954255Z","caller":"traceutil/trace.go:171","msg":"trace[636705954] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:401; }","duration":"101.820091ms","start":"2026-05-27T09:51:44.852415Z","end":"2026-05-27T09:51:44.954235Z","steps":["trace[636705954] 'range keys from in-memory index tree' (duration: 101.425271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T09:52:11.338124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.095617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-27T09:52:11.338202Z","caller":"traceutil/trace.go:171","msg":"trace[1420524028] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:628; }","duration":"209.22515ms","start":"2026-05-27T09:52:11.128958Z","end":"2026-05-27T09:52:11.338183Z","steps":["trace[1420524028] 'range keys from in-memory index tree' (duration: 208.998294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T09:52:11.338124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.216118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T09:52:11.338252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.772001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-05-27T09:52:11.338335Z","caller":"traceutil/trace.go:171","msg":"trace[1173268156] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:628; }","duration":"224.913794ms","start":"2026-05-27T09:52:11.113402Z","end":"2026-05-27T09:52:11.338316Z","steps":["trace[1173268156] 'range keys from in-memory index tree' (duration: 224.550085ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:52:11.338282Z","caller":"traceutil/trace.go:171","msg":"trace[17933729] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:628; }","duration":"234.422524ms","start":"2026-05-27T09:52:11.103845Z","end":"2026-05-27T09:52:11.338268Z","steps":["trace[17933729] 'range keys from in-memory index tree' (duration: 234.115455ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:52:11.35591Z","caller":"traceutil/trace.go:171","msg":"trace[1647287973] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"199.595558ms","start":"2026-05-27T09:52:11.156297Z","end":"2026-05-27T09:52:11.355893Z","steps":["trace[1647287973] 'read index received' (duration: 199.375222ms)","trace[1647287973] 'applied index is now lower than readState.Index' (duration: 219.466µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T09:52:11.355951Z","caller":"traceutil/trace.go:171","msg":"trace[1903741286] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"225.338986ms","start":"2026-05-27T09:52:11.130585Z","end":"2026-05-27T09:52:11.355924Z","steps":["trace[1903741286] 'process raft request' (duration: 225.024437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T09:52:11.356042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.736022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-27T09:52:11.356072Z","caller":"traceutil/trace.go:171","msg":"trace[868381699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"199.805714ms","start":"2026-05-27T09:52:11.156257Z","end":"2026-05-27T09:52:11.356063Z","steps":["trace[868381699] 'agreement among raft nodes before linearized reading' (duration: 199.726022ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:52:11.363019Z","caller":"traceutil/trace.go:171","msg":"trace[680429542] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"130.332758ms","start":"2026-05-27T09:52:11.232668Z","end":"2026-05-27T09:52:11.363001Z","steps":["trace[680429542] 'process raft request' (duration: 129.897395ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T09:52:11.363303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.42874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-27T09:52:11.363369Z","caller":"traceutil/trace.go:171","msg":"trace[377183289] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"154.548893ms","start":"2026-05-27T09:52:11.208803Z","end":"2026-05-27T09:52:11.363351Z","steps":["trace[377183289] 'agreement among raft nodes before linearized reading' (duration: 154.43903ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:52:14.505799Z","caller":"traceutil/trace.go:171","msg":"trace[744208316] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"127.90792ms","start":"2026-05-27T09:52:14.377846Z","end":"2026-05-27T09:52:14.505754Z","steps":["trace[744208316] 'process raft request' (duration: 66.381738ms)","trace[744208316] 'compare' (duration: 60.698849ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T09:52:17.077236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.501419ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T09:52:17.077466Z","caller":"traceutil/trace.go:171","msg":"trace[1582241153] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"176.510201ms","start":"2026-05-27T09:52:16.900936Z","end":"2026-05-27T09:52:17.077446Z","steps":["trace[1582241153] 'read index received' (duration: 33.204049ms)","trace[1582241153] 'applied index is now lower than readState.Index' (duration: 143.304422ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T09:52:17.077596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.648264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T09:52:17.077637Z","caller":"traceutil/trace.go:171","msg":"trace[97821176] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:675; }","duration":"176.758908ms","start":"2026-05-27T09:52:16.900864Z","end":"2026-05-27T09:52:17.077623Z","steps":["trace[97821176] 'agreement among raft nodes before linearized reading' (duration: 176.671935ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:52:17.07759Z","caller":"traceutil/trace.go:171","msg":"trace[671776786] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"373.69263ms","start":"2026-05-27T09:52:16.703782Z","end":"2026-05-27T09:52:17.077475Z","steps":["trace[671776786] 'process raft request' (duration: 230.43099ms)","trace[671776786] 'compare' (duration: 142.065547ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T09:52:17.077815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T09:52:16.70376Z","time spent":"373.951768ms","remote":"127.0.0.1:39762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T09:52:17.593546Z","caller":"traceutil/trace.go:171","msg":"trace[152407074] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"114.625658ms","start":"2026-05-27T09:52:17.478886Z","end":"2026-05-27T09:52:17.593512Z","steps":["trace[152407074] 'process raft request' (duration: 113.909518ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:52:17.795526Z","caller":"traceutil/trace.go:171","msg":"trace[413520920] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"175.209054ms","start":"2026-05-27T09:52:17.620244Z","end":"2026-05-27T09:52:17.795453Z","steps":["trace[413520920] 'process raft request' (duration: 174.953527ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:52:17.807671Z","caller":"traceutil/trace.go:171","msg":"trace[608423601] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"144.253097ms","start":"2026-05-27T09:52:17.66339Z","end":"2026-05-27T09:52:17.807643Z","steps":["trace[608423601] 'process raft request' (duration: 144.103183ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:52:18.342173Z","caller":"traceutil/trace.go:171","msg":"trace[1020313675] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"102.703815ms","start":"2026-05-27T09:52:18.239435Z","end":"2026-05-27T09:52:18.342139Z","steps":["trace[1020313675] 'process raft request' (duration: 101.44514ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T09:52:33.840779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.904163ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T09:52:33.840957Z","caller":"traceutil/trace.go:171","msg":"trace[215870321] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:808; }","duration":"102.112428ms","start":"2026-05-27T09:52:33.738824Z","end":"2026-05-27T09:52:33.840936Z","steps":["trace[215870321] 'range keys from in-memory index tree' (duration: 101.880932ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:52:33.842772Z","caller":"traceutil/trace.go:171","msg":"trace[170389339] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:837; }","duration":"142.871869ms","start":"2026-05-27T09:52:33.699879Z","end":"2026-05-27T09:52:33.842751Z","steps":["trace[170389339] 'read index received' (duration: 142.676554ms)","trace[170389339] 'applied index is now lower than readState.Index' (duration: 194.185µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T09:52:33.842868Z","caller":"traceutil/trace.go:171","msg":"trace[2115137326] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"146.674026ms","start":"2026-05-27T09:52:33.696159Z","end":"2026-05-27T09:52:33.842833Z","steps":["trace[2115137326] 'process raft request' (duration: 146.42582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T09:52:33.843188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.275791ms","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-05-27T09:52:33.843235Z","caller":"traceutil/trace.go:171","msg":"trace[1688623877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:809; }","duration":"143.405914ms","start":"2026-05-27T09:52:33.699819Z","end":"2026-05-27T09:52:33.843225Z","steps":["trace[1688623877] 'agreement among raft nodes before linearized reading' (duration: 143.026334ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:52:34.005894Z","caller":"traceutil/trace.go:171","msg":"trace[619317936] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:838; }","duration":"106.82456ms","start":"2026-05-27T09:52:33.89905Z","end":"2026-05-27T09:52:34.005874Z","steps":["trace[619317936] 'read index received' (duration: 78.59264ms)","trace[619317936] 'applied index is now lower than readState.Index' (duration: 28.23068ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T09:52:34.006022Z","caller":"traceutil/trace.go:171","msg":"trace[1657361631] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"158.201108ms","start":"2026-05-27T09:52:33.847785Z","end":"2026-05-27T09:52:34.005986Z","steps":["trace[1657361631] 'process raft request' (duration: 129.884106ms)","trace[1657361631] 'compare' (duration: 28.099126ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T09:52:34.006065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.993185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T09:52:34.006341Z","caller":"traceutil/trace.go:171","msg":"trace[846557950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"107.307763ms","start":"2026-05-27T09:52:33.899002Z","end":"2026-05-27T09:52:34.00631Z","steps":["trace[846557950] 'agreement among raft nodes before linearized reading' (duration: 106.951773ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:53:22.210935Z","caller":"traceutil/trace.go:171","msg":"trace[627926410] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"132.30049ms","start":"2026-05-27T09:53:22.078604Z","end":"2026-05-27T09:53:22.210905Z","steps":["trace[627926410] 'process raft request' (duration: 132.128815ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:53:47.176624Z","caller":"traceutil/trace.go:171","msg":"trace[436768353] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"296.722928ms","start":"2026-05-27T09:53:46.879868Z","end":"2026-05-27T09:53:47.176591Z","steps":["trace[436768353] 'process raft request' (duration: 284.502496ms)","trace[436768353] 'compare' (duration: 11.802541ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T09:53:47.176628Z","caller":"traceutil/trace.go:171","msg":"trace[915921343] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1950; }","duration":"279.362863ms","start":"2026-05-27T09:53:46.897206Z","end":"2026-05-27T09:53:47.176569Z","steps":["trace[915921343] 'read index received' (duration: 267.183182ms)","trace[915921343] 'applied index is now lower than readState.Index' (duration: 12.178121ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T09:53:47.176871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.63546ms","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-05-27T09:53:47.176957Z","caller":"traceutil/trace.go:171","msg":"trace[530058737] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1879; }","duration":"279.761924ms","start":"2026-05-27T09:53:46.897174Z","end":"2026-05-27T09:53:47.176936Z","steps":["trace[530058737] 'agreement among raft nodes before linearized reading' (duration: 279.535608ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T09:53:47.194293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.641462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T09:53:47.194334Z","caller":"traceutil/trace.go:171","msg":"trace[1215950975] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"106.361854ms","start":"2026-05-27T09:53:47.087928Z","end":"2026-05-27T09:53:47.19429Z","steps":["trace[1215950975] 'process raft request' (duration: 106.005104ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:53:47.194403Z","caller":"traceutil/trace.go:171","msg":"trace[509903267] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1880; }","duration":"293.794286ms","start":"2026-05-27T09:53:46.900588Z","end":"2026-05-27T09:53:47.194382Z","steps":["trace[509903267] 'agreement among raft nodes before linearized reading' (duration: 293.57655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T09:53:47.194436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.996377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T09:53:47.19446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.167029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1393758f-23b7-4964-b5b9-392537edb785\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-27T09:53:47.194534Z","caller":"traceutil/trace.go:171","msg":"trace[485461381] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1880; }","duration":"139.147121ms","start":"2026-05-27T09:53:47.055357Z","end":"2026-05-27T09:53:47.194504Z","steps":["trace[485461381] 'agreement among raft nodes before linearized reading' (duration: 138.974706ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:53:47.194567Z","caller":"traceutil/trace.go:171","msg":"trace[1159325462] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1393758f-23b7-4964-b5b9-392537edb785; range_end:; response_count:1; response_revision:1880; }","duration":"111.325543ms","start":"2026-05-27T09:53:47.083215Z","end":"2026-05-27T09:53:47.19454Z","steps":["trace[1159325462] 'agreement among raft nodes before linearized reading' (duration: 110.986204ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:54:00.096379Z","caller":"traceutil/trace.go:171","msg":"trace[1720191087] linearizableReadLoop","detail":"{readStateIndex:2063; appliedIndex:2062; }","duration":"105.512501ms","start":"2026-05-27T09:53:59.990846Z","end":"2026-05-27T09:54:00.096358Z","steps":["trace[1720191087] 'read index received' (duration: 71.106749ms)","trace[1720191087] 'applied index is now lower than readState.Index' (duration: 34.404592ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T09:54:00.096603Z","caller":"traceutil/trace.go:171","msg":"trace[274377834] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"132.757873ms","start":"2026-05-27T09:53:59.963764Z","end":"2026-05-27T09:54:00.096522Z","steps":["trace[274377834] 'process raft request' (duration: 98.274538ms)","trace[274377834] 'compare' (duration: 34.230008ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T09:54:00.096754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.889281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-27T09:54:00.096816Z","caller":"traceutil/trace.go:171","msg":"trace[1801083813] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1987; }","duration":"105.998354ms","start":"2026-05-27T09:53:59.990801Z","end":"2026-05-27T09:54:00.096799Z","steps":["trace[1801083813] 'agreement among raft nodes before linearized reading' (duration: 105.815039ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:54:03.445482Z","caller":"traceutil/trace.go:171","msg":"trace[2063368771] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"126.23116ms","start":"2026-05-27T09:54:03.319224Z","end":"2026-05-27T09:54:03.445455Z","steps":["trace[2063368771] 'process raft request' (duration: 126.055925ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:54:03.446571Z","caller":"traceutil/trace.go:171","msg":"trace[713816655] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"106.644082ms","start":"2026-05-27T09:54:03.339887Z","end":"2026-05-27T09:54:03.446531Z","steps":["trace[713816655] 'process raft request' (duration: 106.519989ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:54:37.76149Z","caller":"traceutil/trace.go:171","msg":"trace[1605193460] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"122.014805ms","start":"2026-05-27T09:54:37.639453Z","end":"2026-05-27T09:54:37.761468Z","steps":["trace[1605193460] 'process raft request' (duration: 121.905032ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:54:43.625669Z","caller":"traceutil/trace.go:171","msg":"trace[560009530] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"232.451573ms","start":"2026-05-27T09:54:43.393188Z","end":"2026-05-27T09:54:43.62564Z","steps":["trace[560009530] 'process raft request' (duration: 138.06024ms)","trace[560009530] 'compare' (duration: 94.25548ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T09:55:59.010888Z","caller":"traceutil/trace.go:171","msg":"trace[1154103497] transaction","detail":"{read_only:false; response_revision:2838; number_of_response:1; }","duration":"219.491691ms","start":"2026-05-27T09:55:58.791372Z","end":"2026-05-27T09:55:59.010863Z","steps":["trace[1154103497] 'process raft request' (duration: 128.802417ms)","trace[1154103497] 'compare' (duration: 90.513499ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T09:55:59.011072Z","caller":"traceutil/trace.go:171","msg":"trace[1926847975] linearizableReadLoop","detail":"{readStateIndex:2947; appliedIndex:2945; }","duration":"110.711618ms","start":"2026-05-27T09:55:58.900326Z","end":"2026-05-27T09:55:59.011038Z","steps":["trace[1926847975] 'read index received' (duration: 19.86404ms)","trace[1926847975] 'applied index is now lower than readState.Index' (duration: 90.845588ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T09:55:59.011136Z","caller":"traceutil/trace.go:171","msg":"trace[2001777901] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"216.855635ms","start":"2026-05-27T09:55:58.794239Z","end":"2026-05-27T09:55:59.011095Z","steps":["trace[2001777901] 'process raft request' (duration: 216.583948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T09:55:59.011193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.861853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T09:55:59.011239Z","caller":"traceutil/trace.go:171","msg":"trace[1719623364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2839; }","duration":"110.950415ms","start":"2026-05-27T09:55:58.900278Z","end":"2026-05-27T09:55:59.011228Z","steps":["trace[1719623364] 'agreement among raft nodes before linearized reading' (duration: 110.878063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T09:55:59.314926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.4818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T09:55:59.31506Z","caller":"traceutil/trace.go:171","msg":"trace[307117691] transaction","detail":"{read_only:false; response_revision:2840; number_of_response:1; }","duration":"203.571164ms","start":"2026-05-27T09:55:59.111457Z","end":"2026-05-27T09:55:59.315028Z","steps":["trace[307117691] 'process raft request' (duration: 36.713414ms)","trace[307117691] 'compare' (duration: 166.327445ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T09:58:25.553508Z","caller":"traceutil/trace.go:171","msg":"trace[911758614] transaction","detail":"{read_only:false; response_revision:3812; number_of_response:1; }","duration":"113.121213ms","start":"2026-05-27T09:58:25.440353Z","end":"2026-05-27T09:58:25.553474Z","steps":["trace[911758614] 'process raft request' (duration: 112.752762ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:58:25.694258Z","caller":"traceutil/trace.go:171","msg":"trace[1035764833] transaction","detail":"{read_only:false; response_revision:3813; number_of_response:1; }","duration":"137.692613ms","start":"2026-05-27T09:58:25.55653Z","end":"2026-05-27T09:58:25.694222Z","steps":["trace[1035764833] 'process raft request' (duration: 137.465416ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:58:25.694897Z","caller":"traceutil/trace.go:171","msg":"trace[78622132] transaction","detail":"{read_only:false; response_revision:3814; number_of_response:1; }","duration":"136.5547ms","start":"2026-05-27T09:58:25.558313Z","end":"2026-05-27T09:58:25.694868Z","steps":["trace[78622132] 'process raft request' (duration: 136.424487ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:59:48.274178Z","caller":"traceutil/trace.go:171","msg":"trace[239874238] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"126.82248ms","start":"2026-05-27T09:59:48.147336Z","end":"2026-05-27T09:59:48.274159Z","steps":["trace[239874238] 'process raft request' (duration: 126.504551ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:59:48.274451Z","caller":"traceutil/trace.go:171","msg":"trace[1881538365] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"126.785078ms","start":"2026-05-27T09:59:48.147656Z","end":"2026-05-27T09:59:48.274441Z","steps":["trace[1881538365] 'process raft request' (duration: 126.309415ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T09:59:52.026752Z","caller":"traceutil/trace.go:171","msg":"trace[1118651150] linearizableReadLoop","detail":"{readStateIndex:5193; appliedIndex:5192; }","duration":"126.748877ms","start":"2026-05-27T09:59:51.89998Z","end":"2026-05-27T09:59:52.026728Z","steps":["trace[1118651150] 'read index received' (duration: 126.638214ms)","trace[1118651150] 'applied index is now lower than readState.Index' (duration: 109.663µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T09:59:52.026843Z","caller":"traceutil/trace.go:171","msg":"trace[1145329198] transaction","detail":"{read_only:false; response_revision:5004; number_of_response:1; }","duration":"172.356151ms","start":"2026-05-27T09:59:51.854456Z","end":"2026-05-27T09:59:52.026812Z","steps":["trace[1145329198] 'process raft request' (duration: 172.145955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T09:59:52.026872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.874061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T09:59:52.026903Z","caller":"traceutil/trace.go:171","msg":"trace[1282263399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5004; }","duration":"126.953513ms","start":"2026-05-27T09:59:51.89994Z","end":"2026-05-27T09:59:52.026893Z","steps":["trace[1282263399] 'agreement among raft nodes before linearized reading' (duration: 126.886951ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:00:13.302977Z","caller":"traceutil/trace.go:171","msg":"trace[285682480] linearizableReadLoop","detail":"{readStateIndex:5571; appliedIndex:5570; }","duration":"217.149762ms","start":"2026-05-27T10:00:13.085805Z","end":"2026-05-27T10:00:13.302955Z","steps":["trace[285682480] 'read index received' (duration: 217.08631ms)","trace[285682480] 'applied index is now lower than readState.Index' (duration: 62.242µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:00:13.303091Z","caller":"traceutil/trace.go:171","msg":"trace[178845483] transaction","detail":"{read_only:false; response_revision:5372; number_of_response:1; }","duration":"249.08866ms","start":"2026-05-27T10:00:13.053992Z","end":"2026-05-27T10:00:13.30308Z","steps":["trace[178845483] 'process raft request' (duration: 248.827893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:00:13.303289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.44818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8b3f2a1f-002c-4f4f-900a-d0aacea6764c\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-05-27T10:00:13.303397Z","caller":"traceutil/trace.go:171","msg":"trace[62316317] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8b3f2a1f-002c-4f4f-900a-d0aacea6764c; range_end:; response_count:1; response_revision:5372; }","duration":"217.605525ms","start":"2026-05-27T10:00:13.085768Z","end":"2026-05-27T10:00:13.303374Z","steps":["trace[62316317] 'agreement among raft nodes before linearized reading' (duration: 217.390858ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:00:13.309109Z","caller":"traceutil/trace.go:171","msg":"trace[1469507537] transaction","detail":"{read_only:false; response_revision:5373; number_of_response:1; }","duration":"110.86135ms","start":"2026-05-27T10:00:13.198226Z","end":"2026-05-27T10:00:13.309087Z","steps":["trace[1469507537] 'process raft request' (duration: 110.590993ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:00:32.731264Z","caller":"traceutil/trace.go:171","msg":"trace[510697663] linearizableReadLoop","detail":"{readStateIndex:5832; appliedIndex:5831; }","duration":"425.738061ms","start":"2026-05-27T10:00:32.305507Z","end":"2026-05-27T10:00:32.731245Z","steps":["trace[510697663] 'read index received' (duration: 425.67294ms)","trace[510697663] 'applied index is now lower than readState.Index' (duration: 64.491µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:00:32.731329Z","caller":"traceutil/trace.go:171","msg":"trace[98175567] transaction","detail":"{read_only:false; response_revision:5625; number_of_response:1; }","duration":"457.073944ms","start":"2026-05-27T10:00:32.274222Z","end":"2026-05-27T10:00:32.731296Z","steps":["trace[98175567] 'process raft request' (duration: 456.902039ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:00:32.731438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.917827ms","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-05-27T10:00:32.731475Z","caller":"traceutil/trace.go:171","msg":"trace[53460895] 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:5625; }","duration":"426.00387ms","start":"2026-05-27T10:00:32.305459Z","end":"2026-05-27T10:00:32.731463Z","steps":["trace[53460895] 'agreement among raft nodes before linearized reading' (duration: 425.874946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:00:32.731501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:00:32.305419Z","time spent":"426.075701ms","remote":"127.0.0.1:39726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2104,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-05-27T10:00:32.731489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:00:32.274199Z","time spent":"457.206488ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17217,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T10:00:32.741579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.600502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T10:00:32.741634Z","caller":"traceutil/trace.go:171","msg":"trace[62657338] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5626; }","duration":"256.703164ms","start":"2026-05-27T10:00:32.484921Z","end":"2026-05-27T10:00:32.741624Z","steps":["trace[62657338] 'agreement among raft nodes before linearized reading' (duration: 256.619002ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:00:32.741636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.476727ms","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-05-27T10:00:32.741882Z","caller":"traceutil/trace.go:171","msg":"trace[606347988] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5626; }","duration":"235.725964ms","start":"2026-05-27T10:00:32.506087Z","end":"2026-05-27T10:00:32.741813Z","steps":["trace[606347988] 'agreement among raft nodes before linearized reading' (duration: 235.364614ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:00:32.741927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.386213ms","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-05-27T10:00:32.741969Z","caller":"traceutil/trace.go:171","msg":"trace[855536855] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5626; }","duration":"322.470385ms","start":"2026-05-27T10:00:32.419489Z","end":"2026-05-27T10:00:32.741959Z","steps":["trace[855536855] 'agreement among raft nodes before linearized reading' (duration: 322.345481ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:00:32.741996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:00:32.419467Z","time spent":"322.521847ms","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T10:00:32.742032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.248816ms","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-05-27T10:00:32.742115Z","caller":"traceutil/trace.go:171","msg":"trace[1211073220] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5626; }","duration":"329.389391ms","start":"2026-05-27T10:00:32.412708Z","end":"2026-05-27T10:00:32.742098Z","steps":["trace[1211073220] 'agreement among raft nodes before linearized reading' (duration: 329.210926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:00:32.742159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:00:32.412684Z","time spent":"329.466222ms","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T10:00:32.74228Z","caller":"traceutil/trace.go:171","msg":"trace[1402487887] transaction","detail":"{read_only:false; response_revision:5626; number_of_response:1; }","duration":"101.863637ms","start":"2026-05-27T10:00:32.640385Z","end":"2026-05-27T10:00:32.742249Z","steps":["trace[1402487887] 'process raft request' (duration: 100.934601ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:00:33.395486Z","caller":"traceutil/trace.go:171","msg":"trace[952884895] transaction","detail":"{read_only:false; response_revision:5634; number_of_response:1; }","duration":"109.573534ms","start":"2026-05-27T10:00:33.285869Z","end":"2026-05-27T10:00:33.395443Z","steps":["trace[952884895] 'process raft request' (duration: 109.421309ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:01:31.41206Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3016} {"level":"info","ts":"2026-05-27T10:01:31.617743Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3016,"took":"204.095898ms","hash":3969680253,"current-db-size-bytes":58531840,"current-db-size":"58 MB","current-db-size-in-use-bytes":31719424,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-27T10:01:31.61781Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3969680253,"revision":3016,"compact-revision":-1} {"level":"info","ts":"2026-05-27T10:04:27.097261Z","caller":"traceutil/trace.go:171","msg":"trace[722769408] transaction","detail":"{read_only:false; response_revision:7273; number_of_response:1; }","duration":"173.800055ms","start":"2026-05-27T10:04:26.923434Z","end":"2026-05-27T10:04:27.097234Z","steps":["trace[722769408] 'process raft request' (duration: 173.61679ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:04:30.062685Z","caller":"traceutil/trace.go:171","msg":"trace[168321659] transaction","detail":"{read_only:false; response_revision:7286; number_of_response:1; }","duration":"114.729355ms","start":"2026-05-27T10:04:29.947873Z","end":"2026-05-27T10:04:30.062603Z","steps":["trace[168321659] 'process raft request' (duration: 96.212438ms)","trace[168321659] 'compare' (duration: 17.89479ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:04:30.071217Z","caller":"traceutil/trace.go:171","msg":"trace[468334956] linearizableReadLoop","detail":"{readStateIndex:7552; appliedIndex:7550; }","duration":"108.896362ms","start":"2026-05-27T10:04:29.962296Z","end":"2026-05-27T10:04:30.071193Z","steps":["trace[468334956] 'read index received' (duration: 81.955629ms)","trace[468334956] 'applied index is now lower than readState.Index' (duration: 26.939733ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:04:30.071343Z","caller":"traceutil/trace.go:171","msg":"trace[401476371] transaction","detail":"{read_only:false; response_revision:7287; number_of_response:1; }","duration":"117.588225ms","start":"2026-05-27T10:04:29.953743Z","end":"2026-05-27T10:04:30.071332Z","steps":["trace[401476371] 'process raft request' (duration: 117.303007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:04:30.071525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.21177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T10:04:30.071603Z","caller":"traceutil/trace.go:171","msg":"trace[462685148] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:7287; }","duration":"109.347585ms","start":"2026-05-27T10:04:29.962238Z","end":"2026-05-27T10:04:30.071586Z","steps":["trace[462685148] 'agreement among raft nodes before linearized reading' (duration: 109.216712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:04:30.116865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.267646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-27T10:04:30.116961Z","caller":"traceutil/trace.go:171","msg":"trace[1716596694] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:7290; }","duration":"146.372839ms","start":"2026-05-27T10:04:29.970566Z","end":"2026-05-27T10:04:30.116939Z","steps":["trace[1716596694] 'agreement among raft nodes before linearized reading' (duration: 146.146383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:04:30.116868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.567809ms","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-05-27T10:04:30.117229Z","caller":"traceutil/trace.go:171","msg":"trace[1563859820] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7290; }","duration":"129.920959ms","start":"2026-05-27T10:04:29.987229Z","end":"2026-05-27T10:04:30.11715Z","steps":["trace[1563859820] 'agreement among raft nodes before linearized reading' (duration: 129.477717ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:04:34.414754Z","caller":"traceutil/trace.go:171","msg":"trace[1614183599] transaction","detail":"{read_only:false; response_revision:7323; number_of_response:1; }","duration":"106.645219ms","start":"2026-05-27T10:04:34.308081Z","end":"2026-05-27T10:04:34.414726Z","steps":["trace[1614183599] 'process raft request' (duration: 89.898341ms)","trace[1614183599] 'compare' (duration: 16.575474ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:06:31.418481Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6105} {"level":"info","ts":"2026-05-27T10:06:31.514487Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6105,"took":"93.991004ms","hash":1625881632,"current-db-size-bytes":58531840,"current-db-size":"58 MB","current-db-size-in-use-bytes":21749760,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-05-27T10:06:31.514533Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1625881632,"revision":6105,"compact-revision":3016} {"level":"info","ts":"2026-05-27T10:06:36.202092Z","caller":"traceutil/trace.go:171","msg":"trace[1140786236] transaction","detail":"{read_only:false; response_revision:8349; number_of_response:1; }","duration":"254.151087ms","start":"2026-05-27T10:06:35.947916Z","end":"2026-05-27T10:06:36.202067Z","steps":["trace[1140786236] 'process raft request' (duration: 253.995483ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:06:50.410661Z","caller":"traceutil/trace.go:171","msg":"trace[1998424183] transaction","detail":"{read_only:false; response_revision:8423; number_of_response:1; }","duration":"132.516811ms","start":"2026-05-27T10:06:50.2781Z","end":"2026-05-27T10:06:50.410616Z","steps":["trace[1998424183] 'process raft request' (duration: 132.334626ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:07:17.31875Z","caller":"traceutil/trace.go:171","msg":"trace[1550977898] transaction","detail":"{read_only:false; response_revision:8621; number_of_response:1; }","duration":"246.36439ms","start":"2026-05-27T10:07:17.072362Z","end":"2026-05-27T10:07:17.318727Z","steps":["trace[1550977898] 'process raft request' (duration: 246.231556ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:07:17.5125Z","caller":"traceutil/trace.go:171","msg":"trace[1870985956] linearizableReadLoop","detail":"{readStateIndex:8928; appliedIndex:8926; }","duration":"336.578489ms","start":"2026-05-27T10:07:17.17587Z","end":"2026-05-27T10:07:17.512448Z","steps":["trace[1870985956] 'read index received' (duration: 142.755316ms)","trace[1870985956] 'applied index is now lower than readState.Index' (duration: 193.822103ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:07:17.512626Z","caller":"traceutil/trace.go:171","msg":"trace[1347183987] transaction","detail":"{read_only:false; response_revision:8622; number_of_response:1; }","duration":"338.498772ms","start":"2026-05-27T10:07:17.174114Z","end":"2026-05-27T10:07:17.512613Z","steps":["trace[1347183987] 'process raft request' (duration: 248.079637ms)","trace[1347183987] 'compare' (duration: 89.993623ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T10:07:17.512728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:07:17.174076Z","time spent":"338.576834ms","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T10:07:17.51297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.47338ms","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-05-27T10:07:17.51305Z","caller":"traceutil/trace.go:171","msg":"trace[175189494] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8622; }","duration":"262.578033ms","start":"2026-05-27T10:07:17.250452Z","end":"2026-05-27T10:07:17.51303Z","steps":["trace[175189494] 'agreement among raft nodes before linearized reading' (duration: 262.390648ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:07:17.513102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.569809ms","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-05-27T10:07:17.513163Z","caller":"traceutil/trace.go:171","msg":"trace[387329383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8622; }","duration":"259.663671ms","start":"2026-05-27T10:07:17.253483Z","end":"2026-05-27T10:07:17.513147Z","steps":["trace[387329383] 'agreement among raft nodes before linearized reading' (duration: 259.539778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:07:17.51297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.103514ms","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-05-27T10:07:17.513227Z","caller":"traceutil/trace.go:171","msg":"trace[1788511474] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8622; }","duration":"337.406172ms","start":"2026-05-27T10:07:17.175802Z","end":"2026-05-27T10:07:17.513208Z","steps":["trace[1788511474] 'agreement among raft nodes before linearized reading' (duration: 337.048472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:07:17.513311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:07:17.17578Z","time spent":"337.512885ms","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T10:07:21.058418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.76465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T10:07:21.058547Z","caller":"traceutil/trace.go:171","msg":"trace[976011185] linearizableReadLoop","detail":"{readStateIndex:8949; appliedIndex:8948; }","duration":"157.322603ms","start":"2026-05-27T10:07:20.901204Z","end":"2026-05-27T10:07:21.058526Z","steps":["trace[976011185] 'read index received' (duration: 96.562µs)","trace[976011185] 'applied index is now lower than readState.Index' (duration: 157.224331ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T10:07:21.058667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.459796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T10:07:21.058705Z","caller":"traceutil/trace.go:171","msg":"trace[820581482] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8641; }","duration":"157.532519ms","start":"2026-05-27T10:07:20.90116Z","end":"2026-05-27T10:07:21.058692Z","steps":["trace[820581482] 'agreement among raft nodes before linearized reading' (duration: 157.424386ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:07:21.058701Z","caller":"traceutil/trace.go:171","msg":"trace[1056879918] transaction","detail":"{read_only:false; response_revision:8641; number_of_response:1; }","duration":"326.200949ms","start":"2026-05-27T10:07:20.732452Z","end":"2026-05-27T10:07:21.058653Z","steps":["trace[1056879918] 'process raft request' (duration: 127.092589ms)","trace[1056879918] 'compare' (duration: 198.550235ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T10:07:21.058846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:07:20.732432Z","time spent":"326.334082ms","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T10:07:31.559384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.860539ms","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-05-27T10:07:31.559496Z","caller":"traceutil/trace.go:171","msg":"trace[910012080] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8740; }","duration":"148.048784ms","start":"2026-05-27T10:07:31.411423Z","end":"2026-05-27T10:07:31.559472Z","steps":["trace[910012080] 'range keys from in-memory index tree' (duration: 147.610992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:07:31.559467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.624821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T10:07:31.559581Z","caller":"traceutil/trace.go:171","msg":"trace[284497582] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:8740; }","duration":"138.797276ms","start":"2026-05-27T10:07:31.420746Z","end":"2026-05-27T10:07:31.559543Z","steps":["trace[284497582] 'count revisions from in-memory index tree' (duration: 138.527959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:07:31.559811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.915661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"} {"level":"info","ts":"2026-05-27T10:07:31.559967Z","caller":"traceutil/trace.go:171","msg":"trace[70336373] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8740; }","duration":"273.114366ms","start":"2026-05-27T10:07:31.286828Z","end":"2026-05-27T10:07:31.559942Z","steps":["trace[70336373] 'range keys from in-memory index tree' (duration: 272.622443ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:07:31.742931Z","caller":"traceutil/trace.go:171","msg":"trace[1605986111] transaction","detail":"{read_only:false; response_revision:8742; number_of_response:1; }","duration":"177.938849ms","start":"2026-05-27T10:07:31.564953Z","end":"2026-05-27T10:07:31.742892Z","steps":["trace[1605986111] 'process raft request' (duration: 177.735984ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:07:31.743103Z","caller":"traceutil/trace.go:171","msg":"trace[761301539] linearizableReadLoop","detail":"{readStateIndex:9055; appliedIndex:9052; }","duration":"156.558251ms","start":"2026-05-27T10:07:31.586521Z","end":"2026-05-27T10:07:31.743079Z","steps":["trace[761301539] 'read index received' (duration: 2.951662ms)","trace[761301539] 'applied index is now lower than readState.Index' (duration: 153.604909ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:07:31.743212Z","caller":"traceutil/trace.go:171","msg":"trace[1029673107] transaction","detail":"{read_only:false; response_revision:8743; number_of_response:1; }","duration":"167.556069ms","start":"2026-05-27T10:07:31.575645Z","end":"2026-05-27T10:07:31.743201Z","steps":["trace[1029673107] 'process raft request' (duration: 167.178808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:07:31.743444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.181893ms","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-05-27T10:07:31.74345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.029721ms","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-05-27T10:07:31.743481Z","caller":"traceutil/trace.go:171","msg":"trace[1979127200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8743; }","duration":"155.243395ms","start":"2026-05-27T10:07:31.588228Z","end":"2026-05-27T10:07:31.743471Z","steps":["trace[1979127200] 'agreement among raft nodes before linearized reading' (duration: 155.097121ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:07:31.74349Z","caller":"traceutil/trace.go:171","msg":"trace[1769894019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8743; }","duration":"154.094703ms","start":"2026-05-27T10:07:31.589384Z","end":"2026-05-27T10:07:31.743479Z","steps":["trace[1769894019] 'agreement among raft nodes before linearized reading' (duration: 153.935568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:07:31.743548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.002045ms","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-05-27T10:07:31.743641Z","caller":"traceutil/trace.go:171","msg":"trace[1488495482] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8743; }","duration":"157.139808ms","start":"2026-05-27T10:07:31.58648Z","end":"2026-05-27T10:07:31.743619Z","steps":["trace[1488495482] 'agreement among raft nodes before linearized reading' (duration: 156.87385ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:07:31.743644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.117769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-05-27T10:07:31.743822Z","caller":"traceutil/trace.go:171","msg":"trace[1615484324] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8743; }","duration":"156.447859ms","start":"2026-05-27T10:07:31.587332Z","end":"2026-05-27T10:07:31.74378Z","steps":["trace[1615484324] 'agreement among raft nodes before linearized reading' (duration: 155.986086ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:07:35.393697Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002385.wal"} {"level":"info","ts":"2026-05-27T10:09:09.432133Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5ac240a6daec2148","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-27T10:09:09.437269Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-27T10:09:09.437351Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-27T10:11:31.423847Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8196} {"level":"info","ts":"2026-05-27T10:11:31.482064Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8196,"took":"55.737004ms","hash":1145278066,"current-db-size-bytes":58531840,"current-db-size":"58 MB","current-db-size-in-use-bytes":29753344,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-27T10:11:31.482116Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1145278066,"revision":8196,"compact-revision":6105} {"level":"info","ts":"2026-05-27T10:12:31.431091Z","caller":"traceutil/trace.go:171","msg":"trace[1176599185] transaction","detail":"{read_only:false; response_revision:11340; number_of_response:1; }","duration":"123.467067ms","start":"2026-05-27T10:12:31.307587Z","end":"2026-05-27T10:12:31.431054Z","steps":["trace[1176599185] 'process raft request' (duration: 100.712064ms)","trace[1176599185] 'compare' (duration: 22.479295ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:12:31.431303Z","caller":"traceutil/trace.go:171","msg":"trace[1815493566] transaction","detail":"{read_only:false; response_revision:11341; number_of_response:1; }","duration":"123.433096ms","start":"2026-05-27T10:12:31.307834Z","end":"2026-05-27T10:12:31.431267Z","steps":["trace[1815493566] 'process raft request' (duration: 123.116407ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:12:31.690984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.922431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/cinder-backup-64bb75dfff-4l62x.18b364724b932c67\" ","response":"range_response_count:1 size:811"} {"level":"info","ts":"2026-05-27T10:12:31.691097Z","caller":"traceutil/trace.go:171","msg":"trace[1280692074] range","detail":"{range_begin:/registry/events/openstack/cinder-backup-64bb75dfff-4l62x.18b364724b932c67; range_end:; response_count:1; response_revision:11341; }","duration":"156.046594ms","start":"2026-05-27T10:12:31.535022Z","end":"2026-05-27T10:12:31.691069Z","steps":["trace[1280692074] 'range keys from in-memory index tree' (duration: 155.697475ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:16:31.429257Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10800} {"level":"info","ts":"2026-05-27T10:16:31.510105Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10800,"took":"78.038761ms","hash":894819223,"current-db-size-bytes":58531840,"current-db-size":"58 MB","current-db-size-in-use-bytes":27160576,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-27T10:16:31.510174Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":894819223,"revision":10800,"compact-revision":8196} {"level":"info","ts":"2026-05-27T10:19:09.789891Z","caller":"traceutil/trace.go:171","msg":"trace[2127594311] linearizableReadLoop","detail":"{readStateIndex:14486; appliedIndex:14485; }","duration":"247.099593ms","start":"2026-05-27T10:19:09.542772Z","end":"2026-05-27T10:19:09.789871Z","steps":["trace[2127594311] 'read index received' (duration: 246.924158ms)","trace[2127594311] 'applied index is now lower than readState.Index' (duration: 174.375µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:19:09.789976Z","caller":"traceutil/trace.go:171","msg":"trace[1726244865] transaction","detail":"{read_only:false; response_revision:14005; number_of_response:1; }","duration":"249.553532ms","start":"2026-05-27T10:19:09.540393Z","end":"2026-05-27T10:19:09.789947Z","steps":["trace[1726244865] 'process raft request' (duration: 249.319936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:19:09.790105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.31909ms","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-05-27T10:19:09.790166Z","caller":"traceutil/trace.go:171","msg":"trace[753476206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14005; }","duration":"247.412802ms","start":"2026-05-27T10:19:09.542739Z","end":"2026-05-27T10:19:09.790152Z","steps":["trace[753476206] 'agreement among raft nodes before linearized reading' (duration: 247.234717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:19:09.814395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.165601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-27T10:19:09.814523Z","caller":"traceutil/trace.go:171","msg":"trace[367145769] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:14006; }","duration":"183.326645ms","start":"2026-05-27T10:19:09.631161Z","end":"2026-05-27T10:19:09.814488Z","steps":["trace[367145769] 'agreement among raft nodes before linearized reading' (duration: 183.060018ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:19:09.965695Z","caller":"traceutil/trace.go:171","msg":"trace[161118218] transaction","detail":"{read_only:false; response_revision:14007; number_of_response:1; }","duration":"171.578449ms","start":"2026-05-27T10:19:09.794094Z","end":"2026-05-27T10:19:09.965673Z","steps":["trace[161118218] 'process raft request' (duration: 171.431335ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:19:09.966962Z","caller":"traceutil/trace.go:171","msg":"trace[360544792] transaction","detail":"{read_only:false; response_revision:14008; number_of_response:1; }","duration":"148.53685ms","start":"2026-05-27T10:19:09.818394Z","end":"2026-05-27T10:19:09.966931Z","steps":["trace[360544792] 'process raft request' (duration: 148.269743ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:19:19.303833Z","caller":"traceutil/trace.go:171","msg":"trace[1174269269] transaction","detail":"{read_only:false; response_revision:14174; number_of_response:1; }","duration":"225.233897ms","start":"2026-05-27T10:19:19.078572Z","end":"2026-05-27T10:19:19.303806Z","steps":["trace[1174269269] 'process raft request' (duration: 225.022091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:20:48.167512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.927663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-05-27T10:20:48.167613Z","caller":"traceutil/trace.go:171","msg":"trace[393473369] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15205; }","duration":"117.069277ms","start":"2026-05-27T10:20:48.050524Z","end":"2026-05-27T10:20:48.167593Z","steps":["trace[393473369] 'range keys from in-memory index tree' (duration: 116.738347ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:20:48.167956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.256883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T10:20:48.167986Z","caller":"traceutil/trace.go:171","msg":"trace[574382129] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15205; }","duration":"121.330055ms","start":"2026-05-27T10:20:48.046647Z","end":"2026-05-27T10:20:48.167977Z","steps":["trace[574382129] 'range keys from in-memory index tree' (duration: 121.178361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:20:48.168117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.306754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T10:20:48.168142Z","caller":"traceutil/trace.go:171","msg":"trace[431602089] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15205; }","duration":"121.334025ms","start":"2026-05-27T10:20:48.046801Z","end":"2026-05-27T10:20:48.168135Z","steps":["trace[431602089] 'range keys from in-memory index tree' (duration: 121.209222ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:20:48.16845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.482142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T10:20:48.168611Z","caller":"traceutil/trace.go:171","msg":"trace[649010044] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15205; }","duration":"120.702618ms","start":"2026-05-27T10:20:48.047881Z","end":"2026-05-27T10:20:48.168584Z","steps":["trace[649010044] 'range keys from in-memory index tree' (duration: 120.379889ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:20:48.303431Z","caller":"traceutil/trace.go:171","msg":"trace[1846703965] transaction","detail":"{read_only:false; response_revision:15206; number_of_response:1; }","duration":"191.504431ms","start":"2026-05-27T10:20:48.111903Z","end":"2026-05-27T10:20:48.303407Z","steps":["trace[1846703965] 'process raft request' (duration: 191.345417ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:20:48.435204Z","caller":"traceutil/trace.go:171","msg":"trace[1145659071] transaction","detail":"{read_only:false; response_revision:15207; number_of_response:1; }","duration":"295.807075ms","start":"2026-05-27T10:20:48.13936Z","end":"2026-05-27T10:20:48.435167Z","steps":["trace[1145659071] 'process raft request' (duration: 287.059442ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:20:48.435219Z","caller":"traceutil/trace.go:171","msg":"trace[1581603930] linearizableReadLoop","detail":"{readStateIndex:15725; appliedIndex:15723; }","duration":"181.589787ms","start":"2026-05-27T10:20:48.253593Z","end":"2026-05-27T10:20:48.435183Z","steps":["trace[1581603930] 'read index received' (duration: 49.72903ms)","trace[1581603930] 'applied index is now lower than readState.Index' (duration: 131.858997ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T10:20:48.4355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.261186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T10:20:48.435599Z","caller":"traceutil/trace.go:171","msg":"trace[537094748] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15207; }","duration":"177.405831ms","start":"2026-05-27T10:20:48.258169Z","end":"2026-05-27T10:20:48.435574Z","steps":["trace[537094748] 'agreement among raft nodes before linearized reading' (duration: 177.228346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:20:48.435606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.959147ms","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-05-27T10:20:48.435671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.321249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"warn","ts":"2026-05-27T10:20:48.435713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.506803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T10:20:48.43573Z","caller":"traceutil/trace.go:171","msg":"trace[787756968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15207; }","duration":"182.146902ms","start":"2026-05-27T10:20:48.253555Z","end":"2026-05-27T10:20:48.435702Z","steps":["trace[787756968] 'agreement among raft nodes before linearized reading' (duration: 181.747101ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:20:48.435765Z","caller":"traceutil/trace.go:171","msg":"trace[2020719987] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15207; }","duration":"133.593406ms","start":"2026-05-27T10:20:48.302156Z","end":"2026-05-27T10:20:48.43575Z","steps":["trace[2020719987] 'agreement among raft nodes before linearized reading' (duration: 133.535894ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:20:48.435716Z","caller":"traceutil/trace.go:171","msg":"trace[37623888] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15207; }","duration":"172.382181ms","start":"2026-05-27T10:20:48.263322Z","end":"2026-05-27T10:20:48.435704Z","steps":["trace[37623888] 'agreement among raft nodes before linearized reading' (duration: 172.201086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:20:48.435604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.40644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"warn","ts":"2026-05-27T10:20:48.435898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.823871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T10:20:48.435919Z","caller":"traceutil/trace.go:171","msg":"trace[1205847040] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15207; }","duration":"133.73994ms","start":"2026-05-27T10:20:48.302163Z","end":"2026-05-27T10:20:48.435903Z","steps":["trace[1205847040] 'agreement among raft nodes before linearized reading' (duration: 133.263807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:20:48.435667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.454111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T10:20:48.435924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.693375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-05-27T10:20:48.435987Z","caller":"traceutil/trace.go:171","msg":"trace[842050571] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15207; }","duration":"133.747129ms","start":"2026-05-27T10:20:48.302205Z","end":"2026-05-27T10:20:48.435952Z","steps":["trace[842050571] 'agreement among raft nodes before linearized reading' (duration: 133.42861ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:20:48.43602Z","caller":"traceutil/trace.go:171","msg":"trace[735006643] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15207; }","duration":"174.823199ms","start":"2026-05-27T10:20:48.261174Z","end":"2026-05-27T10:20:48.435997Z","steps":["trace[735006643] 'agreement among raft nodes before linearized reading' (duration: 174.601592ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:20:48.435933Z","caller":"traceutil/trace.go:171","msg":"trace[1421402962] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15207; }","duration":"133.869073ms","start":"2026-05-27T10:20:48.302053Z","end":"2026-05-27T10:20:48.435922Z","steps":["trace[1421402962] 'agreement among raft nodes before linearized reading' (duration: 133.809032ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:21:31.435863Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12893} {"level":"info","ts":"2026-05-27T10:21:31.519214Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12893,"took":"80.683858ms","hash":3726663699,"current-db-size-bytes":58531840,"current-db-size":"58 MB","current-db-size-in-use-bytes":30507008,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-27T10:21:31.51927Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3726663699,"revision":12893,"compact-revision":10800} {"level":"info","ts":"2026-05-27T10:24:29.256683Z","caller":"traceutil/trace.go:171","msg":"trace[1938248414] transaction","detail":"{read_only:false; response_revision:16874; number_of_response:1; }","duration":"702.833008ms","start":"2026-05-27T10:24:28.553827Z","end":"2026-05-27T10:24:29.25666Z","steps":["trace[1938248414] 'process raft request' (duration: 702.682834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:24:29.256826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:24:28.553804Z","time spent":"702.94823ms","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T10:24:29.257076Z","caller":"traceutil/trace.go:171","msg":"trace[824179293] linearizableReadLoop","detail":"{readStateIndex:17448; appliedIndex:17448; }","duration":"306.063032ms","start":"2026-05-27T10:24:28.950991Z","end":"2026-05-27T10:24:29.257054Z","steps":["trace[824179293] 'read index received' (duration: 306.053202ms)","trace[824179293] 'applied index is now lower than readState.Index' (duration: 7.84µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T10:24:29.257248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.239408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-27T10:24:29.257325Z","caller":"traceutil/trace.go:171","msg":"trace[490318400] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16874; }","duration":"306.362391ms","start":"2026-05-27T10:24:28.950945Z","end":"2026-05-27T10:24:29.257308Z","steps":["trace[490318400] 'agreement among raft nodes before linearized reading' (duration: 306.193826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:24:29.257364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:24:28.950926Z","time spent":"306.430112ms","remote":"127.0.0.1:39828","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-05-27T10:24:29.259844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.792558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-v2t58\" ","response":"range_response_count:1 size:9789"} {"level":"info","ts":"2026-05-27T10:24:29.259901Z","caller":"traceutil/trace.go:171","msg":"trace[189964979] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-v2t58; range_end:; response_count:1; response_revision:16876; }","duration":"308.900261ms","start":"2026-05-27T10:24:28.950987Z","end":"2026-05-27T10:24:29.259887Z","steps":["trace[189964979] 'agreement among raft nodes before linearized reading' (duration: 308.756757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:24:29.259934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:24:28.950947Z","time spent":"308.979034ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9811,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-v2t58\" "} {"level":"warn","ts":"2026-05-27T10:24:29.259982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.072757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-27T10:24:29.259979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.452953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-27T10:24:29.260032Z","caller":"traceutil/trace.go:171","msg":"trace[1321650910] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:16876; }","duration":"208.150059ms","start":"2026-05-27T10:24:29.051869Z","end":"2026-05-27T10:24:29.260019Z","steps":["trace[1321650910] 'agreement among raft nodes before linearized reading' (duration: 208.054076ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:24:29.260197Z","caller":"traceutil/trace.go:171","msg":"trace[739792818] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:16876; }","duration":"109.581087ms","start":"2026-05-27T10:24:29.150451Z","end":"2026-05-27T10:24:29.260032Z","steps":["trace[739792818] 'agreement among raft nodes before linearized reading' (duration: 109.420952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:24:29.260292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.957015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-27T10:24:29.260337Z","caller":"traceutil/trace.go:171","msg":"trace[744927671] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16876; }","duration":"264.037078ms","start":"2026-05-27T10:24:28.996289Z","end":"2026-05-27T10:24:29.260326Z","steps":["trace[744927671] 'agreement among raft nodes before linearized reading' (duration: 263.855513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:24:29.260552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.532704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-27T10:24:29.260586Z","caller":"traceutil/trace.go:171","msg":"trace[1526806779] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-endpoints; range_end:; response_count:0; response_revision:16876; }","duration":"110.595285ms","start":"2026-05-27T10:24:29.149983Z","end":"2026-05-27T10:24:29.260578Z","steps":["trace[1526806779] 'agreement among raft nodes before linearized reading' (duration: 110.538593ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:24:29.260621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.363704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"warn","ts":"2026-05-27T10:24:29.260557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.285422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-05-27T10:24:29.260657Z","caller":"traceutil/trace.go:171","msg":"trace[214185922] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:16876; }","duration":"309.571ms","start":"2026-05-27T10:24:28.951078Z","end":"2026-05-27T10:24:29.260649Z","steps":["trace[214185922] 'agreement among raft nodes before linearized reading' (duration: 309.498078ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:24:29.260677Z","caller":"traceutil/trace.go:171","msg":"trace[156040315] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:16876; }","duration":"309.424236ms","start":"2026-05-27T10:24:28.951241Z","end":"2026-05-27T10:24:29.260666Z","steps":["trace[156040315] 'agreement among raft nodes before linearized reading' (duration: 309.247411ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:24:29.26069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:24:28.951065Z","time spent":"309.618521ms","remote":"127.0.0.1:39728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":724,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"warn","ts":"2026-05-27T10:24:29.260691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.823203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-27T10:24:29.260713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:24:28.951228Z","time spent":"309.476137ms","remote":"127.0.0.1:39728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":724,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"info","ts":"2026-05-27T10:24:29.260749Z","caller":"traceutil/trace.go:171","msg":"trace[1613484680] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:0; response_revision:16876; }","duration":"109.920416ms","start":"2026-05-27T10:24:29.150811Z","end":"2026-05-27T10:24:29.260731Z","steps":["trace[1613484680] 'agreement among raft nodes before linearized reading' (duration: 109.813893ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:24:29.260739Z","caller":"traceutil/trace.go:171","msg":"trace[1660197667] transaction","detail":"{read_only:false; response_revision:16875; number_of_response:1; }","duration":"308.14668ms","start":"2026-05-27T10:24:28.952551Z","end":"2026-05-27T10:24:29.260698Z","steps":["trace[1660197667] 'process raft request' (duration: 307.04969ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:24:29.260777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.393586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-ovn-metadata-agent-default-v6wg8\" ","response":"range_response_count:1 size:15425"} {"level":"warn","ts":"2026-05-27T10:24:29.260822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.147457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-db-sync\" ","response":"range_response_count:1 size:5309"} {"level":"info","ts":"2026-05-27T10:24:29.260864Z","caller":"traceutil/trace.go:171","msg":"trace[1902554711] range","detail":"{range_begin:/registry/jobs/openstack/neutron-db-sync; range_end:; response_count:1; response_revision:16876; }","duration":"108.207569ms","start":"2026-05-27T10:24:29.152642Z","end":"2026-05-27T10:24:29.260849Z","steps":["trace[1902554711] 'agreement among raft nodes before linearized reading' (duration: 108.102256ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:24:29.260865Z","caller":"traceutil/trace.go:171","msg":"trace[878498794] range","detail":"{range_begin:/registry/pods/openstack/neutron-ovn-metadata-agent-default-v6wg8; range_end:; response_count:1; response_revision:16876; }","duration":"120.538961ms","start":"2026-05-27T10:24:29.140309Z","end":"2026-05-27T10:24:29.260848Z","steps":["trace[878498794] 'agreement among raft nodes before linearized reading' (duration: 120.256713ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:24:29.260895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T10:24:28.952454Z","time spent":"308.357346ms","remote":"127.0.0.1:39828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T10:24:30.617912Z","caller":"traceutil/trace.go:171","msg":"trace[269959759] transaction","detail":"{read_only:false; response_revision:16883; number_of_response:1; }","duration":"216.102649ms","start":"2026-05-27T10:24:30.401784Z","end":"2026-05-27T10:24:30.617887Z","steps":["trace[269959759] 'process raft request' (duration: 215.894243ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:26:31.443489Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15462} {"level":"info","ts":"2026-05-27T10:26:31.544922Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15462,"took":"97.935555ms","hash":829684133,"current-db-size-bytes":58531840,"current-db-size":"58 MB","current-db-size-in-use-bytes":31842304,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-27T10:26:31.544977Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":829684133,"revision":15462,"compact-revision":12893} {"level":"info","ts":"2026-05-27T10:26:43.880199Z","caller":"traceutil/trace.go:171","msg":"trace[1014816188] transaction","detail":"{read_only:false; response_revision:17802; number_of_response:1; }","duration":"138.737241ms","start":"2026-05-27T10:26:43.741435Z","end":"2026-05-27T10:26:43.880172Z","steps":["trace[1014816188] 'process raft request' (duration: 138.525985ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:26:44.020857Z","caller":"traceutil/trace.go:171","msg":"trace[33723347] transaction","detail":"{read_only:false; response_revision:17803; number_of_response:1; }","duration":"137.659951ms","start":"2026-05-27T10:26:43.883167Z","end":"2026-05-27T10:26:44.020827Z","steps":["trace[33723347] 'process raft request' (duration: 79.806499ms)","trace[33723347] 'compare' (duration: 57.646236ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:26:44.020982Z","caller":"traceutil/trace.go:171","msg":"trace[1622199757] linearizableReadLoop","detail":"{readStateIndex:18411; appliedIndex:18409; }","duration":"132.721235ms","start":"2026-05-27T10:26:43.888245Z","end":"2026-05-27T10:26:44.020967Z","steps":["trace[1622199757] 'read index received' (duration: 74.738259ms)","trace[1622199757] 'applied index is now lower than readState.Index' (duration: 57.981726ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:26:44.02105Z","caller":"traceutil/trace.go:171","msg":"trace[1395927125] transaction","detail":"{read_only:false; response_revision:17804; number_of_response:1; }","duration":"136.826858ms","start":"2026-05-27T10:26:43.884196Z","end":"2026-05-27T10:26:44.021023Z","steps":["trace[1395927125] 'process raft request' (duration: 136.573481ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:26:44.021109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.200745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-27T10:26:44.021142Z","caller":"traceutil/trace.go:171","msg":"trace[1410237970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17804; }","duration":"121.276457ms","start":"2026-05-27T10:26:43.899856Z","end":"2026-05-27T10:26:44.021133Z","steps":["trace[1410237970] 'agreement among raft nodes before linearized reading' (duration: 121.206265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:26:44.021165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.895829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-27T10:26:44.021216Z","caller":"traceutil/trace.go:171","msg":"trace[1846168581] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17804; }","duration":"132.976341ms","start":"2026-05-27T10:26:43.888229Z","end":"2026-05-27T10:26:44.021205Z","steps":["trace[1846168581] 'agreement among raft nodes before linearized reading' (duration: 132.816497ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:26:44.393318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.696107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-27T10:26:44.393438Z","caller":"traceutil/trace.go:171","msg":"trace[275847443] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:17805; }","duration":"139.871842ms","start":"2026-05-27T10:26:44.253537Z","end":"2026-05-27T10:26:44.393409Z","steps":["trace[275847443] 'count revisions from in-memory index tree' (duration: 139.597074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:26:44.393549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.04837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-05-27T10:26:44.393663Z","caller":"traceutil/trace.go:171","msg":"trace[1856984543] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17805; }","duration":"139.237574ms","start":"2026-05-27T10:26:44.25439Z","end":"2026-05-27T10:26:44.393627Z","steps":["trace[1856984543] 'range keys from in-memory index tree' (duration: 138.852384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:26:44.393635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.62312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-05-27T10:26:44.393655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.53373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-27T10:26:44.393723Z","caller":"traceutil/trace.go:171","msg":"trace[550155243] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:17805; }","duration":"232.759943ms","start":"2026-05-27T10:26:44.160942Z","end":"2026-05-27T10:26:44.393702Z","steps":["trace[550155243] 'count revisions from in-memory index tree' (duration: 232.531768ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:26:44.393756Z","caller":"traceutil/trace.go:171","msg":"trace[840258645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17805; }","duration":"166.667214ms","start":"2026-05-27T10:26:44.227062Z","end":"2026-05-27T10:26:44.393729Z","steps":["trace[840258645] 'range keys from in-memory index tree' (duration: 166.376456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:26:44.39386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.766735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-27T10:26:44.39391Z","caller":"traceutil/trace.go:171","msg":"trace[838514461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17805; }","duration":"171.867588ms","start":"2026-05-27T10:26:44.222028Z","end":"2026-05-27T10:26:44.393896Z","steps":["trace[838514461] 'range keys from in-memory index tree' (duration: 171.478587ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:26:44.659515Z","caller":"traceutil/trace.go:171","msg":"trace[1811980109] transaction","detail":"{read_only:false; response_revision:17806; number_of_response:1; }","duration":"261.22616ms","start":"2026-05-27T10:26:44.398262Z","end":"2026-05-27T10:26:44.659488Z","steps":["trace[1811980109] 'process raft request' (duration: 261.011785ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:26:44.683019Z","caller":"traceutil/trace.go:171","msg":"trace[723964988] linearizableReadLoop","detail":"{readStateIndex:18414; appliedIndex:18412; }","duration":"282.309275ms","start":"2026-05-27T10:26:44.400678Z","end":"2026-05-27T10:26:44.682987Z","steps":["trace[723964988] 'read index received' (duration: 258.698171ms)","trace[723964988] 'applied index is now lower than readState.Index' (duration: 23.609844ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:26:44.683423Z","caller":"traceutil/trace.go:171","msg":"trace[2085011484] transaction","detail":"{read_only:false; response_revision:17807; number_of_response:1; }","duration":"284.408753ms","start":"2026-05-27T10:26:44.399001Z","end":"2026-05-27T10:26:44.68341Z","steps":["trace[2085011484] 'process raft request' (duration: 283.841317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:26:44.683791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.105677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-server-8445588fc6-cf7qc.18b365394b3cfd38\" ","response":"range_response_count:1 size:805"} {"level":"info","ts":"2026-05-27T10:26:44.683839Z","caller":"traceutil/trace.go:171","msg":"trace[926168997] range","detail":"{range_begin:/registry/events/openstack/neutron-server-8445588fc6-cf7qc.18b365394b3cfd38; range_end:; response_count:1; response_revision:17807; }","duration":"283.205139ms","start":"2026-05-27T10:26:44.400621Z","end":"2026-05-27T10:26:44.683826Z","steps":["trace[926168997] 'agreement among raft nodes before linearized reading' (duration: 283.061495ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:26:44.862399Z","caller":"traceutil/trace.go:171","msg":"trace[27591412] transaction","detail":"{read_only:false; response_revision:17808; number_of_response:1; }","duration":"176.088315ms","start":"2026-05-27T10:26:44.686283Z","end":"2026-05-27T10:26:44.862371Z","steps":["trace[27591412] 'process raft request' (duration: 175.972762ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:26:44.862566Z","caller":"traceutil/trace.go:171","msg":"trace[653216655] linearizableReadLoop","detail":"{readStateIndex:18416; appliedIndex:18414; }","duration":"174.857431ms","start":"2026-05-27T10:26:44.687686Z","end":"2026-05-27T10:26:44.862544Z","steps":["trace[653216655] 'read index received' (duration: 75.462109ms)","trace[653216655] 'applied index is now lower than readState.Index' (duration: 99.394142ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T10:26:44.862673Z","caller":"traceutil/trace.go:171","msg":"trace[1971108723] transaction","detail":"{read_only:false; response_revision:17809; number_of_response:1; }","duration":"174.09371ms","start":"2026-05-27T10:26:44.68857Z","end":"2026-05-27T10:26:44.862663Z","steps":["trace[1971108723] 'process raft request' (duration: 173.768321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T10:26:44.862923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.225182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-27T10:26:44.862996Z","caller":"traceutil/trace.go:171","msg":"trace[140771273] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:17809; }","duration":"175.338524ms","start":"2026-05-27T10:26:44.687638Z","end":"2026-05-27T10:26:44.862976Z","steps":["trace[140771273] 'agreement among raft nodes before linearized reading' (duration: 175.154729ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T10:31:20.117956Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5ac240a6daec2148","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-27T10:31:20.123826Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-27T10:31:20.123914Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-05-27T10:31:31.46233Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17723} {"level":"info","ts":"2026-05-27T10:31:31.562894Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17723,"took":"94.742562ms","hash":1586156906,"current-db-size-bytes":58531840,"current-db-size":"58 MB","current-db-size-in-use-bytes":27746304,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-27T10:31:31.56297Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1586156906,"revision":17723,"compact-revision":15462}