{"level":"warn","ts":"2026-04-02T16:45:54.292329Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-02T16:45:54.292408Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-04-02T16:45:54.292471Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-02T16:45:54.292484Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]}
{"level":"info","ts":"2026-04-02T16:45:54.2925Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-02T16:45:54.293113Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]}
{"level":"info","ts":"2026-04-02T16:45:54.293187Z","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.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-04-02T16:45:54.296791Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.37889ms"}
{"level":"info","ts":"2026-04-02T16:45:54.302544Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"}
{"level":"info","ts":"2026-04-02T16:45:54.302618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-02T16:45:54.302641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"}
{"level":"info","ts":"2026-04-02T16:45:54.302659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-02T16:45:54.302668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"}
{"level":"info","ts":"2026-04-02T16:45:54.302709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"}
{"level":"warn","ts":"2026-04-02T16:45:54.309108Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-02T16:45:54.310842Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-02T16:45:54.312184Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-04-02T16:45:54.314696Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-02T16:45:54.317316Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-02T16:45:54.316242Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-02T16:45:54.317602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"}
{"level":"info","ts":"2026-04-02T16:45:54.317768Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-02T16:45:54.317933Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-04-02T16:45:54.31861Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]}
{"level":"info","ts":"2026-04-02T16:45:54.319944Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-04-02T16:45:54.320118Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"}
{"level":"info","ts":"2026-04-02T16:45:54.320185Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"}
{"level":"info","ts":"2026-04-02T16:45:54.320647Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-02T16:45:54.320765Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-02T16:45:55.203387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-02T16:45:55.203442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-02T16:45:55.203476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"}
{"level":"info","ts":"2026-04-02T16:45:55.203492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"}
{"level":"info","ts":"2026-04-02T16:45:55.203502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"}
{"level":"info","ts":"2026-04-02T16:45:55.203515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"}
{"level":"info","ts":"2026-04-02T16:45:55.203531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"}
{"level":"info","ts":"2026-04-02T16:45:55.204528Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-02T16:45:55.205224Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-02T16:45:55.20523Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-02T16:45:55.205269Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-02T16:45:55.205589Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-02T16:45:55.205678Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-02T16:45:55.205657Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-02T16:45:55.20578Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-02T16:45:55.205818Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-02T16:45:55.207387Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-02T16:45:55.209763Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"}
{"level":"info","ts":"2026-04-02T16:46:24.556357Z","caller":"traceutil/trace.go:171","msg":"trace[519603292] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"289.802949ms","start":"2026-04-02T16:46:24.266516Z","end":"2026-04-02T16:46:24.556319Z","steps":["trace[519603292] 'process raft request'  (duration: 230.843437ms)","trace[519603292] 'compare'  (duration: 58.786498ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T16:46:24.557093Z","caller":"traceutil/trace.go:171","msg":"trace[1584310550] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"246.85682ms","start":"2026-04-02T16:46:24.310206Z","end":"2026-04-02T16:46:24.557062Z","steps":["trace[1584310550] 'process raft request'  (duration: 246.374009ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:46:24.557604Z","caller":"traceutil/trace.go:171","msg":"trace[1745150613] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"218.46008ms","start":"2026-04-02T16:46:24.339106Z","end":"2026-04-02T16:46:24.557566Z","steps":["trace[1745150613] 'process raft request'  (duration: 217.921047ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:46:30.33698Z","caller":"traceutil/trace.go:171","msg":"trace[1144203063] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"130.348673ms","start":"2026-04-02T16:46:30.206605Z","end":"2026-04-02T16:46:30.336954Z","steps":["trace[1144203063] 'read index received'  (duration: 128.12084ms)","trace[1144203063] 'applied index is now lower than readState.Index'  (duration: 2.226822ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T16:46:30.338555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.89566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pgnvj\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-04-02T16:46:30.338964Z","caller":"traceutil/trace.go:171","msg":"trace[1433870199] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pgnvj; range_end:; response_count:1; response_revision:575; }","duration":"132.34438ms","start":"2026-04-02T16:46:30.206567Z","end":"2026-04-02T16:46:30.338911Z","steps":["trace[1433870199] 'agreement among raft nodes before linearized reading'  (duration: 130.490866ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:46:30.338646Z","caller":"traceutil/trace.go:171","msg":"trace[577055385] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"261.428873ms","start":"2026-04-02T16:46:30.077139Z","end":"2026-04-02T16:46:30.338568Z","steps":["trace[577055385] 'process raft request'  (duration: 258.383041ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:46:46.486523Z","caller":"traceutil/trace.go:171","msg":"trace[219281395] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"170.673546ms","start":"2026-04-02T16:46:46.315812Z","end":"2026-04-02T16:46:46.486485Z","steps":["trace[219281395] 'process raft request'  (duration: 170.494532ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:47:58.249881Z","caller":"traceutil/trace.go:171","msg":"trace[1616701112] linearizableReadLoop","detail":"{readStateIndex:1861; appliedIndex:1860; }","duration":"111.27469ms","start":"2026-04-02T16:47:58.138574Z","end":"2026-04-02T16:47:58.249848Z","steps":["trace[1616701112] 'read index received'  (duration: 111.045544ms)","trace[1616701112] 'applied index is now lower than readState.Index'  (duration: 228.026µs)"],"step_count":2}
{"level":"info","ts":"2026-04-02T16:47:58.249951Z","caller":"traceutil/trace.go:171","msg":"trace[459432351] transaction","detail":"{read_only:false; response_revision:1792; number_of_response:1; }","duration":"182.695778ms","start":"2026-04-02T16:47:58.067221Z","end":"2026-04-02T16:47:58.249916Z","steps":["trace[459432351] 'process raft request'  (duration: 182.454323ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T16:47:58.250185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.509265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-04-02T16:47:58.250927Z","caller":"traceutil/trace.go:171","msg":"trace[240629229] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:1792; }","duration":"111.708881ms","start":"2026-04-02T16:47:58.138534Z","end":"2026-04-02T16:47:58.250243Z","steps":["trace[240629229] 'agreement among raft nodes before linearized reading'  (duration: 111.433484ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T16:47:58.365973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.045268ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988150131256396856 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:0db69d4f164b0c37>","response":"size:40"}
{"level":"info","ts":"2026-04-02T16:47:58.366088Z","caller":"traceutil/trace.go:171","msg":"trace[1873952751] linearizableReadLoop","detail":"{readStateIndex:1862; appliedIndex:1861; }","duration":"104.97161ms","start":"2026-04-02T16:47:58.261098Z","end":"2026-04-02T16:47:58.36607Z","steps":["trace[1873952751] 'read index received'  (duration: 697.817µs)","trace[1873952751] 'applied index is now lower than readState.Index'  (duration: 104.272313ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T16:47:58.366463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.312908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-02T16:47:58.36656Z","caller":"traceutil/trace.go:171","msg":"trace[1923553324] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1792; }","duration":"105.458572ms","start":"2026-04-02T16:47:58.261079Z","end":"2026-04-02T16:47:58.366538Z","steps":["trace[1923553324] 'agreement among raft nodes before linearized reading'  (duration: 105.070753ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:47:58.600296Z","caller":"traceutil/trace.go:171","msg":"trace[942796007] transaction","detail":"{read_only:false; response_revision:1795; number_of_response:1; }","duration":"169.776239ms","start":"2026-04-02T16:47:58.430497Z","end":"2026-04-02T16:47:58.600273Z","steps":["trace[942796007] 'process raft request'  (duration: 169.644976ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T16:48:36.802645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.433184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-02T16:48:36.802727Z","caller":"traceutil/trace.go:171","msg":"trace[2143690503] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2051; }","duration":"111.530916ms","start":"2026-04-02T16:48:36.691179Z","end":"2026-04-02T16:48:36.80271Z","steps":["trace[2143690503] 'count revisions from in-memory index tree'  (duration: 111.328982ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:48:42.66811Z","caller":"traceutil/trace.go:171","msg":"trace[652951864] transaction","detail":"{read_only:false; response_revision:2081; number_of_response:1; }","duration":"152.781304ms","start":"2026-04-02T16:48:42.515304Z","end":"2026-04-02T16:48:42.668086Z","steps":["trace[652951864] 'process raft request'  (duration: 152.61363ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:48:42.786533Z","caller":"traceutil/trace.go:171","msg":"trace[116721927] linearizableReadLoop","detail":"{readStateIndex:2161; appliedIndex:2159; }","duration":"243.562575ms","start":"2026-04-02T16:48:42.542931Z","end":"2026-04-02T16:48:42.786493Z","steps":["trace[116721927] 'read index received'  (duration: 125.02656ms)","trace[116721927] 'applied index is now lower than readState.Index'  (duration: 118.534935ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T16:48:42.786606Z","caller":"traceutil/trace.go:171","msg":"trace[882722898] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"259.724831ms","start":"2026-04-02T16:48:42.526823Z","end":"2026-04-02T16:48:42.786547Z","steps":["trace[882722898] 'process raft request'  (duration: 255.799997ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T16:48:42.78666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.713258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T16:48:42.78672Z","caller":"traceutil/trace.go:171","msg":"trace[320411057] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2082; }","duration":"243.815921ms","start":"2026-04-02T16:48:42.542886Z","end":"2026-04-02T16:48:42.786702Z","steps":["trace[320411057] 'agreement among raft nodes before linearized reading'  (duration: 243.711038ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T16:48:42.786818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.688555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-02T16:48:42.786913Z","caller":"traceutil/trace.go:171","msg":"trace[485998035] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2082; }","duration":"209.824908ms","start":"2026-04-02T16:48:42.577072Z","end":"2026-04-02T16:48:42.786897Z","steps":["trace[485998035] 'agreement among raft nodes before linearized reading'  (duration: 209.618623ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T16:48:42.786964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.931676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-04-02T16:48:42.787049Z","caller":"traceutil/trace.go:171","msg":"trace[698894848] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2082; }","duration":"112.02939ms","start":"2026-04-02T16:48:42.674996Z","end":"2026-04-02T16:48:42.787025Z","steps":["trace[698894848] 'agreement among raft nodes before linearized reading'  (duration: 111.739283ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T16:50:10.958791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.366955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T16:50:10.958901Z","caller":"traceutil/trace.go:171","msg":"trace[555559812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2751; }","duration":"180.511808ms","start":"2026-04-02T16:50:10.77837Z","end":"2026-04-02T16:50:10.958882Z","steps":["trace[555559812] 'range keys from in-memory index tree'  (duration: 180.302713ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T16:50:10.958906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.681933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T16:50:10.958986Z","caller":"traceutil/trace.go:171","msg":"trace[570560652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2751; }","duration":"129.821186ms","start":"2026-04-02T16:50:10.829145Z","end":"2026-04-02T16:50:10.958966Z","steps":["trace[570560652] 'range keys from in-memory index tree'  (duration: 129.57458ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:50:11.531468Z","caller":"traceutil/trace.go:171","msg":"trace[1087682027] linearizableReadLoop","detail":"{readStateIndex:2860; appliedIndex:2859; }","duration":"305.529091ms","start":"2026-04-02T16:50:11.225914Z","end":"2026-04-02T16:50:11.531443Z","steps":["trace[1087682027] 'read index received'  (duration: 263.961107ms)","trace[1087682027] 'applied index is now lower than readState.Index'  (duration: 41.567084ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T16:50:11.531591Z","caller":"traceutil/trace.go:171","msg":"trace[329168843] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"319.205737ms","start":"2026-04-02T16:50:11.212374Z","end":"2026-04-02T16:50:11.53158Z","steps":["trace[329168843] 'process raft request'  (duration: 277.52296ms)","trace[329168843] 'compare'  (duration: 41.435042ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T16:50:11.532039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.837756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-04-02T16:50:11.532086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:50:11.212348Z","time spent":"319.269638ms","remote":"127.0.0.1:47152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2744 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-02T16:50:11.532133Z","caller":"traceutil/trace.go:171","msg":"trace[676509614] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2753; }","duration":"241.97777ms","start":"2026-04-02T16:50:11.290132Z","end":"2026-04-02T16:50:11.53211Z","steps":["trace[676509614] 'agreement among raft nodes before linearized reading'  (duration: 241.728364ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T16:50:11.532082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.154646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-02T16:50:11.532313Z","caller":"traceutil/trace.go:171","msg":"trace[2097237459] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2753; }","duration":"306.437332ms","start":"2026-04-02T16:50:11.225854Z","end":"2026-04-02T16:50:11.532292Z","steps":["trace[2097237459] 'agreement among raft nodes before linearized reading'  (duration: 306.067284ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T16:50:11.532458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T16:50:11.225823Z","time spent":"306.620547ms","remote":"127.0.0.1:47152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-02T16:54:09.117358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.523877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-04-02T16:54:09.117457Z","caller":"traceutil/trace.go:171","msg":"trace[1739964697] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4949; }","duration":"147.683671ms","start":"2026-04-02T16:54:08.969753Z","end":"2026-04-02T16:54:09.117437Z","steps":["trace[1739964697] 'range keys from in-memory index tree'  (duration: 147.334402ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:54:16.832588Z","caller":"traceutil/trace.go:171","msg":"trace[466554254] linearizableReadLoop","detail":"{readStateIndex:5294; appliedIndex:5291; }","duration":"119.67494ms","start":"2026-04-02T16:54:16.712883Z","end":"2026-04-02T16:54:16.832557Z","steps":["trace[466554254] 'read index received'  (duration: 58.093349ms)","trace[466554254] 'applied index is now lower than readState.Index'  (duration: 61.580491ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T16:54:16.832704Z","caller":"traceutil/trace.go:171","msg":"trace[13227661] transaction","detail":"{read_only:false; response_revision:5096; number_of_response:1; }","duration":"123.239486ms","start":"2026-04-02T16:54:16.709438Z","end":"2026-04-02T16:54:16.832677Z","steps":["trace[13227661] 'process raft request'  (duration: 104.331284ms)","trace[13227661] 'compare'  (duration: 18.594055ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T16:54:16.832927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.013368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:9 size:368403"}
{"level":"info","ts":"2026-04-02T16:54:16.833012Z","caller":"traceutil/trace.go:171","msg":"trace[1213443971] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:9; response_revision:5097; }","duration":"120.107361ms","start":"2026-04-02T16:54:16.712857Z","end":"2026-04-02T16:54:16.832965Z","steps":["trace[1213443971] 'agreement among raft nodes before linearized reading'  (duration: 119.810704ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:54:25.814995Z","caller":"traceutil/trace.go:171","msg":"trace[1059256055] transaction","detail":"{read_only:false; response_revision:5280; number_of_response:1; }","duration":"212.900649ms","start":"2026-04-02T16:54:25.602061Z","end":"2026-04-02T16:54:25.814961Z","steps":["trace[1059256055] 'process raft request'  (duration: 126.901124ms)","trace[1059256055] 'compare'  (duration: 85.651697ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T16:54:25.81509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.740141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T16:54:25.815167Z","caller":"traceutil/trace.go:171","msg":"trace[1252097870] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:5280; }","duration":"175.864304ms","start":"2026-04-02T16:54:25.639282Z","end":"2026-04-02T16:54:25.815146Z","steps":["trace[1252097870] 'agreement among raft nodes before linearized reading'  (duration: 175.684209ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:54:25.815154Z","caller":"traceutil/trace.go:171","msg":"trace[166155939] linearizableReadLoop","detail":"{readStateIndex:5481; appliedIndex:5480; }","duration":"175.638958ms","start":"2026-04-02T16:54:25.639323Z","end":"2026-04-02T16:54:25.814962Z","steps":["trace[166155939] 'read index received'  (duration: 89.616303ms)","trace[166155939] 'applied index is now lower than readState.Index'  (duration: 86.020665ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T16:54:25.815445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.721859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-0\" ","response":"range_response_count:1 size:5834"}
{"level":"info","ts":"2026-04-02T16:54:25.815943Z","caller":"traceutil/trace.go:171","msg":"trace[2023304120] range","detail":"{range_begin:/registry/pods/monitoring/loki-0; range_end:; response_count:1; response_revision:5280; }","duration":"173.021416ms","start":"2026-04-02T16:54:25.642667Z","end":"2026-04-02T16:54:25.815689Z","steps":["trace[2023304120] 'agreement among raft nodes before linearized reading'  (duration: 172.619757ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:54:25.963371Z","caller":"traceutil/trace.go:171","msg":"trace[1634865750] transaction","detail":"{read_only:false; response_revision:5281; number_of_response:1; }","duration":"138.48544ms","start":"2026-04-02T16:54:25.824844Z","end":"2026-04-02T16:54:25.96333Z","steps":["trace[1634865750] 'process raft request'  (duration: 96.734213ms)","trace[1634865750] 'compare'  (duration: 41.573203ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T16:54:37.127654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.411407ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988150131256405674 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5439 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T16:54:37.12782Z","caller":"traceutil/trace.go:171","msg":"trace[865946700] transaction","detail":"{read_only:false; response_revision:5468; number_of_response:1; }","duration":"264.77522ms","start":"2026-04-02T16:54:36.863033Z","end":"2026-04-02T16:54:37.127808Z","steps":["trace[865946700] 'process raft request'  (duration: 264.695308ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:54:37.127908Z","caller":"traceutil/trace.go:171","msg":"trace[883124049] transaction","detail":"{read_only:false; response_revision:5467; number_of_response:1; }","duration":"265.095797ms","start":"2026-04-02T16:54:36.862775Z","end":"2026-04-02T16:54:37.127871Z","steps":["trace[883124049] 'process raft request'  (duration: 24.397113ms)","trace[883124049] 'compare'  (duration: 240.274824ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T16:54:37.128108Z","caller":"traceutil/trace.go:171","msg":"trace[1914774363] linearizableReadLoop","detail":"{readStateIndex:5674; appliedIndex:5671; }","duration":"235.900569ms","start":"2026-04-02T16:54:36.892175Z","end":"2026-04-02T16:54:37.128075Z","steps":["trace[1914774363] 'read index received'  (duration: 8.36311ms)","trace[1914774363] 'applied index is now lower than readState.Index'  (duration: 227.534719ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T16:54:37.128212Z","caller":"traceutil/trace.go:171","msg":"trace[2141541809] transaction","detail":"{read_only:false; response_revision:5469; number_of_response:1; }","duration":"239.897685ms","start":"2026-04-02T16:54:36.88829Z","end":"2026-04-02T16:54:37.128188Z","steps":["trace[2141541809] 'process raft request'  (duration: 239.492095ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T16:54:37.12833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.146414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T16:54:37.1284Z","caller":"traceutil/trace.go:171","msg":"trace[1627689910] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:5469; }","duration":"236.252497ms","start":"2026-04-02T16:54:36.892129Z","end":"2026-04-02T16:54:37.128381Z","steps":["trace[1627689910] 'agreement among raft nodes before linearized reading'  (duration: 236.089143ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:54:37.314783Z","caller":"traceutil/trace.go:171","msg":"trace[1036603440] transaction","detail":"{read_only:false; response_revision:5471; number_of_response:1; }","duration":"177.792821ms","start":"2026-04-02T16:54:37.136961Z","end":"2026-04-02T16:54:37.314754Z","steps":["trace[1036603440] 'process raft request'  (duration: 176.222513ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:54:37.315238Z","caller":"traceutil/trace.go:171","msg":"trace[1946384358] transaction","detail":"{read_only:false; response_revision:5472; number_of_response:1; }","duration":"178.078217ms","start":"2026-04-02T16:54:37.137101Z","end":"2026-04-02T16:54:37.315179Z","steps":["trace[1946384358] 'process raft request'  (duration: 177.606506ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:54:37.315398Z","caller":"traceutil/trace.go:171","msg":"trace[1374239556] transaction","detail":"{read_only:false; response_revision:5473; number_of_response:1; }","duration":"177.928804ms","start":"2026-04-02T16:54:37.137458Z","end":"2026-04-02T16:54:37.315387Z","steps":["trace[1374239556] 'process raft request'  (duration: 177.598936ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:54:37.744048Z","caller":"traceutil/trace.go:171","msg":"trace[2127824787] transaction","detail":"{read_only:false; response_revision:5482; number_of_response:1; }","duration":"103.225668ms","start":"2026-04-02T16:54:37.640798Z","end":"2026-04-02T16:54:37.744023Z","steps":["trace[2127824787] 'process raft request'  (duration: 103.051124ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:54:37.933386Z","caller":"traceutil/trace.go:171","msg":"trace[769746257] linearizableReadLoop","detail":"{readStateIndex:5688; appliedIndex:5687; }","duration":"103.159475ms","start":"2026-04-02T16:54:37.830195Z","end":"2026-04-02T16:54:37.933355Z","steps":["trace[769746257] 'read index received'  (duration: 102.747055ms)","trace[769746257] 'applied index is now lower than readState.Index'  (duration: 410.63µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T16:54:37.933528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.306119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T16:54:37.933577Z","caller":"traceutil/trace.go:171","msg":"trace[1567242338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5483; }","duration":"103.400041ms","start":"2026-04-02T16:54:37.830166Z","end":"2026-04-02T16:54:37.933566Z","steps":["trace[1567242338] 'agreement among raft nodes before linearized reading'  (duration: 103.297738ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:54:37.933565Z","caller":"traceutil/trace.go:171","msg":"trace[1170581907] transaction","detail":"{read_only:false; response_revision:5483; number_of_response:1; }","duration":"116.147716ms","start":"2026-04-02T16:54:37.817372Z","end":"2026-04-02T16:54:37.93352Z","steps":["trace[1170581907] 'process raft request'  (duration: 115.709005ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T16:55:55.230248Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2995}
{"level":"info","ts":"2026-04-02T16:55:55.303739Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2995,"took":"71.78658ms","hash":1310754110,"current-db-size-bytes":58384384,"current-db-size":"58 MB","current-db-size-in-use-bytes":33751040,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-04-02T16:55:55.303832Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1310754110,"revision":2995,"compact-revision":-1}
{"level":"info","ts":"2026-04-02T17:00:55.236765Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6106}
{"level":"info","ts":"2026-04-02T17:00:55.328127Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6106,"took":"89.975456ms","hash":131073433,"current-db-size-bytes":58384384,"current-db-size":"58 MB","current-db-size-in-use-bytes":22953984,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-04-02T17:00:55.328241Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":131073433,"revision":6106,"compact-revision":2995}
{"level":"warn","ts":"2026-04-02T17:01:05.484496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.549272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-02T17:01:05.484591Z","caller":"traceutil/trace.go:171","msg":"trace[1773591790] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8326; }","duration":"270.700497ms","start":"2026-04-02T17:01:05.213871Z","end":"2026-04-02T17:01:05.484571Z","steps":["trace[1773591790] 'range keys from in-memory index tree'  (duration: 270.349477ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:01:34.69562Z","caller":"traceutil/trace.go:171","msg":"trace[1407949404] transaction","detail":"{read_only:false; response_revision:8537; number_of_response:1; }","duration":"140.193803ms","start":"2026-04-02T17:01:34.555402Z","end":"2026-04-02T17:01:34.695596Z","steps":["trace[1407949404] 'process raft request'  (duration: 140.04413ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:01:35.961104Z","caller":"traceutil/trace.go:171","msg":"trace[93001125] transaction","detail":"{read_only:false; response_revision:8545; number_of_response:1; }","duration":"109.955963ms","start":"2026-04-02T17:01:35.851115Z","end":"2026-04-02T17:01:35.961071Z","steps":["trace[93001125] 'process raft request'  (duration: 109.802289ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:01:46.59377Z","caller":"traceutil/trace.go:171","msg":"trace[225006693] transaction","detail":"{read_only:false; response_revision:8642; number_of_response:1; }","duration":"203.955395ms","start":"2026-04-02T17:01:46.389781Z","end":"2026-04-02T17:01:46.593736Z","steps":["trace[225006693] 'process raft request'  (duration: 176.750625ms)","trace[225006693] 'compare'  (duration: 27.007795ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:01:47.506114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.058923ms","expected-duration":"100ms","prefix":"","request":"header:<ID:988150131256414409 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/jobs/openstack/rook-ceph-detect-version\" mod_revision:8639 > success:<request_put:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" value_size:2980 >> failure:<request_range:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T17:01:47.506225Z","caller":"traceutil/trace.go:171","msg":"trace[1256714829] linearizableReadLoop","detail":"{readStateIndex:8961; appliedIndex:8960; }","duration":"186.259382ms","start":"2026-04-02T17:01:47.319949Z","end":"2026-04-02T17:01:47.506208Z","steps":["trace[1256714829] 'read index received'  (duration: 35.7µs)","trace[1256714829] 'applied index is now lower than readState.Index'  (duration: 186.222632ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:01:47.506335Z","caller":"traceutil/trace.go:171","msg":"trace[1312624447] transaction","detail":"{read_only:false; response_revision:8649; number_of_response:1; }","duration":"301.436189ms","start":"2026-04-02T17:01:47.204855Z","end":"2026-04-02T17:01:47.506291Z","steps":["trace[1312624447] 'process raft request'  (duration: 67.11958ms)","trace[1312624447] 'compare'  (duration: 233.93617ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:01:47.506537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.585641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-04-02T17:01:47.50656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:01:47.204833Z","time spent":"301.605724ms","remote":"127.0.0.1:47130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/rook-ceph-detect-version\" mod_revision:8639 > success:<request_put:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" value_size:2980 >> failure:<request_range:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" > >"}
{"level":"info","ts":"2026-04-02T17:01:47.506608Z","caller":"traceutil/trace.go:171","msg":"trace[1638504860] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8649; }","duration":"186.654831ms","start":"2026-04-02T17:01:47.319911Z","end":"2026-04-02T17:01:47.506565Z","steps":["trace[1638504860] 'agreement among raft nodes before linearized reading'  (duration: 186.382385ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:01:47.506954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.344038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-04-02T17:01:47.507015Z","caller":"traceutil/trace.go:171","msg":"trace[1111786899] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8649; }","duration":"117.444521ms","start":"2026-04-02T17:01:47.389556Z","end":"2026-04-02T17:01:47.507001Z","steps":["trace[1111786899] 'agreement among raft nodes before linearized reading'  (duration: 117.243326ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:01:47.507027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.327589ms","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-04-02T17:01:47.507367Z","caller":"traceutil/trace.go:171","msg":"trace[43147545] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8649; }","duration":"177.717188ms","start":"2026-04-02T17:01:47.32962Z","end":"2026-04-02T17:01:47.507338Z","steps":["trace[43147545] 'agreement among raft nodes before linearized reading'  (duration: 177.072612ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:01:48.152778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.788775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-02T17:01:48.152878Z","caller":"traceutil/trace.go:171","msg":"trace[944330685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8656; }","duration":"116.938259ms","start":"2026-04-02T17:01:48.035918Z","end":"2026-04-02T17:01:48.152856Z","steps":["trace[944330685] 'range keys from in-memory index tree'  (duration: 116.622912ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:01:48.385673Z","caller":"traceutil/trace.go:171","msg":"trace[1105941413] linearizableReadLoop","detail":"{readStateIndex:8971; appliedIndex:8970; }","duration":"149.150917ms","start":"2026-04-02T17:01:48.236497Z","end":"2026-04-02T17:01:48.385648Z","steps":["trace[1105941413] 'read index received'  (duration: 51.785204ms)","trace[1105941413] 'applied index is now lower than readState.Index'  (duration: 97.364303ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:01:48.386507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.002827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19382"}
{"level":"info","ts":"2026-04-02T17:01:48.386989Z","caller":"traceutil/trace.go:171","msg":"trace[1563902134] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8658; }","duration":"150.530929ms","start":"2026-04-02T17:01:48.236447Z","end":"2026-04-02T17:01:48.386978Z","steps":["trace[1563902134] 'agreement among raft nodes before linearized reading'  (duration: 149.585817ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:02:35.575651Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024e2.wal"}
{"level":"info","ts":"2026-04-02T17:02:47.870249Z","caller":"traceutil/trace.go:171","msg":"trace[1781491638] transaction","detail":"{read_only:false; response_revision:9303; number_of_response:1; }","duration":"121.397047ms","start":"2026-04-02T17:02:47.748818Z","end":"2026-04-02T17:02:47.870215Z","steps":["trace[1781491638] 'process raft request'  (duration: 121.167212ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:03:36.611067Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a847c2e9c7010db6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-02T17:03:36.619631Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-02T17:03:36.619783Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-02T17:05:21.446205Z","caller":"traceutil/trace.go:171","msg":"trace[1005003692] transaction","detail":"{read_only:false; response_revision:10449; number_of_response:1; }","duration":"100.808795ms","start":"2026-04-02T17:05:21.345359Z","end":"2026-04-02T17:05:21.446167Z","steps":["trace[1005003692] 'process raft request'  (duration: 100.650831ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:05:55.244154Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8277}
{"level":"info","ts":"2026-04-02T17:05:55.361059Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8277,"took":"115.363802ms","hash":3086737927,"current-db-size-bytes":58384384,"current-db-size":"58 MB","current-db-size-in-use-bytes":25640960,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-04-02T17:05:55.361142Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3086737927,"revision":8277,"compact-revision":6106}
{"level":"info","ts":"2026-04-02T17:10:55.250341Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10672}
{"level":"info","ts":"2026-04-02T17:10:55.331257Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10672,"took":"78.597406ms","hash":1805820828,"current-db-size-bytes":58384384,"current-db-size":"58 MB","current-db-size-in-use-bytes":20942848,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-04-02T17:10:55.331313Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1805820828,"revision":10672,"compact-revision":8277}