{"level":"warn","ts":"2026-04-07T00:06:06.961345Z","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-07T00:06:06.961427Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.243:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.243:2380","--initial-cluster=instance=https://199.19.213.243:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.243:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.243: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-07T00:06:06.961491Z","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-07T00:06:06.961506Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.243:2380"]}
{"level":"info","ts":"2026-04-07T00:06:06.961527Z","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-07T00:06:06.962423Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"]}
{"level":"info","ts":"2026-04-07T00:06:06.962498Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.243:2380"],"listen-peer-urls":["https://199.19.213.243:2380"],"advertise-client-urls":["https://199.19.213.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.243: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-07T00:06:06.96845Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.715273ms"}
{"level":"info","ts":"2026-04-07T00:06:06.986667Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"864e14457b828f9c","cluster-id":"6c0ae60a355554b9"}
{"level":"info","ts":"2026-04-07T00:06:06.986753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=()"}
{"level":"info","ts":"2026-04-07T00:06:06.986782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became follower at term 0"}
{"level":"info","ts":"2026-04-07T00:06:06.986796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 864e14457b828f9c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-07T00:06:06.986808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became follower at term 1"}
{"level":"info","ts":"2026-04-07T00:06:06.986853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=(9677694937923227548)"}
{"level":"warn","ts":"2026-04-07T00:06:06.994007Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-07T00:06:06.995084Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-07T00:06:06.996655Z","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-07T00:06:07.000116Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"864e14457b828f9c","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-07T00:06:07.001144Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"864e14457b828f9c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-07T00:06:07.001388Z","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-07T00:06:07.00142Z","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-07T00:06:07.00143Z","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-07T00:06:07.001716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=(9677694937923227548)"}
{"level":"info","ts":"2026-04-07T00:06:07.001896Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c0ae60a355554b9","local-member-id":"864e14457b828f9c","added-peer-id":"864e14457b828f9c","added-peer-peer-urls":["https://199.19.213.243:2380"]}
{"level":"info","ts":"2026-04-07T00:06:07.008345Z","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-07T00:06:07.008595Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"864e14457b828f9c","initial-advertise-peer-urls":["https://199.19.213.243:2380"],"listen-peer-urls":["https://199.19.213.243:2380"],"advertise-client-urls":["https://199.19.213.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-07T00:06:07.008635Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-07T00:06:07.00875Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.243:2380"}
{"level":"info","ts":"2026-04-07T00:06:07.008773Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.243:2380"}
{"level":"info","ts":"2026-04-07T00:06:07.287395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c is starting a new election at term 1"}
{"level":"info","ts":"2026-04-07T00:06:07.287467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-07T00:06:07.287502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c received MsgPreVoteResp from 864e14457b828f9c at term 1"}
{"level":"info","ts":"2026-04-07T00:06:07.287525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became candidate at term 2"}
{"level":"info","ts":"2026-04-07T00:06:07.287549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c received MsgVoteResp from 864e14457b828f9c at term 2"}
{"level":"info","ts":"2026-04-07T00:06:07.287566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became leader at term 2"}
{"level":"info","ts":"2026-04-07T00:06:07.28758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 864e14457b828f9c elected leader 864e14457b828f9c at term 2"}
{"level":"info","ts":"2026-04-07T00:06:07.289873Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"864e14457b828f9c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.243:2379]}","request-path":"/0/members/864e14457b828f9c/attributes","cluster-id":"6c0ae60a355554b9","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-07T00:06:07.290069Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-07T00:06:07.290113Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-07T00:06:07.290346Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T00:06:07.291685Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c0ae60a355554b9","local-member-id":"864e14457b828f9c","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T00:06:07.291837Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T00:06:07.291883Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T00:06:07.293715Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-07T00:06:07.294014Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-07T00:06:07.294055Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-07T00:06:07.296908Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.243:2379"}
{"level":"info","ts":"2026-04-07T00:06:12.990259Z","caller":"traceutil/trace.go:171","msg":"trace[1058651484] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"118.05278ms","start":"2026-04-07T00:06:12.872177Z","end":"2026-04-07T00:06:12.99023Z","steps":["trace[1058651484] 'process raft request'  (duration: 117.884929ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:17.10763Z","caller":"traceutil/trace.go:171","msg":"trace[255588807] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"132.376511ms","start":"2026-04-07T00:06:16.975218Z","end":"2026-04-07T00:06:17.107595Z","steps":["trace[255588807] 'process raft request'  (duration: 72.996196ms)","trace[255588807] 'compare'  (duration: 59.207175ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:06:21.920241Z","caller":"traceutil/trace.go:171","msg":"trace[446810720] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:377; }","duration":"284.091948ms","start":"2026-04-07T00:06:21.636122Z","end":"2026-04-07T00:06:21.920214Z","steps":["trace[446810720] 'read index received'  (duration: 283.918077ms)","trace[446810720] 'applied index is now lower than readState.Index'  (duration: 172.281µs)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:06:21.920389Z","caller":"traceutil/trace.go:171","msg":"trace[291387166] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"358.661388ms","start":"2026-04-07T00:06:21.561715Z","end":"2026-04-07T00:06:21.920377Z","steps":["trace[291387166] 'process raft request'  (duration: 358.321077ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:06:21.920981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:06:21.5617Z","time spent":"358.719839ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4119,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:360 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4061 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >"}
{"level":"warn","ts":"2026-04-07T00:06:21.921098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.957181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-04-07T00:06:21.921247Z","caller":"traceutil/trace.go:171","msg":"trace[1644979802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:364; }","duration":"285.161921ms","start":"2026-04-07T00:06:21.636058Z","end":"2026-04-07T00:06:21.92122Z","steps":["trace[1644979802] 'agreement among raft nodes before linearized reading'  (duration: 284.96604ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:06:22.347971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.085871ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10348319102027795797 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:358 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-07T00:06:22.34814Z","caller":"traceutil/trace.go:171","msg":"trace[1278730509] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:378; }","duration":"177.489616ms","start":"2026-04-07T00:06:22.170634Z","end":"2026-04-07T00:06:22.348124Z","steps":["trace[1278730509] 'read index received'  (duration: 10.019104ms)","trace[1278730509] 'applied index is now lower than readState.Index'  (duration: 167.469302ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:06:22.348193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.560176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:06:22.348214Z","caller":"traceutil/trace.go:171","msg":"trace[62858047] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:366; }","duration":"177.616036ms","start":"2026-04-07T00:06:22.170592Z","end":"2026-04-07T00:06:22.348208Z","steps":["trace[62858047] 'agreement among raft nodes before linearized reading'  (duration: 177.574976ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:22.348321Z","caller":"traceutil/trace.go:171","msg":"trace[1785746503] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"420.71805ms","start":"2026-04-07T00:06:21.927577Z","end":"2026-04-07T00:06:22.348295Z","steps":["trace[1785746503] 'process raft request'  (duration: 253.062958ms)","trace[1785746503] 'compare'  (duration: 166.939411ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:06:22.348472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:06:21.927547Z","time spent":"420.85893ms","remote":"127.0.0.1:36924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:358 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-04-07T00:06:22.348486Z","caller":"traceutil/trace.go:171","msg":"trace[881822169] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"417.842064ms","start":"2026-04-07T00:06:21.930583Z","end":"2026-04-07T00:06:22.348425Z","steps":["trace[881822169] 'process raft request'  (duration: 417.495553ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:06:22.34863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:06:21.930549Z","time spent":"418.056005ms","remote":"127.0.0.1:36924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:359 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-07T00:06:23.203509Z","caller":"traceutil/trace.go:171","msg":"trace[1021520363] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"118.151179ms","start":"2026-04-07T00:06:23.085324Z","end":"2026-04-07T00:06:23.203475Z","steps":["trace[1021520363] 'process raft request'  (duration: 70.44617ms)","trace[1021520363] 'compare'  (duration: 47.121788ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:06:38.055498Z","caller":"traceutil/trace.go:171","msg":"trace[1852238921] transaction","detail":"{read_only:false; number_of_response:1; response_revision:495; }","duration":"146.364705ms","start":"2026-04-07T00:06:37.909114Z","end":"2026-04-07T00:06:38.055479Z","steps":["trace[1852238921] 'process raft request'  (duration: 130.483629ms)","trace[1852238921] 'compare'  (duration: 15.825516ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:06:38.056379Z","caller":"traceutil/trace.go:171","msg":"trace[148679026] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"141.306672ms","start":"2026-04-07T00:06:37.915062Z","end":"2026-04-07T00:06:38.056369Z","steps":["trace[148679026] 'process raft request'  (duration: 140.78846ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:38.056471Z","caller":"traceutil/trace.go:171","msg":"trace[1191938112] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"133.704885ms","start":"2026-04-07T00:06:37.922759Z","end":"2026-04-07T00:06:38.056464Z","steps":["trace[1191938112] 'process raft request'  (duration: 133.250694ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:38.614022Z","caller":"traceutil/trace.go:171","msg":"trace[1921569791] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:546; }","duration":"173.660037ms","start":"2026-04-07T00:06:38.440334Z","end":"2026-04-07T00:06:38.613994Z","steps":["trace[1921569791] 'read index received'  (duration: 165.133618ms)","trace[1921569791] 'applied index is now lower than readState.Index'  (duration: 8.524939ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:06:38.614177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.825887ms","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-07T00:06:38.614209Z","caller":"traceutil/trace.go:171","msg":"trace[1906747129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:526; }","duration":"173.930887ms","start":"2026-04-07T00:06:38.440269Z","end":"2026-04-07T00:06:38.6142Z","steps":["trace[1906747129] 'agreement among raft nodes before linearized reading'  (duration: 173.823667ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:38.61426Z","caller":"traceutil/trace.go:171","msg":"trace[2135622224] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"176.622543ms","start":"2026-04-07T00:06:38.437603Z","end":"2026-04-07T00:06:38.614226Z","steps":["trace[2135622224] 'process raft request'  (duration: 167.378582ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:38.614464Z","caller":"traceutil/trace.go:171","msg":"trace[1670131946] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"128.970164ms","start":"2026-04-07T00:06:38.485465Z","end":"2026-04-07T00:06:38.614435Z","steps":["trace[1670131946] 'process raft request'  (duration: 128.843414ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:38.614638Z","caller":"traceutil/trace.go:171","msg":"trace[2132163236] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"159.212743ms","start":"2026-04-07T00:06:38.455413Z","end":"2026-04-07T00:06:38.614625Z","steps":["trace[2132163236] 'process raft request'  (duration: 158.660802ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:43.809824Z","caller":"traceutil/trace.go:171","msg":"trace[1019523141] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"173.068965ms","start":"2026-04-07T00:06:43.636718Z","end":"2026-04-07T00:06:43.809787Z","steps":["trace[1019523141] 'process raft request'  (duration: 172.715365ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:44.263483Z","caller":"traceutil/trace.go:171","msg":"trace[1988833003] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"356.628635ms","start":"2026-04-07T00:06:43.906827Z","end":"2026-04-07T00:06:44.263455Z","steps":["trace[1988833003] 'process raft request'  (duration: 356.063133ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:06:44.263638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:06:43.906792Z","time spent":"356.767045ms","remote":"127.0.0.1:36758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:572 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036197 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-04-07T00:06:44.445799Z","caller":"traceutil/trace.go:171","msg":"trace[1724191912] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"127.364771ms","start":"2026-04-07T00:06:44.318386Z","end":"2026-04-07T00:06:44.445751Z","steps":["trace[1724191912] 'process raft request'  (duration: 127.03855ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:06:45.102539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.585458ms","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-07T00:06:45.102593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.954004ms","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-07T00:06:45.102639Z","caller":"traceutil/trace.go:171","msg":"trace[784876546] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:579; }","duration":"463.728478ms","start":"2026-04-07T00:06:44.638887Z","end":"2026-04-07T00:06:45.102615Z","steps":["trace[784876546] 'range keys from in-memory index tree'  (duration: 463.357098ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:06:45.102658Z","caller":"traceutil/trace.go:171","msg":"trace[1392407625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:579; }","duration":"462.040574ms","start":"2026-04-07T00:06:44.640601Z","end":"2026-04-07T00:06:45.102641Z","steps":["trace[1392407625] 'range keys from in-memory index tree'  (duration: 461.837834ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:06:45.102691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:06:44.640595Z","time spent":"462.089424ms","remote":"127.0.0.1:36924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-07T00:06:45.102689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:06:44.63887Z","time spent":"463.810418ms","remote":"127.0.0.1:36924","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-04-07T00:06:45.128625Z","caller":"traceutil/trace.go:171","msg":"trace[2116998023] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"272.933183ms","start":"2026-04-07T00:06:44.855666Z","end":"2026-04-07T00:06:45.1286Z","steps":["trace[2116998023] 'process raft request'  (duration: 272.406071ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:07:01.230701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.668441ms","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-07T00:07:01.230806Z","caller":"traceutil/trace.go:171","msg":"trace[1350026709] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:742; }","duration":"236.822071ms","start":"2026-04-07T00:07:00.993959Z","end":"2026-04-07T00:07:01.230781Z","steps":["trace[1350026709] 'range keys from in-memory index tree'  (duration: 236.32336ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:07:21.555168Z","caller":"traceutil/trace.go:171","msg":"trace[942825542] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"104.002498ms","start":"2026-04-07T00:07:21.451137Z","end":"2026-04-07T00:07:21.555139Z","steps":["trace[942825542] 'process raft request'  (duration: 103.766687ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:07:21.56838Z","caller":"traceutil/trace.go:171","msg":"trace[437031841] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"117.082848ms","start":"2026-04-07T00:07:21.451276Z","end":"2026-04-07T00:07:21.568358Z","steps":["trace[437031841] 'process raft request'  (duration: 116.885008ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:07:24.117273Z","caller":"traceutil/trace.go:171","msg":"trace[815818216] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"288.94434ms","start":"2026-04-07T00:07:23.828301Z","end":"2026-04-07T00:07:24.117245Z","steps":["trace[815818216] 'process raft request'  (duration: 288.538099ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:07:24.133277Z","caller":"traceutil/trace.go:171","msg":"trace[1180965947] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"255.054692ms","start":"2026-04-07T00:07:23.878202Z","end":"2026-04-07T00:07:24.133257Z","steps":["trace[1180965947] 'process raft request'  (duration: 255.018442ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:07:24.133315Z","caller":"traceutil/trace.go:171","msg":"trace[993910866] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"272.216901ms","start":"2026-04-07T00:07:23.861069Z","end":"2026-04-07T00:07:24.133286Z","steps":["trace[993910866] 'process raft request'  (duration: 272.03014ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:07:37.037408Z","caller":"traceutil/trace.go:171","msg":"trace[1057477018] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"115.871175ms","start":"2026-04-07T00:07:36.921502Z","end":"2026-04-07T00:07:37.037373Z","steps":["trace[1057477018] 'process raft request'  (duration: 78.243609ms)","trace[1057477018] 'compare'  (duration: 37.471115ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:08:26.578506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.18485ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10348319102027798727 > lease_revoke:<id:0f9c9d6542c19717>","response":"size:28"}
{"level":"info","ts":"2026-04-07T00:08:26.57862Z","caller":"traceutil/trace.go:171","msg":"trace[1875409312] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1934; }","duration":"390.37338ms","start":"2026-04-07T00:08:26.188227Z","end":"2026-04-07T00:08:26.578601Z","steps":["trace[1875409312] 'read index received'  (duration: 12.991169ms)","trace[1875409312] 'applied index is now lower than readState.Index'  (duration: 377.380671ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:08:26.578794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.5676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2df3bbaf-fe9a-4210-871c-c3c289c9f721\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-04-07T00:08:26.578833Z","caller":"traceutil/trace.go:171","msg":"trace[1651043833] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2df3bbaf-fe9a-4210-871c-c3c289c9f721; range_end:; response_count:1; response_revision:1860; }","duration":"390.664612ms","start":"2026-04-07T00:08:26.188158Z","end":"2026-04-07T00:08:26.578823Z","steps":["trace[1651043833] 'agreement among raft nodes before linearized reading'  (duration: 390.516712ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:26.578879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:26.188132Z","time spent":"390.738103ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2df3bbaf-fe9a-4210-871c-c3c289c9f721\" "}
{"level":"info","ts":"2026-04-07T00:08:26.698629Z","caller":"traceutil/trace.go:171","msg":"trace[370525537] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"476.571758ms","start":"2026-04-07T00:08:26.222029Z","end":"2026-04-07T00:08:26.6986Z","steps":["trace[370525537] 'process raft request'  (duration: 476.346788ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:26.698814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:26.221993Z","time spent":"476.721638ms","remote":"127.0.0.1:36924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1837 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-07T00:08:26.906052Z","caller":"traceutil/trace.go:171","msg":"trace[1997076827] linearizableReadLoop","detail":"{readStateIndex:1938; appliedIndex:1935; }","duration":"327.376497ms","start":"2026-04-07T00:08:26.578644Z","end":"2026-04-07T00:08:26.90602Z","steps":["trace[1997076827] 'read index received'  (duration: 119.797864ms)","trace[1997076827] 'applied index is now lower than readState.Index'  (duration: 207.576603ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:08:26.906065Z","caller":"traceutil/trace.go:171","msg":"trace[27764441] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"609.766701ms","start":"2026-04-07T00:08:26.296262Z","end":"2026-04-07T00:08:26.906028Z","steps":["trace[27764441] 'process raft request'  (duration: 597.963124ms)","trace[27764441] 'compare'  (duration: 11.538047ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:08:26.90628Z","caller":"traceutil/trace.go:171","msg":"trace[1805257053] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"319.62157ms","start":"2026-04-07T00:08:26.586621Z","end":"2026-04-07T00:08:26.906242Z","steps":["trace[1805257053] 'process raft request'  (duration: 319.329379ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:26.906497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:26.296229Z","time spent":"610.142782ms","remote":"127.0.0.1:36924","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:1839 > 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-07T00:08:26.906191Z","caller":"traceutil/trace.go:171","msg":"trace[967574493] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"473.46212ms","start":"2026-04-07T00:08:26.432706Z","end":"2026-04-07T00:08:26.906168Z","steps":["trace[967574493] 'process raft request'  (duration: 473.19896ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:26.906704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:26.586601Z","time spent":"319.8442ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2df3bbaf-fe9a-4210-871c-c3c289c9f721\" mod_revision:1809 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2df3bbaf-fe9a-4210-871c-c3c289c9f721\" value_size:3632 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2df3bbaf-fe9a-4210-871c-c3c289c9f721\" > >"}
{"level":"warn","ts":"2026-04-07T00:08:26.90673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.816669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:08:26.906876Z","caller":"traceutil/trace.go:171","msg":"trace[1740100502] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1864; }","duration":"503.223059ms","start":"2026-04-07T00:08:26.403628Z","end":"2026-04-07T00:08:26.906851Z","steps":["trace[1740100502] 'agreement among raft nodes before linearized reading'  (duration: 502.575167ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:26.90694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:26.4036Z","time spent":"503.32846ms","remote":"127.0.0.1:36658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-07T00:08:26.906687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:26.432669Z","time spent":"473.919622ms","remote":"127.0.0.1:36924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1840 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-07T00:08:26.906242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.753892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:08:26.907094Z","caller":"traceutil/trace.go:171","msg":"trace[1106681585] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1864; }","duration":"628.584615ms","start":"2026-04-07T00:08:26.278456Z","end":"2026-04-07T00:08:26.90704Z","steps":["trace[1106681585] 'agreement among raft nodes before linearized reading'  (duration: 627.723182ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:26.907223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:26.278376Z","time spent":"628.809405ms","remote":"127.0.0.1:37082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"warn","ts":"2026-04-07T00:08:26.906334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.734836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2df3bbaf-fe9a-4210-871c-c3c289c9f721\" ","response":"range_response_count:1 size:3747"}
{"level":"info","ts":"2026-04-07T00:08:26.907376Z","caller":"traceutil/trace.go:171","msg":"trace[96731230] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2df3bbaf-fe9a-4210-871c-c3c289c9f721; range_end:; response_count:1; response_revision:1864; }","duration":"292.799708ms","start":"2026-04-07T00:08:26.614536Z","end":"2026-04-07T00:08:26.907336Z","steps":["trace[96731230] 'agreement among raft nodes before linearized reading'  (duration: 291.722766ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:27.141919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.431213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-04-07T00:08:27.142024Z","caller":"traceutil/trace.go:171","msg":"trace[677185137] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1865; }","duration":"106.597583ms","start":"2026-04-07T00:08:27.035401Z","end":"2026-04-07T00:08:27.141999Z","steps":["trace[677185137] 'range keys from in-memory index tree'  (duration: 106.144143ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:27.639679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.100148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:08:27.639869Z","caller":"traceutil/trace.go:171","msg":"trace[1094211710] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1866; }","duration":"236.340639ms","start":"2026-04-07T00:08:27.403506Z","end":"2026-04-07T00:08:27.639847Z","steps":["trace[1094211710] 'range keys from in-memory index tree'  (duration: 236.005018ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:27.639694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.478345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-07T00:08:27.640068Z","caller":"traceutil/trace.go:171","msg":"trace[1408627370] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:1866; }","duration":"116.858466ms","start":"2026-04-07T00:08:27.523178Z","end":"2026-04-07T00:08:27.640036Z","steps":["trace[1408627370] 'count revisions from in-memory index tree'  (duration: 116.348675ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:08:40.649057Z","caller":"traceutil/trace.go:171","msg":"trace[1848955066] linearizableReadLoop","detail":"{readStateIndex:2058; appliedIndex:2056; }","duration":"245.06732ms","start":"2026-04-07T00:08:40.403951Z","end":"2026-04-07T00:08:40.649018Z","steps":["trace[1848955066] 'read index received'  (duration: 244.592829ms)","trace[1848955066] 'applied index is now lower than readState.Index'  (duration: 472.871µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:08:40.649255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.28476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:08:40.64962Z","caller":"traceutil/trace.go:171","msg":"trace[461962206] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1980; }","duration":"245.719521ms","start":"2026-04-07T00:08:40.403881Z","end":"2026-04-07T00:08:40.6496Z","steps":["trace[461962206] 'agreement among raft nodes before linearized reading'  (duration: 245.28733ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:08:40.649109Z","caller":"traceutil/trace.go:171","msg":"trace[1121387750] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"354.032838ms","start":"2026-04-07T00:08:40.295045Z","end":"2026-04-07T00:08:40.649078Z","steps":["trace[1121387750] 'process raft request'  (duration: 353.654027ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:08:40.649761Z","caller":"traceutil/trace.go:171","msg":"trace[200725554] transaction","detail":"{read_only:false; response_revision:1980; number_of_response:1; }","duration":"353.522928ms","start":"2026-04-07T00:08:40.2956Z","end":"2026-04-07T00:08:40.649122Z","steps":["trace[200725554] 'process raft request'  (duration: 353.357238ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:40.649809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.975719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-04-07T00:08:40.649962Z","caller":"traceutil/trace.go:171","msg":"trace[1332482866] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1980; }","duration":"153.20278ms","start":"2026-04-07T00:08:40.496739Z","end":"2026-04-07T00:08:40.649942Z","steps":["trace[1332482866] 'agreement among raft nodes before linearized reading'  (duration: 152.709888ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:40.649992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:40.295591Z","time spent":"354.277349ms","remote":"127.0.0.1:36924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1954 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-04-07T00:08:40.649873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:40.295014Z","time spent":"354.724999ms","remote":"127.0.0.1:36924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1953 > 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\" > >"}
{"level":"info","ts":"2026-04-07T00:08:41.066807Z","caller":"traceutil/trace.go:171","msg":"trace[873311507] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"103.523157ms","start":"2026-04-07T00:08:40.963257Z","end":"2026-04-07T00:08:41.06678Z","steps":["trace[873311507] 'process raft request'  (duration: 103.372447ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:08:41.107008Z","caller":"traceutil/trace.go:171","msg":"trace[1034972470] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"123.547942ms","start":"2026-04-07T00:08:40.983432Z","end":"2026-04-07T00:08:41.10698Z","steps":["trace[1034972470] 'process raft request'  (duration: 123.437131ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:08:41.107287Z","caller":"traceutil/trace.go:171","msg":"trace[148359034] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"124.856105ms","start":"2026-04-07T00:08:40.982418Z","end":"2026-04-07T00:08:41.107274Z","steps":["trace[148359034] 'process raft request'  (duration: 102.844425ms)","trace[148359034] 'compare'  (duration: 21.253399ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:08:44.521356Z","caller":"traceutil/trace.go:171","msg":"trace[60401493] linearizableReadLoop","detail":"{readStateIndex:2080; appliedIndex:2079; }","duration":"188.33299ms","start":"2026-04-07T00:08:44.332991Z","end":"2026-04-07T00:08:44.521324Z","steps":["trace[60401493] 'read index received'  (duration: 188.112809ms)","trace[60401493] 'applied index is now lower than readState.Index'  (duration: 218.531µs)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:08:44.521521Z","caller":"traceutil/trace.go:171","msg":"trace[2054764538] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"209.99213ms","start":"2026-04-07T00:08:44.31147Z","end":"2026-04-07T00:08:44.521462Z","steps":["trace[2054764538] 'process raft request'  (duration: 209.623068ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:08:44.521753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.728821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-04-07T00:08:44.521633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.711202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:08:44.521856Z","caller":"traceutil/trace.go:171","msg":"trace[787203602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2001; }","duration":"188.917731ms","start":"2026-04-07T00:08:44.332915Z","end":"2026-04-07T00:08:44.521833Z","steps":["trace[787203602] 'agreement among raft nodes before linearized reading'  (duration: 188.564281ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:08:44.521878Z","caller":"traceutil/trace.go:171","msg":"trace[2091954731] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2001; }","duration":"119.090932ms","start":"2026-04-07T00:08:44.402774Z","end":"2026-04-07T00:08:44.521865Z","steps":["trace[2091954731] 'agreement among raft nodes before linearized reading'  (duration: 118.724592ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:09:07.356744Z","caller":"traceutil/trace.go:171","msg":"trace[721373719] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"121.664868ms","start":"2026-04-07T00:09:07.235055Z","end":"2026-04-07T00:09:07.356719Z","steps":["trace[721373719] 'process raft request'  (duration: 121.621248ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:09:07.357201Z","caller":"traceutil/trace.go:171","msg":"trace[382918383] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"127.357391ms","start":"2026-04-07T00:09:07.229809Z","end":"2026-04-07T00:09:07.357166Z","steps":["trace[382918383] 'process raft request'  (duration: 126.829429ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:09:07.357465Z","caller":"traceutil/trace.go:171","msg":"trace[394075593] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"407.4971ms","start":"2026-04-07T00:09:06.949892Z","end":"2026-04-07T00:09:07.357389Z","steps":["trace[394075593] 'process raft request'  (duration: 366.120785ms)","trace[394075593] 'compare'  (duration: 40.355183ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:09:07.357462Z","caller":"traceutil/trace.go:171","msg":"trace[1257536680] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"187.780809ms","start":"2026-04-07T00:09:07.169648Z","end":"2026-04-07T00:09:07.357429Z","steps":["trace[1257536680] 'process raft request'  (duration: 186.910187ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:09:07.357856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:09:06.949864Z","time spent":"407.63707ms","remote":"127.0.0.1:36924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2119 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-07T00:09:09.17939Z","caller":"traceutil/trace.go:171","msg":"trace[1708532662] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2217; }","duration":"457.578584ms","start":"2026-04-07T00:09:08.721789Z","end":"2026-04-07T00:09:09.179367Z","steps":["trace[1708532662] 'read index received'  (duration: 457.351724ms)","trace[1708532662] 'applied index is now lower than readState.Index'  (duration: 225.84µs)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:09:09.179694Z","caller":"traceutil/trace.go:171","msg":"trace[1499626338] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"475.841167ms","start":"2026-04-07T00:09:08.703841Z","end":"2026-04-07T00:09:09.179682Z","steps":["trace[1499626338] 'process raft request'  (duration: 475.364386ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:09:09.17981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:09:08.703812Z","time spent":"475.922237ms","remote":"127.0.0.1:36924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2125 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-07T00:09:09.180036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.368357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a3ea84b3ff2547\" ","response":"range_response_count:1 size:846"}
{"level":"info","ts":"2026-04-07T00:09:09.180143Z","caller":"traceutil/trace.go:171","msg":"trace[1961213900] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a3ea84b3ff2547; range_end:; response_count:1; response_revision:2134; }","duration":"388.519747ms","start":"2026-04-07T00:09:08.791596Z","end":"2026-04-07T00:09:09.180116Z","steps":["trace[1961213900] 'agreement among raft nodes before linearized reading'  (duration: 388.250636ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:09:09.180199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:09:08.791575Z","time spent":"388.609728ms","remote":"127.0.0.1:36730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a3ea84b3ff2547\" "}
{"level":"warn","ts":"2026-04-07T00:09:09.180351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.707041ms","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-07T00:09:09.18041Z","caller":"traceutil/trace.go:171","msg":"trace[1909570203] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2134; }","duration":"280.802641ms","start":"2026-04-07T00:09:08.899595Z","end":"2026-04-07T00:09:09.180398Z","steps":["trace[1909570203] 'agreement among raft nodes before linearized reading'  (duration: 280.667001ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:09:09.180412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.596047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-04-07T00:09:09.180493Z","caller":"traceutil/trace.go:171","msg":"trace[612916911] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2134; }","duration":"458.689537ms","start":"2026-04-07T00:09:08.721784Z","end":"2026-04-07T00:09:09.180473Z","steps":["trace[612916911] 'agreement among raft nodes before linearized reading'  (duration: 458.459317ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:09:09.180532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:09:08.721744Z","time spent":"458.779827ms","remote":"127.0.0.1:36924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-07T00:09:09.180611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.670383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:128737"}
{"level":"warn","ts":"2026-04-07T00:09:09.180871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.554035ms","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-07T00:09:09.180992Z","caller":"traceutil/trace.go:171","msg":"trace[101130540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2134; }","duration":"282.673875ms","start":"2026-04-07T00:09:08.898299Z","end":"2026-04-07T00:09:09.180972Z","steps":["trace[101130540] 'agreement among raft nodes before linearized reading'  (duration: 281.969194ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:09:09.180649Z","caller":"traceutil/trace.go:171","msg":"trace[802327751] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2134; }","duration":"268.742143ms","start":"2026-04-07T00:09:08.911898Z","end":"2026-04-07T00:09:09.18064Z","steps":["trace[802327751] 'agreement among raft nodes before linearized reading'  (duration: 268.600193ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:09:09.181613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.970486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"}
{"level":"info","ts":"2026-04-07T00:09:09.181733Z","caller":"traceutil/trace.go:171","msg":"trace[1710512636] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2134; }","duration":"262.59808ms","start":"2026-04-07T00:09:08.919107Z","end":"2026-04-07T00:09:09.181705Z","steps":["trace[1710512636] 'agreement among raft nodes before linearized reading'  (duration: 260.917286ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:09:09.295536Z","caller":"traceutil/trace.go:171","msg":"trace[340231727] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"109.57966ms","start":"2026-04-07T00:09:09.185896Z","end":"2026-04-07T00:09:09.295476Z","steps":["trace[340231727] 'process raft request'  (duration: 38.357208ms)","trace[340231727] 'compare'  (duration: 70.758761ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:09:09.295646Z","caller":"traceutil/trace.go:171","msg":"trace[211960109] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"109.023589ms","start":"2026-04-07T00:09:09.186593Z","end":"2026-04-07T00:09:09.295617Z","steps":["trace[211960109] 'process raft request'  (duration: 108.932769ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:09:09.296005Z","caller":"traceutil/trace.go:171","msg":"trace[1670852451] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"109.268319ms","start":"2026-04-07T00:09:09.186708Z","end":"2026-04-07T00:09:09.295976Z","steps":["trace[1670852451] 'process raft request'  (duration: 108.873638ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:09:09.296251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.939844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:09:09.296301Z","caller":"traceutil/trace.go:171","msg":"trace[300979428] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2138; }","duration":"107.030724ms","start":"2026-04-07T00:09:09.189258Z","end":"2026-04-07T00:09:09.296289Z","steps":["trace[300979428] 'agreement among raft nodes before linearized reading'  (duration: 106.924583ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:09:09.296746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.893581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:15 size:25777"}
{"level":"info","ts":"2026-04-07T00:09:09.297261Z","caller":"traceutil/trace.go:171","msg":"trace[2016461984] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:15; response_revision:2138; }","duration":"110.422622ms","start":"2026-04-07T00:09:09.186792Z","end":"2026-04-07T00:09:09.297215Z","steps":["trace[2016461984] 'agreement among raft nodes before linearized reading'  (duration: 109.621031ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:09:09.565701Z","caller":"traceutil/trace.go:171","msg":"trace[171472806] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"203.428304ms","start":"2026-04-07T00:09:09.362244Z","end":"2026-04-07T00:09:09.565673Z","steps":["trace[171472806] 'process raft request'  (duration: 201.63965ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:09:09.566074Z","caller":"traceutil/trace.go:171","msg":"trace[384980813] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"203.193884ms","start":"2026-04-07T00:09:09.36286Z","end":"2026-04-07T00:09:09.566054Z","steps":["trace[384980813] 'process raft request'  (duration: 202.758963ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:09:09.5664Z","caller":"traceutil/trace.go:171","msg":"trace[1662483080] linearizableReadLoop","detail":"{readStateIndex:2226; appliedIndex:2222; }","duration":"198.541052ms","start":"2026-04-07T00:09:09.367837Z","end":"2026-04-07T00:09:09.566379Z","steps":["trace[1662483080] 'read index received'  (duration: 196.071367ms)","trace[1662483080] 'applied index is now lower than readState.Index'  (duration: 2.468455ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:09:09.566537Z","caller":"traceutil/trace.go:171","msg":"trace[1259438746] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"203.600535ms","start":"2026-04-07T00:09:09.362921Z","end":"2026-04-07T00:09:09.566522Z","steps":["trace[1259438746] 'process raft request'  (duration: 203.040204ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:09:09.566527Z","caller":"traceutil/trace.go:171","msg":"trace[1759418306] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"202.591672ms","start":"2026-04-07T00:09:09.363916Z","end":"2026-04-07T00:09:09.566508Z","steps":["trace[1759418306] 'process raft request'  (duration: 202.363751ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:09:09.566575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.709903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-07T00:09:09.566621Z","caller":"traceutil/trace.go:171","msg":"trace[443603046] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2142; }","duration":"198.812634ms","start":"2026-04-07T00:09:09.367799Z","end":"2026-04-07T00:09:09.566611Z","steps":["trace[443603046] 'agreement among raft nodes before linearized reading'  (duration: 198.716253ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:09:09.56669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.350536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:09:09.566731Z","caller":"traceutil/trace.go:171","msg":"trace[1184422442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2142; }","duration":"164.433796ms","start":"2026-04-07T00:09:09.402286Z","end":"2026-04-07T00:09:09.56672Z","steps":["trace[1184422442] 'agreement among raft nodes before linearized reading'  (duration: 164.356946ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:10:25.95671Z","caller":"traceutil/trace.go:171","msg":"trace[1486823210] transaction","detail":"{read_only:false; response_revision:2650; number_of_response:1; }","duration":"111.947045ms","start":"2026-04-07T00:10:25.844737Z","end":"2026-04-07T00:10:25.956684Z","steps":["trace[1486823210] 'process raft request'  (duration: 111.690685ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:10:26.754442Z","caller":"traceutil/trace.go:171","msg":"trace[746771989] linearizableReadLoop","detail":"{readStateIndex:2757; appliedIndex:2756; }","duration":"174.031947ms","start":"2026-04-07T00:10:26.580371Z","end":"2026-04-07T00:10:26.754403Z","steps":["trace[746771989] 'read index received'  (duration: 173.739666ms)","trace[746771989] 'applied index is now lower than readState.Index'  (duration: 288.281µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:10:26.754596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.213248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-07T00:10:26.754595Z","caller":"traceutil/trace.go:171","msg":"trace[507905640] transaction","detail":"{read_only:false; response_revision:2654; number_of_response:1; }","duration":"190.008064ms","start":"2026-04-07T00:10:26.564551Z","end":"2026-04-07T00:10:26.75456Z","steps":["trace[507905640] 'process raft request'  (duration: 189.660212ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:10:26.754648Z","caller":"traceutil/trace.go:171","msg":"trace[75680950] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:2654; }","duration":"174.284128ms","start":"2026-04-07T00:10:26.580349Z","end":"2026-04-07T00:10:26.754634Z","steps":["trace[75680950] 'agreement among raft nodes before linearized reading'  (duration: 174.172958ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:10:59.524602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.101124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:10:59.524709Z","caller":"traceutil/trace.go:171","msg":"trace[1953925793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2832; }","duration":"120.265994ms","start":"2026-04-07T00:10:59.404417Z","end":"2026-04-07T00:10:59.524683Z","steps":["trace[1953925793] 'range keys from in-memory index tree'  (duration: 120.000304ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:14:58.386046Z","caller":"traceutil/trace.go:171","msg":"trace[988413605] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"200.127747ms","start":"2026-04-07T00:14:58.185896Z","end":"2026-04-07T00:14:58.386024Z","steps":["trace[988413605] 'process raft request'  (duration: 199.945387ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:15:04.527405Z","caller":"traceutil/trace.go:171","msg":"trace[1883155831] linearizableReadLoop","detail":"{readStateIndex:5125; appliedIndex:5121; }","duration":"125.784037ms","start":"2026-04-07T00:15:04.40158Z","end":"2026-04-07T00:15:04.527364Z","steps":["trace[1883155831] 'read index received'  (duration: 34.611949ms)","trace[1883155831] 'applied index is now lower than readState.Index'  (duration: 91.170398ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:15:04.52764Z","caller":"traceutil/trace.go:171","msg":"trace[949654371] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"143.232407ms","start":"2026-04-07T00:15:04.384382Z","end":"2026-04-07T00:15:04.527614Z","steps":["trace[949654371] 'process raft request'  (duration: 104.989369ms)","trace[949654371] 'compare'  (duration: 37.550297ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:15:04.527859Z","caller":"traceutil/trace.go:171","msg":"trace[765409425] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"141.638223ms","start":"2026-04-07T00:15:04.386157Z","end":"2026-04-07T00:15:04.527795Z","steps":["trace[765409425] 'process raft request'  (duration: 141.117572ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:15:04.528002Z","caller":"traceutil/trace.go:171","msg":"trace[1053922667] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"142.363275ms","start":"2026-04-07T00:15:04.385597Z","end":"2026-04-07T00:15:04.52796Z","steps":["trace[1053922667] 'process raft request'  (duration: 141.596943ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:15:04.528535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.549759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T00:15:04.528646Z","caller":"traceutil/trace.go:171","msg":"trace[568552260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4936; }","duration":"127.19611ms","start":"2026-04-07T00:15:04.401428Z","end":"2026-04-07T00:15:04.528624Z","steps":["trace[568552260] 'agreement among raft nodes before linearized reading'  (duration: 126.507509ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:15:12.714804Z","caller":"traceutil/trace.go:171","msg":"trace[2131166713] linearizableReadLoop","detail":"{readStateIndex:5250; appliedIndex:5249; }","duration":"100.927061ms","start":"2026-04-07T00:15:12.613836Z","end":"2026-04-07T00:15:12.714763Z","steps":["trace[2131166713] 'read index received'  (duration: 22.02157ms)","trace[2131166713] 'applied index is now lower than readState.Index'  (duration: 78.904071ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:15:12.714823Z","caller":"traceutil/trace.go:171","msg":"trace[1260167625] transaction","detail":"{read_only:false; response_revision:5056; number_of_response:1; }","duration":"116.840398ms","start":"2026-04-07T00:15:12.597939Z","end":"2026-04-07T00:15:12.714779Z","steps":["trace[1260167625] 'process raft request'  (duration: 38.005988ms)","trace[1260167625] 'compare'  (duration: 78.427209ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T00:15:12.715542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.664002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-07T00:15:12.715669Z","caller":"traceutil/trace.go:171","msg":"trace[973454878] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:5057; }","duration":"101.858442ms","start":"2026-04-07T00:15:12.613786Z","end":"2026-04-07T00:15:12.715644Z","steps":["trace[973454878] 'agreement among raft nodes before linearized reading'  (duration: 101.175761ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:15:20.876971Z","caller":"traceutil/trace.go:171","msg":"trace[283044589] linearizableReadLoop","detail":"{readStateIndex:5328; appliedIndex:5327; }","duration":"328.382757ms","start":"2026-04-07T00:15:20.548563Z","end":"2026-04-07T00:15:20.876945Z","steps":["trace[283044589] 'read index received'  (duration: 328.134617ms)","trace[283044589] 'applied index is now lower than readState.Index'  (duration: 246.27µs)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:15:20.877141Z","caller":"traceutil/trace.go:171","msg":"trace[1596840805] transaction","detail":"{read_only:false; response_revision:5133; number_of_response:1; }","duration":"407.550779ms","start":"2026-04-07T00:15:20.469462Z","end":"2026-04-07T00:15:20.877012Z","steps":["trace[1596840805] 'process raft request'  (duration: 407.272518ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:15:20.877271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.864748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.243\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-04-07T00:15:20.877317Z","caller":"traceutil/trace.go:171","msg":"trace[1227307423] range","detail":"{range_begin:/registry/masterleases/199.19.213.243; range_end:; response_count:1; response_revision:5133; }","duration":"174.970289ms","start":"2026-04-07T00:15:20.702335Z","end":"2026-04-07T00:15:20.877306Z","steps":["trace[1227307423] 'agreement among raft nodes before linearized reading'  (duration: 174.767808ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:15:20.877409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:15:20.469426Z","time spent":"407.824349ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10667,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" mod_revision:4995 > success:<request_put:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" value_size:10608 >> failure:<request_range:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" > >"}
{"level":"warn","ts":"2026-04-07T00:15:20.877388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.962666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-04-07T00:15:20.877444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.735199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-04-07T00:15:20.877586Z","caller":"traceutil/trace.go:171","msg":"trace[840400422] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5133; }","duration":"329.068539ms","start":"2026-04-07T00:15:20.548497Z","end":"2026-04-07T00:15:20.877565Z","steps":["trace[840400422] 'agreement among raft nodes before linearized reading'  (duration: 328.599228ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:15:20.877521Z","caller":"traceutil/trace.go:171","msg":"trace[457193397] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5133; }","duration":"108.141566ms","start":"2026-04-07T00:15:20.769364Z","end":"2026-04-07T00:15:20.877506Z","steps":["trace[457193397] 'agreement among raft nodes before linearized reading'  (duration: 107.859845ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:15:20.87764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:15:20.548473Z","time spent":"329.15405ms","remote":"127.0.0.1:36814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"info","ts":"2026-04-07T00:15:21.006977Z","caller":"traceutil/trace.go:171","msg":"trace[1236753402] transaction","detail":"{read_only:false; response_revision:5134; number_of_response:1; }","duration":"122.501369ms","start":"2026-04-07T00:15:20.884448Z","end":"2026-04-07T00:15:21.006949Z","steps":["trace[1236753402] 'process raft request'  (duration: 122.237319ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:15:21.007218Z","caller":"traceutil/trace.go:171","msg":"trace[218500320] transaction","detail":"{read_only:false; response_revision:5135; number_of_response:1; }","duration":"122.72193ms","start":"2026-04-07T00:15:20.884478Z","end":"2026-04-07T00:15:21.0072Z","steps":["trace[218500320] 'process raft request'  (duration: 122.410239ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:15:21.007689Z","caller":"traceutil/trace.go:171","msg":"trace[1385658125] transaction","detail":"{read_only:false; response_revision:5136; number_of_response:1; }","duration":"122.967711ms","start":"2026-04-07T00:15:20.884688Z","end":"2026-04-07T00:15:21.007656Z","steps":["trace[1385658125] 'process raft request'  (duration: 122.434799ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T00:15:21.007982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.602551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-07T00:15:21.008098Z","caller":"traceutil/trace.go:171","msg":"trace[1946435399] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5138; }","duration":"118.780881ms","start":"2026-04-07T00:15:20.889298Z","end":"2026-04-07T00:15:21.008079Z","steps":["trace[1946435399] 'agreement among raft nodes before linearized reading'  (duration: 118.553211ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:15:21.008264Z","caller":"traceutil/trace.go:171","msg":"trace[30076518] transaction","detail":"{read_only:false; response_revision:5138; number_of_response:1; }","duration":"122.772389ms","start":"2026-04-07T00:15:20.885478Z","end":"2026-04-07T00:15:21.008251Z","steps":["trace[30076518] 'process raft request'  (duration: 122.166578ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:15:21.007743Z","caller":"traceutil/trace.go:171","msg":"trace[1449921473] transaction","detail":"{read_only:false; response_revision:5137; number_of_response:1; }","duration":"122.61573ms","start":"2026-04-07T00:15:20.885095Z","end":"2026-04-07T00:15:21.007711Z","steps":["trace[1449921473] 'process raft request'  (duration: 122.40655ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T00:16:07.583435Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2874}
{"level":"info","ts":"2026-04-07T00:16:07.684047Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2874,"took":"99.192715ms","hash":504078374,"current-db-size-bytes":53460992,"current-db-size":"54 MB","current-db-size-in-use-bytes":28311552,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-04-07T00:16:07.684125Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":504078374,"revision":2874,"compact-revision":-1}
{"level":"info","ts":"2026-04-07T00:19:25.241495Z","caller":"traceutil/trace.go:171","msg":"trace[1869631224] transaction","detail":"{read_only:false; response_revision:6897; number_of_response:1; }","duration":"125.998019ms","start":"2026-04-07T00:19:25.115471Z","end":"2026-04-07T00:19:25.241469Z","steps":["trace[1869631224] 'process raft request'  (duration: 53.545321ms)","trace[1869631224] 'compare'  (duration: 72.16988ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T00:21:07.59077Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5502}
{"level":"info","ts":"2026-04-07T00:21:07.690832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5502,"took":"98.246873ms","hash":34677411,"current-db-size-bytes":53460992,"current-db-size":"54 MB","current-db-size-in-use-bytes":18534400,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-04-07T00:21:07.690926Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":34677411,"revision":5502,"compact-revision":2874}