{"level":"warn","ts":"2026-09-18T15:08:18.986292Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-18T15:08:18.986424Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.143: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://162.253.55.143:2380","--initial-cluster=instance=https://162.253.55.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.143: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-09-18T15:08:18.986527Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-18T15:08:18.986551Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.143:2380"]}
{"level":"info","ts":"2026-09-18T15:08:18.986576Z","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-09-18T15:08:18.987333Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"]}
{"level":"info","ts":"2026-09-18T15:08:18.987435Z","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://162.253.55.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.143: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-09-18T15:08:18.994792Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.024831ms"}
{"level":"info","ts":"2026-09-18T15:08:19.006022Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7bf20b54406e85d1","cluster-id":"de54e01795e71fe2"}
{"level":"info","ts":"2026-09-18T15:08:19.006141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-18T15:08:19.006174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 0"}
{"level":"info","ts":"2026-09-18T15:08:19.006192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7bf20b54406e85d1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-18T15:08:19.006204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 1"}
{"level":"info","ts":"2026-09-18T15:08:19.007628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"}
{"level":"warn","ts":"2026-09-18T15:08:19.014176Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-18T15:08:19.016365Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-18T15:08:19.01825Z","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-09-18T15:08:19.021892Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7bf20b54406e85d1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-18T15:08:19.022084Z","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-09-18T15:08:19.022163Z","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-09-18T15:08:19.022174Z","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-09-18T15:08:19.02213Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7bf20b54406e85d1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-18T15:08:19.023925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"}
{"level":"info","ts":"2026-09-18T15:08:19.024148Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","added-peer-id":"7bf20b54406e85d1","added-peer-peer-urls":["https://162.253.55.143:2380"]}
{"level":"info","ts":"2026-09-18T15:08:19.02562Z","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-09-18T15:08:19.02579Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7bf20b54406e85d1","initial-advertise-peer-urls":["https://162.253.55.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-18T15:08:19.025819Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-18T15:08:19.026166Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.143:2380"}
{"level":"info","ts":"2026-09-18T15:08:19.02619Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.143:2380"}
{"level":"info","ts":"2026-09-18T15:08:19.608828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-18T15:08:19.608894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-18T15:08:19.608916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgPreVoteResp from 7bf20b54406e85d1 at term 1"}
{"level":"info","ts":"2026-09-18T15:08:19.608946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became candidate at term 2"}
{"level":"info","ts":"2026-09-18T15:08:19.608962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgVoteResp from 7bf20b54406e85d1 at term 2"}
{"level":"info","ts":"2026-09-18T15:08:19.608973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became leader at term 2"}
{"level":"info","ts":"2026-09-18T15:08:19.608986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7bf20b54406e85d1 elected leader 7bf20b54406e85d1 at term 2"}
{"level":"info","ts":"2026-09-18T15:08:19.610234Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-18T15:08:19.611148Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-18T15:08:19.611169Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7bf20b54406e85d1","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.143:2379]}","request-path":"/0/members/7bf20b54406e85d1/attributes","cluster-id":"de54e01795e71fe2","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-18T15:08:19.611588Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-18T15:08:19.611721Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-18T15:08:19.611814Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-18T15:08:19.611849Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-18T15:08:19.611832Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-18T15:08:19.611947Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-18T15:08:19.613813Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.143:2379"}
{"level":"info","ts":"2026-09-18T15:08:19.61616Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-18T15:08:23.824091Z","caller":"traceutil/trace.go:171","msg":"trace[1456336694] linearizableReadLoop","detail":"{readStateIndex:208; appliedIndex:207; }","duration":"148.193368ms","start":"2026-09-18T15:08:23.675868Z","end":"2026-09-18T15:08:23.824062Z","steps":["trace[1456336694] 'read index received'  (duration: 148.04125ms)","trace[1456336694] 'applied index is now lower than readState.Index'  (duration: 150.988µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:08:23.824293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.368308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T15:08:23.824355Z","caller":"traceutil/trace.go:171","msg":"trace[711638400] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:203; }","duration":"148.553487ms","start":"2026-09-18T15:08:23.675789Z","end":"2026-09-18T15:08:23.824343Z","steps":["trace[711638400] 'agreement among raft nodes before linearized reading'  (duration: 148.398149ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:08:23.824432Z","caller":"traceutil/trace.go:171","msg":"trace[1594243855] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"213.349087ms","start":"2026-09-18T15:08:23.610981Z","end":"2026-09-18T15:08:23.82433Z","steps":["trace[1594243855] 'process raft request'  (duration: 212.943065ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:08:24.189097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.336957ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9642664976689578224 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:3660-second id:05d1a0b50faec0ef>","response":"size:41"}
{"level":"info","ts":"2026-09-18T15:08:24.189396Z","caller":"traceutil/trace.go:171","msg":"trace[2058486856] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"360.094938ms","start":"2026-09-18T15:08:23.829286Z","end":"2026-09-18T15:08:24.189381Z","steps":["trace[2058486856] 'process raft request'  (duration: 359.901758ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:08:24.189385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:08:23.757378Z","time spent":"432.001742ms","remote":"127.0.0.1:53388","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-09-18T15:08:24.189453Z","caller":"traceutil/trace.go:171","msg":"trace[1612237116] linearizableReadLoop","detail":"{readStateIndex:209; appliedIndex:208; }","duration":"360.654847ms","start":"2026-09-18T15:08:23.828744Z","end":"2026-09-18T15:08:24.189399Z","steps":["trace[1612237116] 'read index received'  (duration: 153.894829ms)","trace[1612237116] 'applied index is now lower than readState.Index'  (duration: 206.757298ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:08:24.18985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:08:23.829268Z","time spent":"360.158151ms","remote":"127.0.0.1:53550","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:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<>"}
{"level":"warn","ts":"2026-09-18T15:08:24.189871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.099322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-mp8nye\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T15:08:24.18992Z","caller":"traceutil/trace.go:171","msg":"trace[50639020] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-mp8nye; range_end:; response_count:0; response_revision:204; }","duration":"361.168105ms","start":"2026-09-18T15:08:23.828737Z","end":"2026-09-18T15:08:24.189905Z","steps":["trace[50639020] 'agreement among raft nodes before linearized reading'  (duration: 360.940133ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:08:24.189996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:08:23.82865Z","time spent":"361.335613ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-mp8nye\" "}
{"level":"warn","ts":"2026-09-18T15:08:24.190267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.281346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T15:08:24.190311Z","caller":"traceutil/trace.go:171","msg":"trace[2044303281] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:204; }","duration":"312.360419ms","start":"2026-09-18T15:08:23.877938Z","end":"2026-09-18T15:08:24.190298Z","steps":["trace[2044303281] 'agreement among raft nodes before linearized reading'  (duration: 312.281805ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:08:24.190344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:08:23.877916Z","time spent":"312.420813ms","remote":"127.0.0.1:53448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "}
{"level":"info","ts":"2026-09-18T15:08:24.422276Z","caller":"traceutil/trace.go:171","msg":"trace[1883316591] linearizableReadLoop","detail":"{readStateIndex:211; appliedIndex:210; }","duration":"227.129201ms","start":"2026-09-18T15:08:24.195122Z","end":"2026-09-18T15:08:24.422251Z","steps":["trace[1883316591] 'read index received'  (duration: 220.80604ms)","trace[1883316591] 'applied index is now lower than readState.Index'  (duration: 6.322171ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:08:24.422301Z","caller":"traceutil/trace.go:171","msg":"trace[96290778] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"230.818124ms","start":"2026-09-18T15:08:24.19146Z","end":"2026-09-18T15:08:24.422278Z","steps":["trace[96290778] 'process raft request'  (duration: 224.45455ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:08:24.422575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.375705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T15:08:24.422632Z","caller":"traceutil/trace.go:171","msg":"trace[2108580511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:205; }","duration":"227.528492ms","start":"2026-09-18T15:08:24.195088Z","end":"2026-09-18T15:08:24.422617Z","steps":["trace[2108580511] 'agreement among raft nodes before linearized reading'  (duration: 227.28461ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:08:24.423083Z","caller":"traceutil/trace.go:171","msg":"trace[49056527] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"227.759873ms","start":"2026-09-18T15:08:24.195307Z","end":"2026-09-18T15:08:24.423067Z","steps":["trace[49056527] 'process raft request'  (duration: 227.351632ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:08:24.423178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.030278ms","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-09-18T15:08:24.423274Z","caller":"traceutil/trace.go:171","msg":"trace[1553659991] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:208; }","duration":"228.149164ms","start":"2026-09-18T15:08:24.195107Z","end":"2026-09-18T15:08:24.423256Z","steps":["trace[1553659991] 'agreement among raft nodes before linearized reading'  (duration: 227.985776ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:08:24.423458Z","caller":"traceutil/trace.go:171","msg":"trace[990424668] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"228.094421ms","start":"2026-09-18T15:08:24.195301Z","end":"2026-09-18T15:08:24.423396Z","steps":["trace[990424668] 'process raft request'  (duration: 227.673579ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:08:24.423576Z","caller":"traceutil/trace.go:171","msg":"trace[396893810] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"228.24967ms","start":"2026-09-18T15:08:24.195309Z","end":"2026-09-18T15:08:24.423558Z","steps":["trace[396893810] 'process raft request'  (duration: 227.732562ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:09:07.907207Z","caller":"traceutil/trace.go:171","msg":"trace[1399147600] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"138.88056ms","start":"2026-09-18T15:09:07.768298Z","end":"2026-09-18T15:09:07.907179Z","steps":["trace[1399147600] 'process raft request'  (duration: 111.03321ms)","trace[1399147600] 'compare'  (duration: 27.670584ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:09:07.907525Z","caller":"traceutil/trace.go:171","msg":"trace[508049887] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"116.035907ms","start":"2026-09-18T15:09:07.791467Z","end":"2026-09-18T15:09:07.907503Z","steps":["trace[508049887] 'process raft request'  (duration: 115.84899ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:09:14.783478Z","caller":"traceutil/trace.go:171","msg":"trace[488033350] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:687; }","duration":"136.424898ms","start":"2026-09-18T15:09:14.646989Z","end":"2026-09-18T15:09:14.783414Z","steps":["trace[488033350] 'read index received'  (duration: 129.740922ms)","trace[488033350] 'applied index is now lower than readState.Index'  (duration: 6.682796ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:09:14.783996Z","caller":"traceutil/trace.go:171","msg":"trace[1884335893] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"201.546767ms","start":"2026-09-18T15:09:14.582383Z","end":"2026-09-18T15:09:14.783929Z","steps":["trace[1884335893] 'process raft request'  (duration: 194.687215ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:09:14.784038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.019727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kpzn4\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-09-18T15:09:14.784111Z","caller":"traceutil/trace.go:171","msg":"trace[1548292437] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kpzn4; range_end:; response_count:1; response_revision:659; }","duration":"137.154712ms","start":"2026-09-18T15:09:14.646937Z","end":"2026-09-18T15:09:14.784091Z","steps":["trace[1548292437] 'agreement among raft nodes before linearized reading'  (duration: 136.931615ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:09:15.395811Z","caller":"traceutil/trace.go:171","msg":"trace[130142283] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:690; }","duration":"184.685943ms","start":"2026-09-18T15:09:15.211098Z","end":"2026-09-18T15:09:15.395784Z","steps":["trace[130142283] 'read index received'  (duration: 167.985293ms)","trace[130142283] 'applied index is now lower than readState.Index'  (duration: 16.6996ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:09:15.396013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.90282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T15:09:15.395918Z","caller":"traceutil/trace.go:171","msg":"trace[303675252] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"529.416184ms","start":"2026-09-18T15:09:14.866459Z","end":"2026-09-18T15:09:15.395875Z","steps":["trace[303675252] 'process raft request'  (duration: 529.212967ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:09:15.396064Z","caller":"traceutil/trace.go:171","msg":"trace[2072006410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:663; }","duration":"185.007003ms","start":"2026-09-18T15:09:15.211044Z","end":"2026-09-18T15:09:15.396051Z","steps":["trace[2072006410] 'agreement among raft nodes before linearized reading'  (duration: 184.890959ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:09:15.3962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.109491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-18T15:09:15.396253Z","caller":"traceutil/trace.go:171","msg":"trace[114667434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:663; }","duration":"124.213454ms","start":"2026-09-18T15:09:15.272027Z","end":"2026-09-18T15:09:15.39624Z","steps":["trace[114667434] 'agreement among raft nodes before linearized reading'  (duration: 124.042208ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:09:15.396264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:09:14.866408Z","time spent":"529.684663ms","remote":"127.0.0.1:53526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"info","ts":"2026-09-18T15:09:15.395988Z","caller":"traceutil/trace.go:171","msg":"trace[2092257875] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"580.157428ms","start":"2026-09-18T15:09:14.815797Z","end":"2026-09-18T15:09:15.395955Z","steps":["trace[2092257875] 'process raft request'  (duration: 563.243911ms)","trace[2092257875] 'compare'  (duration: 16.322177ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:09:15.396725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:09:14.815766Z","time spent":"580.705417ms","remote":"127.0.0.1:53474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-kpzn4\" mod_revision:542 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-kpzn4\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-kpzn4\" > >"}
{"level":"warn","ts":"2026-09-18T15:09:33.131682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.153894ms","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-09-18T15:09:33.131861Z","caller":"traceutil/trace.go:171","msg":"trace[1586443274] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:830; }","duration":"223.417282ms","start":"2026-09-18T15:09:32.908421Z","end":"2026-09-18T15:09:33.131839Z","steps":["trace[1586443274] 'range keys from in-memory index tree'  (duration: 222.938618ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:09:33.131874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.004568ms","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":"warn","ts":"2026-09-18T15:09:33.13191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.610423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.143\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-09-18T15:09:33.131955Z","caller":"traceutil/trace.go:171","msg":"trace[1496192905] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:830; }","duration":"305.118461ms","start":"2026-09-18T15:09:32.826819Z","end":"2026-09-18T15:09:33.131937Z","steps":["trace[1496192905] 'range keys from in-memory index tree'  (duration: 304.839042ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:09:33.132002Z","caller":"traceutil/trace.go:171","msg":"trace[197412480] range","detail":"{range_begin:/registry/masterleases/162.253.55.143; range_end:; response_count:1; response_revision:830; }","duration":"370.725266ms","start":"2026-09-18T15:09:32.761257Z","end":"2026-09-18T15:09:33.131982Z","steps":["trace[197412480] 'range keys from in-memory index tree'  (duration: 370.317644ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:09:33.132002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:09:32.82678Z","time spent":"305.212874ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-09-18T15:09:33.132039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:09:32.761171Z","time spent":"370.861131ms","remote":"127.0.0.1:53350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.143\" "}
{"level":"warn","ts":"2026-09-18T15:09:33.131758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.918114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dqn4s\" ","response":"range_response_count:1 size:3965"}
{"level":"warn","ts":"2026-09-18T15:09:33.132064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.074772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-18T15:09:33.132101Z","caller":"traceutil/trace.go:171","msg":"trace[1278885405] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dqn4s; range_end:; response_count:1; response_revision:830; }","duration":"360.299314ms","start":"2026-09-18T15:09:32.771781Z","end":"2026-09-18T15:09:33.13208Z","steps":["trace[1278885405] 'range keys from in-memory index tree'  (duration: 359.716228ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:09:33.132122Z","caller":"traceutil/trace.go:171","msg":"trace[775947525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:830; }","duration":"207.167126ms","start":"2026-09-18T15:09:32.924941Z","end":"2026-09-18T15:09:33.132108Z","steps":["trace[775947525] 'range keys from in-memory index tree'  (duration: 206.924058ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:09:33.132151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:09:32.771766Z","time spent":"360.372008ms","remote":"127.0.0.1:53474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dqn4s\" "}
{"level":"info","ts":"2026-09-18T15:09:33.175873Z","caller":"traceutil/trace.go:171","msg":"trace[307593719] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"226.553489ms","start":"2026-09-18T15:09:32.949289Z","end":"2026-09-18T15:09:33.175843Z","steps":["trace[307593719] 'process raft request'  (duration: 226.329662ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:10:20.959329Z","caller":"traceutil/trace.go:171","msg":"trace[787561548] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"110.394199ms","start":"2026-09-18T15:10:20.848897Z","end":"2026-09-18T15:10:20.959291Z","steps":["trace[787561548] 'process raft request'  (duration: 110.088772ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:10:57.341783Z","caller":"traceutil/trace.go:171","msg":"trace[1816072468] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"194.438253ms","start":"2026-09-18T15:10:57.147313Z","end":"2026-09-18T15:10:57.341751Z","steps":["trace[1816072468] 'process raft request'  (duration: 194.28449ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:10:57.342146Z","caller":"traceutil/trace.go:171","msg":"trace[1287695814] linearizableReadLoop","detail":"{readStateIndex:2016; appliedIndex:2016; }","duration":"132.19922ms","start":"2026-09-18T15:10:57.209909Z","end":"2026-09-18T15:10:57.342109Z","steps":["trace[1287695814] 'read index received'  (duration: 132.18794ms)","trace[1287695814] 'applied index is now lower than readState.Index'  (duration: 9.15µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:10:57.34239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.482767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"}
{"level":"info","ts":"2026-09-18T15:10:57.342444Z","caller":"traceutil/trace.go:171","msg":"trace[798206699] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1933; }","duration":"132.60804ms","start":"2026-09-18T15:10:57.209824Z","end":"2026-09-18T15:10:57.342432Z","steps":["trace[798206699] 'agreement among raft nodes before linearized reading'  (duration: 132.421696ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:10:57.618735Z","caller":"traceutil/trace.go:171","msg":"trace[1930917334] linearizableReadLoop","detail":"{readStateIndex:2017; appliedIndex:2016; }","duration":"276.421048ms","start":"2026-09-18T15:10:57.342277Z","end":"2026-09-18T15:10:57.618698Z","steps":["trace[1930917334] 'read index received'  (duration: 257.39547ms)","trace[1930917334] 'applied index is now lower than readState.Index'  (duration: 19.024118ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:10:57.618789Z","caller":"traceutil/trace.go:171","msg":"trace[1929191178] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"383.643384ms","start":"2026-09-18T15:10:57.235115Z","end":"2026-09-18T15:10:57.618758Z","steps":["trace[1929191178] 'process raft request'  (duration: 364.489764ms)","trace[1929191178] 'compare'  (duration: 18.991637ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:10:57.618903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.808062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T15:10:57.618946Z","caller":"traceutil/trace.go:171","msg":"trace[590516827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1934; }","duration":"407.886523ms","start":"2026-09-18T15:10:57.211053Z","end":"2026-09-18T15:10:57.61894Z","steps":["trace[590516827] 'agreement among raft nodes before linearized reading'  (duration: 407.792391ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:10:57.61897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.211018Z","time spent":"407.946984ms","remote":"127.0.0.1:53304","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-09-18T15:10:57.619221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.235086Z","time spent":"383.833297ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":553,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1907 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:475 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-18T15:10:57.698877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.899438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T15:10:57.698951Z","caller":"traceutil/trace.go:171","msg":"trace[2100311203] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1935; }","duration":"312.041511ms","start":"2026-09-18T15:10:57.386893Z","end":"2026-09-18T15:10:57.698935Z","steps":["trace[2100311203] 'agreement among raft nodes before linearized reading'  (duration: 311.895958ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:10:57.698934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.034378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-09-18T15:10:57.698996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.38687Z","time spent":"312.109472ms","remote":"127.0.0.1:42660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "}
{"level":"info","ts":"2026-09-18T15:10:57.699061Z","caller":"traceutil/trace.go:171","msg":"trace[275073129] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1935; }","duration":"353.181622ms","start":"2026-09-18T15:10:57.345831Z","end":"2026-09-18T15:10:57.699012Z","steps":["trace[275073129] 'agreement among raft nodes before linearized reading'  (duration: 352.944477ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:10:57.699116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.345807Z","time spent":"353.294604ms","remote":"127.0.0.1:50072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-09-18T15:10:57.699423Z","caller":"traceutil/trace.go:171","msg":"trace[836151359] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"347.499651ms","start":"2026-09-18T15:10:57.351903Z","end":"2026-09-18T15:10:57.699403Z","steps":["trace[836151359] 'process raft request'  (duration: 346.638212ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:10:57.699541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.351876Z","time spent":"347.591052ms","remote":"127.0.0.1:53474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1885 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:10913 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >"}
{"level":"info","ts":"2026-09-18T15:10:57.955417Z","caller":"traceutil/trace.go:171","msg":"trace[472514176] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"246.292522ms","start":"2026-09-18T15:10:57.709085Z","end":"2026-09-18T15:10:57.955377Z","steps":["trace[472514176] 'process raft request'  (duration: 218.12352ms)","trace[472514176] 'compare'  (duration: 27.890277ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:10:58.060729Z","caller":"traceutil/trace.go:171","msg":"trace[638073607] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"351.289349ms","start":"2026-09-18T15:10:57.709414Z","end":"2026-09-18T15:10:58.060703Z","steps":["trace[638073607] 'process raft request'  (duration: 351.105355ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:10:58.060938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.709396Z","time spent":"351.403531ms","remote":"127.0.0.1:53462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" mod_revision:1899 > success:<request_put:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" value_size:909 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" > >"}
{"level":"info","ts":"2026-09-18T15:10:58.061091Z","caller":"traceutil/trace.go:171","msg":"trace[1217164385] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"345.646868ms","start":"2026-09-18T15:10:57.715429Z","end":"2026-09-18T15:10:58.061076Z","steps":["trace[1217164385] 'process raft request'  (duration: 345.180618ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:10:58.061142Z","caller":"traceutil/trace.go:171","msg":"trace[1697088583] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"351.209487ms","start":"2026-09-18T15:10:57.709857Z","end":"2026-09-18T15:10:58.061067Z","steps":["trace[1697088583] 'process raft request'  (duration: 350.711297ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:10:58.060934Z","caller":"traceutil/trace.go:171","msg":"trace[343240827] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"351.642516ms","start":"2026-09-18T15:10:57.709264Z","end":"2026-09-18T15:10:58.060906Z","steps":["trace[343240827] 'process raft request'  (duration: 347.693652ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:10:58.061307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.715415Z","time spent":"345.778211ms","remote":"127.0.0.1:53474","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-952a295b-acf1-42c4-ade4-5fd4a47b4ff9\" mod_revision:1891 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-952a295b-acf1-42c4-ade4-5fd4a47b4ff9\" value_size:3632 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-952a295b-acf1-42c4-ade4-5fd4a47b4ff9\" > >"}
{"level":"warn","ts":"2026-09-18T15:10:58.061479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.709847Z","time spent":"351.494623ms","remote":"127.0.0.1:53552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-j669w\" mod_revision:1904 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-j669w\" value_size:1392 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-j669w\" > >"}
{"level":"warn","ts":"2026-09-18T15:10:58.061518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.709227Z","time spent":"352.138717ms","remote":"127.0.0.1:53552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-zznr2\" mod_revision:1900 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-zznr2\" value_size:1459 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-zznr2\" > >"}
{"level":"info","ts":"2026-09-18T15:10:58.061051Z","caller":"traceutil/trace.go:171","msg":"trace[181149907] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"351.665396ms","start":"2026-09-18T15:10:57.70935Z","end":"2026-09-18T15:10:58.061015Z","steps":["trace[181149907] 'process raft request'  (duration: 351.079813ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:10:58.061852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.709228Z","time spent":"352.579416ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:1739 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:467 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"info","ts":"2026-09-18T15:10:58.067042Z","caller":"traceutil/trace.go:171","msg":"trace[1439168740] linearizableReadLoop","detail":"{readStateIndex:2024; appliedIndex:2018; }","duration":"346.389893ms","start":"2026-09-18T15:10:57.720567Z","end":"2026-09-18T15:10:58.066956Z","steps":["trace[1439168740] 'read index received'  (duration: 206.732695ms)","trace[1439168740] 'applied index is now lower than readState.Index'  (duration: 139.655808ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:10:58.067475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.898563ms","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-09-18T15:10:58.0676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.999731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-18T15:10:58.067789Z","caller":"traceutil/trace.go:171","msg":"trace[1551494990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1942; }","duration":"328.256716ms","start":"2026-09-18T15:10:57.739511Z","end":"2026-09-18T15:10:58.067768Z","steps":["trace[1551494990] 'agreement among raft nodes before linearized reading'  (duration: 327.96922ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:10:58.067866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.739488Z","time spent":"328.358988ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-09-18T15:10:58.067525Z","caller":"traceutil/trace.go:171","msg":"trace[794754289] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1941; }","duration":"346.950005ms","start":"2026-09-18T15:10:57.72056Z","end":"2026-09-18T15:10:58.06751Z","steps":["trace[794754289] 'agreement among raft nodes before linearized reading'  (duration: 346.506365ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:10:58.068427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.72051Z","time spent":"347.899705ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-09-18T15:10:58.068525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.53949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-18T15:10:58.068589Z","caller":"traceutil/trace.go:171","msg":"trace[598484476] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1942; }","duration":"129.655772ms","start":"2026-09-18T15:10:57.938917Z","end":"2026-09-18T15:10:58.068573Z","steps":["trace[598484476] 'agreement among raft nodes before linearized reading'  (duration: 129.485169ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:10:58.069385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.44924ms","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-09-18T15:10:58.069451Z","caller":"traceutil/trace.go:171","msg":"trace[701000929] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1942; }","duration":"328.536221ms","start":"2026-09-18T15:10:57.7409Z","end":"2026-09-18T15:10:58.069437Z","steps":["trace[701000929] 'agreement among raft nodes before linearized reading'  (duration: 328.357147ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:10:58.069498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:10:57.740892Z","time spent":"328.596032ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-18T15:11:10.282571Z","caller":"traceutil/trace.go:171","msg":"trace[128895797] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"162.714383ms","start":"2026-09-18T15:11:10.119832Z","end":"2026-09-18T15:11:10.282547Z","steps":["trace[128895797] 'process raft request'  (duration: 162.528059ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:11:10.282742Z","caller":"traceutil/trace.go:171","msg":"trace[892315809] linearizableReadLoop","detail":"{readStateIndex:2127; appliedIndex:2127; }","duration":"137.128169ms","start":"2026-09-18T15:11:10.145575Z","end":"2026-09-18T15:11:10.282703Z","steps":["trace[892315809] 'read index received'  (duration: 137.116509ms)","trace[892315809] 'applied index is now lower than readState.Index'  (duration: 9.34µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:11:10.283188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.13933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-09-18T15:11:10.283171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.434851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-09-18T15:11:10.283292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.460646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-09-18T15:11:10.283303Z","caller":"traceutil/trace.go:171","msg":"trace[846977028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2041; }","duration":"120.616165ms","start":"2026-09-18T15:11:10.162658Z","end":"2026-09-18T15:11:10.283274Z","steps":["trace[846977028] 'agreement among raft nodes before linearized reading'  (duration: 120.230407ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:11:10.283362Z","caller":"traceutil/trace.go:171","msg":"trace[1772989777] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2041; }","duration":"137.778832ms","start":"2026-09-18T15:11:10.145564Z","end":"2026-09-18T15:11:10.283343Z","steps":["trace[1772989777] 'agreement among raft nodes before linearized reading'  (duration: 137.288302ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:11:10.283495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.729147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-09-18T15:11:10.283225Z","caller":"traceutil/trace.go:171","msg":"trace[1066267450] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2041; }","duration":"115.236052ms","start":"2026-09-18T15:11:10.167981Z","end":"2026-09-18T15:11:10.283217Z","steps":["trace[1066267450] 'agreement among raft nodes before linearized reading'  (duration: 115.077509ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:11:10.283528Z","caller":"traceutil/trace.go:171","msg":"trace[154909807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2041; }","duration":"120.808819ms","start":"2026-09-18T15:11:10.162712Z","end":"2026-09-18T15:11:10.283521Z","steps":["trace[154909807] 'agreement among raft nodes before linearized reading'  (duration: 120.708987ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:11:33.115346Z","caller":"traceutil/trace.go:171","msg":"trace[1704261318] linearizableReadLoop","detail":"{readStateIndex:2277; appliedIndex:2276; }","duration":"202.211685ms","start":"2026-09-18T15:11:32.913108Z","end":"2026-09-18T15:11:33.11532Z","steps":["trace[1704261318] 'read index received'  (duration: 162.399316ms)","trace[1704261318] 'applied index is now lower than readState.Index'  (duration: 39.811099ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:11:33.115362Z","caller":"traceutil/trace.go:171","msg":"trace[2130981055] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"202.248197ms","start":"2026-09-18T15:11:32.913078Z","end":"2026-09-18T15:11:33.115326Z","steps":["trace[2130981055] 'process raft request'  (duration: 162.476048ms)","trace[2130981055] 'compare'  (duration: 39.593585ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:11:33.115684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.207599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-18T15:11:33.115764Z","caller":"traceutil/trace.go:171","msg":"trace[1490421176] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2185; }","duration":"153.334963ms","start":"2026-09-18T15:11:32.962377Z","end":"2026-09-18T15:11:33.115712Z","steps":["trace[1490421176] 'agreement among raft nodes before linearized reading'  (duration: 153.092907ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:11:33.115812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.705716ms","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-09-18T15:11:33.116025Z","caller":"traceutil/trace.go:171","msg":"trace[949503103] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2185; }","duration":"202.956781ms","start":"2026-09-18T15:11:32.913055Z","end":"2026-09-18T15:11:33.116012Z","steps":["trace[949503103] 'agreement among raft nodes before linearized reading'  (duration: 202.382579ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:11:33.388229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.387842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1984"}
{"level":"info","ts":"2026-09-18T15:11:33.388648Z","caller":"traceutil/trace.go:171","msg":"trace[2001074056] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2186; }","duration":"142.81904ms","start":"2026-09-18T15:11:33.245811Z","end":"2026-09-18T15:11:33.38863Z","steps":["trace[2001074056] 'range keys from in-memory index tree'  (duration: 142.242728ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:11:33.416465Z","caller":"traceutil/trace.go:171","msg":"trace[1907065239] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"109.241835ms","start":"2026-09-18T15:11:33.3072Z","end":"2026-09-18T15:11:33.416442Z","steps":["trace[1907065239] 'process raft request'  (duration: 109.090312ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:11:33.784961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.035889ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9642664976689582274 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2177 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-18T15:11:33.785064Z","caller":"traceutil/trace.go:171","msg":"trace[602483596] linearizableReadLoop","detail":"{readStateIndex:2280; appliedIndex:2279; }","duration":"248.251429ms","start":"2026-09-18T15:11:33.536799Z","end":"2026-09-18T15:11:33.78505Z","steps":["trace[602483596] 'read index received'  (duration: 56.066766ms)","trace[602483596] 'applied index is now lower than readState.Index'  (duration: 192.183353ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:11:33.785143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.349071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-18T15:11:33.785169Z","caller":"traceutil/trace.go:171","msg":"trace[323033840] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2188; }","duration":"248.443933ms","start":"2026-09-18T15:11:33.536715Z","end":"2026-09-18T15:11:33.785159Z","steps":["trace[323033840] 'agreement among raft nodes before linearized reading'  (duration: 248.369711ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:11:33.785317Z","caller":"traceutil/trace.go:171","msg":"trace[1085907397] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"283.338193ms","start":"2026-09-18T15:11:33.50196Z","end":"2026-09-18T15:11:33.785298Z","steps":["trace[1085907397] 'process raft request'  (duration: 90.872416ms)","trace[1085907397] 'compare'  (duration: 191.829604ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:12:51.297093Z","caller":"traceutil/trace.go:171","msg":"trace[8222392] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"466.23298ms","start":"2026-09-18T15:12:50.830827Z","end":"2026-09-18T15:12:51.29706Z","steps":["trace[8222392] 'process raft request'  (duration: 459.280073ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:12:51.297276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:12:50.830791Z","time spent":"466.394415ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2688 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-18T15:12:51.297336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.158528ms","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-09-18T15:12:51.297405Z","caller":"traceutil/trace.go:171","msg":"trace[1168730185] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2701; }","duration":"362.258231ms","start":"2026-09-18T15:12:50.935136Z","end":"2026-09-18T15:12:51.297395Z","steps":["trace[1168730185] 'agreement among raft nodes before linearized reading'  (duration: 362.012443ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:12:51.297437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:12:50.935066Z","time spent":"362.365044ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-09-18T15:12:51.297107Z","caller":"traceutil/trace.go:171","msg":"trace[1559590547] linearizableReadLoop","detail":"{readStateIndex:2810; appliedIndex:2809; }","duration":"361.89959ms","start":"2026-09-18T15:12:50.935152Z","end":"2026-09-18T15:12:51.297051Z","steps":["trace[1559590547] 'read index received'  (duration: 354.82991ms)","trace[1559590547] 'applied index is now lower than readState.Index'  (duration: 7.067709ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:12:51.298209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.345067ms","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-09-18T15:12:51.29826Z","caller":"traceutil/trace.go:171","msg":"trace[1685683014] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2701; }","duration":"331.478811ms","start":"2026-09-18T15:12:50.966762Z","end":"2026-09-18T15:12:51.298241Z","steps":["trace[1685683014] 'agreement among raft nodes before linearized reading'  (duration: 331.192502ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:12:51.298297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:12:50.966731Z","time spent":"331.558053ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-09-18T15:12:51.298746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.304517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-09-18T15:12:51.298772Z","caller":"traceutil/trace.go:171","msg":"trace[1148961180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2701; }","duration":"323.383069ms","start":"2026-09-18T15:12:50.975382Z","end":"2026-09-18T15:12:51.298766Z","steps":["trace[1148961180] 'agreement among raft nodes before linearized reading'  (duration: 323.299927ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:12:51.298789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:12:50.975351Z","time spent":"323.434181ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-09-18T15:12:51.298909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.659538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-09-18T15:12:51.298926Z","caller":"traceutil/trace.go:171","msg":"trace[777626599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2701; }","duration":"323.714859ms","start":"2026-09-18T15:12:50.975206Z","end":"2026-09-18T15:12:51.298921Z","steps":["trace[777626599] 'agreement among raft nodes before linearized reading'  (duration: 323.658407ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:12:51.298941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:12:50.975184Z","time spent":"323.752531ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-09-18T15:13:07.505317Z","caller":"traceutil/trace.go:171","msg":"trace[586852811] transaction","detail":"{read_only:false; response_revision:2797; number_of_response:1; }","duration":"124.353085ms","start":"2026-09-18T15:13:07.380941Z","end":"2026-09-18T15:13:07.505294Z","steps":["trace[586852811] 'process raft request'  (duration: 124.313843ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:13:07.505769Z","caller":"traceutil/trace.go:171","msg":"trace[1068688476] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"126.822718ms","start":"2026-09-18T15:13:07.378924Z","end":"2026-09-18T15:13:07.505746Z","steps":["trace[1068688476] 'process raft request'  (duration: 126.232161ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:13:07.506122Z","caller":"traceutil/trace.go:171","msg":"trace[1893228547] transaction","detail":"{read_only:false; response_revision:2794; number_of_response:1; }","duration":"127.181128ms","start":"2026-09-18T15:13:07.378922Z","end":"2026-09-18T15:13:07.506103Z","steps":["trace[1893228547] 'process raft request'  (duration: 70.362336ms)","trace[1893228547] 'compare'  (duration: 55.74086ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:13:07.507059Z","caller":"traceutil/trace.go:171","msg":"trace[1739737902] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"127.029003ms","start":"2026-09-18T15:13:07.380015Z","end":"2026-09-18T15:13:07.507044Z","steps":["trace[1739737902] 'process raft request'  (duration: 125.20975ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:17:51.854906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.514574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0a18fa7e-86bb-44c6-a39a-21d8cd2e6b85\" ","response":"range_response_count:1 size:3774"}
{"level":"info","ts":"2026-09-18T15:17:51.854986Z","caller":"traceutil/trace.go:171","msg":"trace[1761145229] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0a18fa7e-86bb-44c6-a39a-21d8cd2e6b85; range_end:; response_count:1; response_revision:4942; }","duration":"115.645657ms","start":"2026-09-18T15:17:51.739321Z","end":"2026-09-18T15:17:51.854967Z","steps":["trace[1761145229] 'range keys from in-memory index tree'  (duration: 115.397502ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:17:53.491915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.115422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T15:17:53.491977Z","caller":"traceutil/trace.go:171","msg":"trace[2012456554] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:4963; }","duration":"193.222134ms","start":"2026-09-18T15:17:53.298742Z","end":"2026-09-18T15:17:53.491964Z","steps":["trace[2012456554] 'count revisions from in-memory index tree'  (duration: 193.04081ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:17:53.492013Z","caller":"traceutil/trace.go:171","msg":"trace[85729997] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"141.312611ms","start":"2026-09-18T15:17:53.350654Z","end":"2026-09-18T15:17:53.491967Z","steps":["trace[85729997] 'process raft request'  (duration: 58.231536ms)","trace[85729997] 'compare'  (duration: 82.999063ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:17:53.509081Z","caller":"traceutil/trace.go:171","msg":"trace[458289061] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"119.335225ms","start":"2026-09-18T15:17:53.389725Z","end":"2026-09-18T15:17:53.509061Z","steps":["trace[458289061] 'process raft request'  (duration: 119.221493ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:17:58.038959Z","caller":"traceutil/trace.go:171","msg":"trace[18303450] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"159.002892ms","start":"2026-09-18T15:17:57.879937Z","end":"2026-09-18T15:17:58.03894Z","steps":["trace[18303450] 'process raft request'  (duration: 151.528154ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:17:58.090665Z","caller":"traceutil/trace.go:171","msg":"trace[1159868418] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"198.802005ms","start":"2026-09-18T15:17:57.891818Z","end":"2026-09-18T15:17:58.09062Z","steps":["trace[1159868418] 'process raft request'  (duration: 198.601111ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:17:59.03476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.968112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"}
{"level":"info","ts":"2026-09-18T15:17:59.034889Z","caller":"traceutil/trace.go:171","msg":"trace[1806433555] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5106; }","duration":"111.136726ms","start":"2026-09-18T15:17:58.923736Z","end":"2026-09-18T15:17:59.034872Z","steps":["trace[1806433555] 'range keys from in-memory index tree'  (duration: 110.828279ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:18:02.573671Z","caller":"traceutil/trace.go:171","msg":"trace[694336342] linearizableReadLoop","detail":"{readStateIndex:5353; appliedIndex:5352; }","duration":"129.466712ms","start":"2026-09-18T15:18:02.444179Z","end":"2026-09-18T15:18:02.573646Z","steps":["trace[694336342] 'read index received'  (duration: 128.413459ms)","trace[694336342] 'applied index is now lower than readState.Index'  (duration: 1.052203ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:18:02.573986Z","caller":"traceutil/trace.go:171","msg":"trace[889456303] transaction","detail":"{read_only:false; response_revision:5151; number_of_response:1; }","duration":"129.868869ms","start":"2026-09-18T15:18:02.444106Z","end":"2026-09-18T15:18:02.573975Z","steps":["trace[889456303] 'process raft request'  (duration: 128.539421ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:18:02.574332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.130995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"}
{"level":"info","ts":"2026-09-18T15:18:02.574372Z","caller":"traceutil/trace.go:171","msg":"trace[995201818] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:5152; }","duration":"130.236097ms","start":"2026-09-18T15:18:02.444126Z","end":"2026-09-18T15:18:02.574362Z","steps":["trace[995201818] 'agreement among raft nodes before linearized reading'  (duration: 130.069894ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:18:02.574365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.684315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2592"}
{"level":"info","ts":"2026-09-18T15:18:02.574428Z","caller":"traceutil/trace.go:171","msg":"trace[1057377769] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5152; }","duration":"129.771316ms","start":"2026-09-18T15:18:02.444643Z","end":"2026-09-18T15:18:02.574414Z","steps":["trace[1057377769] 'agreement among raft nodes before linearized reading'  (duration: 129.619933ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:18:02.574663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.767766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-83c29ddf-89ab-4fab-99ed-58da7e64eebf\" ","response":"range_response_count:1 size:3954"}
{"level":"info","ts":"2026-09-18T15:18:02.574681Z","caller":"traceutil/trace.go:171","msg":"trace[1810483983] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-83c29ddf-89ab-4fab-99ed-58da7e64eebf; range_end:; response_count:1; response_revision:5152; }","duration":"120.826858ms","start":"2026-09-18T15:18:02.45385Z","end":"2026-09-18T15:18:02.574677Z","steps":["trace[1810483983] 'agreement among raft nodes before linearized reading'  (duration: 120.763806ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:18:19.651991Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2863}
{"level":"info","ts":"2026-09-18T15:18:19.728369Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2863,"took":"75.074691ms","hash":3975743560,"current-db-size-bytes":51396608,"current-db-size":"51 MB","current-db-size-in-use-bytes":27492352,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-18T15:18:19.728437Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3975743560,"revision":2863,"compact-revision":-1}
{"level":"info","ts":"2026-09-18T15:19:15.990382Z","caller":"traceutil/trace.go:171","msg":"trace[2105531393] transaction","detail":"{read_only:false; response_revision:5800; number_of_response:1; }","duration":"172.208034ms","start":"2026-09-18T15:19:15.818158Z","end":"2026-09-18T15:19:15.990366Z","steps":["trace[2105531393] 'process raft request'  (duration: 171.49323ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:19:15.989966Z","caller":"traceutil/trace.go:171","msg":"trace[1617697045] transaction","detail":"{read_only:false; response_revision:5801; number_of_response:1; }","duration":"164.097327ms","start":"2026-09-18T15:19:15.825786Z","end":"2026-09-18T15:19:15.989883Z","steps":["trace[1617697045] 'process raft request'  (duration: 164.035265ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:21:42.786047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.331843ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9642664976689593579 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:6806 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-18T15:21:42.786235Z","caller":"traceutil/trace.go:171","msg":"trace[94914256] linearizableReadLoop","detail":"{readStateIndex:7077; appliedIndex:7074; }","duration":"190.394027ms","start":"2026-09-18T15:21:42.595829Z","end":"2026-09-18T15:21:42.786223Z","steps":["trace[94914256] 'read index received'  (duration: 3.823516ms)","trace[94914256] 'applied index is now lower than readState.Index'  (duration: 186.569781ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:21:42.786365Z","caller":"traceutil/trace.go:171","msg":"trace[902096587] transaction","detail":"{read_only:false; response_revision:6821; number_of_response:1; }","duration":"202.450566ms","start":"2026-09-18T15:21:42.583892Z","end":"2026-09-18T15:21:42.786342Z","steps":["trace[902096587] 'process raft request'  (duration: 202.305641ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:21:42.786477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.666907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-18T15:21:42.786509Z","caller":"traceutil/trace.go:171","msg":"trace[1158946829] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6821; }","duration":"190.735681ms","start":"2026-09-18T15:21:42.595765Z","end":"2026-09-18T15:21:42.7865Z","steps":["trace[1158946829] 'agreement among raft nodes before linearized reading'  (duration: 190.618896ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:21:42.786623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.479157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-09-18T15:21:42.786649Z","caller":"traceutil/trace.go:171","msg":"trace[310997759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6821; }","duration":"171.537149ms","start":"2026-09-18T15:21:42.615107Z","end":"2026-09-18T15:21:42.786644Z","steps":["trace[310997759] 'agreement among raft nodes before linearized reading'  (duration: 171.475526ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:21:42.786758Z","caller":"traceutil/trace.go:171","msg":"trace[1722690623] transaction","detail":"{read_only:false; response_revision:6820; number_of_response:1; }","duration":"238.408198ms","start":"2026-09-18T15:21:42.548319Z","end":"2026-09-18T15:21:42.786727Z","steps":["trace[1722690623] 'process raft request'  (duration: 237.809534ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:21:42.786809Z","caller":"traceutil/trace.go:171","msg":"trace[742262763] transaction","detail":"{read_only:false; response_revision:6819; number_of_response:1; }","duration":"318.097154ms","start":"2026-09-18T15:21:42.468702Z","end":"2026-09-18T15:21:42.7868Z","steps":["trace[742262763] 'process raft request'  (duration: 130.94257ms)","trace[742262763] 'compare'  (duration: 186.179927ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T15:21:42.786866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:21:42.46869Z","time spent":"318.137546ms","remote":"127.0.0.1:53550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:6806 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-09-18T15:22:02.471247Z","caller":"traceutil/trace.go:171","msg":"trace[1224583490] linearizableReadLoop","detail":"{readStateIndex:7226; appliedIndex:7225; }","duration":"236.77498ms","start":"2026-09-18T15:22:02.234453Z","end":"2026-09-18T15:22:02.471228Z","steps":["trace[1224583490] 'read index received'  (duration: 236.648235ms)","trace[1224583490] 'applied index is now lower than readState.Index'  (duration: 126.035µs)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:22:02.471272Z","caller":"traceutil/trace.go:171","msg":"trace[407772793] transaction","detail":"{read_only:false; response_revision:6962; number_of_response:1; }","duration":"244.602478ms","start":"2026-09-18T15:22:02.226656Z","end":"2026-09-18T15:22:02.471258Z","steps":["trace[407772793] 'process raft request'  (duration: 244.451443ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T15:22:02.471385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.916676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-09-18T15:22:02.471411Z","caller":"traceutil/trace.go:171","msg":"trace[74484339] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6962; }","duration":"236.971388ms","start":"2026-09-18T15:22:02.234433Z","end":"2026-09-18T15:22:02.471404Z","steps":["trace[74484339] 'agreement among raft nodes before linearized reading'  (duration: 236.863123ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:22:02.488148Z","caller":"traceutil/trace.go:171","msg":"trace[1156211094] transaction","detail":"{read_only:false; response_revision:6963; number_of_response:1; }","duration":"128.402014ms","start":"2026-09-18T15:22:02.359726Z","end":"2026-09-18T15:22:02.488129Z","steps":["trace[1156211094] 'process raft request'  (duration: 128.250839ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T15:22:13.053431Z","caller":"traceutil/trace.go:171","msg":"trace[829413078] transaction","detail":"{read_only:false; response_revision:7033; number_of_response:1; }","duration":"110.237399ms","start":"2026-09-18T15:22:12.943172Z","end":"2026-09-18T15:22:13.053409Z","steps":["trace[829413078] 'process raft request'  (duration: 70.777715ms)","trace[829413078] 'compare'  (duration: 39.109132ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T15:23:19.664077Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5334}
{"level":"info","ts":"2026-09-18T15:23:19.775983Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5334,"took":"110.766932ms","hash":2589465306,"current-db-size-bytes":51396608,"current-db-size":"51 MB","current-db-size-in-use-bytes":18874368,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-09-18T15:23:19.77605Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2589465306,"revision":5334,"compact-revision":2863}