{"level":"warn","ts":"2026-09-07T08:26:28.068376Z","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-07T08:26:28.06847Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.27: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.27:2380","--initial-cluster=instance=https://162.253.55.27:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.27:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.27: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-07T08:26:28.06854Z","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-07T08:26:28.068553Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.27:2380"]}
{"level":"info","ts":"2026-09-07T08:26:28.068574Z","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-07T08:26:28.069412Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.27:2379"]}
{"level":"info","ts":"2026-09-07T08:26:28.069498Z","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.27:2380"],"listen-peer-urls":["https://162.253.55.27:2380"],"advertise-client-urls":["https://162.253.55.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.27: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-07T08:26:28.073432Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.707382ms"}
{"level":"info","ts":"2026-09-07T08:26:28.082326Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d9b565cb482924cf","cluster-id":"5bc3f8d4cf836b6c"}
{"level":"info","ts":"2026-09-07T08:26:28.082408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf switched to configuration voters=()"}
{"level":"info","ts":"2026-09-07T08:26:28.082428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became follower at term 0"}
{"level":"info","ts":"2026-09-07T08:26:28.082438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d9b565cb482924cf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-07T08:26:28.082448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became follower at term 1"}
{"level":"info","ts":"2026-09-07T08:26:28.08249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf switched to configuration voters=(15687556800778413263)"}
{"level":"warn","ts":"2026-09-07T08:26:28.088662Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-07T08:26:28.091062Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-07T08:26:28.092484Z","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-07T08:26:28.094701Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d9b565cb482924cf","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-07T08:26:28.094826Z","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-07T08:26:28.094937Z","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-07T08:26:28.094878Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d9b565cb482924cf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-07T08:26:28.094949Z","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-07T08:26:28.097523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf switched to configuration voters=(15687556800778413263)"}
{"level":"info","ts":"2026-09-07T08:26:28.098481Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5bc3f8d4cf836b6c","local-member-id":"d9b565cb482924cf","added-peer-id":"d9b565cb482924cf","added-peer-peer-urls":["https://162.253.55.27:2380"]}
{"level":"info","ts":"2026-09-07T08:26:28.100139Z","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-07T08:26:28.100394Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.27:2380"}
{"level":"info","ts":"2026-09-07T08:26:28.10041Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.27:2380"}
{"level":"info","ts":"2026-09-07T08:26:28.101403Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d9b565cb482924cf","initial-advertise-peer-urls":["https://162.253.55.27:2380"],"listen-peer-urls":["https://162.253.55.27:2380"],"advertise-client-urls":["https://162.253.55.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-07T08:26:28.101443Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-07T08:26:28.784043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf is starting a new election at term 1"}
{"level":"info","ts":"2026-09-07T08:26:28.785805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-07T08:26:28.787041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf received MsgPreVoteResp from d9b565cb482924cf at term 1"}
{"level":"info","ts":"2026-09-07T08:26:28.787109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became candidate at term 2"}
{"level":"info","ts":"2026-09-07T08:26:28.787194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf received MsgVoteResp from d9b565cb482924cf at term 2"}
{"level":"info","ts":"2026-09-07T08:26:28.787221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became leader at term 2"}
{"level":"info","ts":"2026-09-07T08:26:28.787305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d9b565cb482924cf elected leader d9b565cb482924cf at term 2"}
{"level":"info","ts":"2026-09-07T08:26:28.988757Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d9b565cb482924cf","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.27:2379]}","request-path":"/0/members/d9b565cb482924cf/attributes","cluster-id":"5bc3f8d4cf836b6c","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-07T08:26:28.988873Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-07T08:26:28.988543Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T08:26:28.989313Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-07T08:26:28.990485Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-07T08:26:28.990604Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-07T08:26:28.992283Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.27:2379"}
{"level":"info","ts":"2026-09-07T08:26:28.993922Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-07T08:26:29.176409Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5bc3f8d4cf836b6c","local-member-id":"d9b565cb482924cf","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T08:26:29.176582Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T08:26:29.176652Z","caller":"traceutil/trace.go:171","msg":"trace[1705720266] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"119.814457ms","start":"2026-09-07T08:26:29.056815Z","end":"2026-09-07T08:26:29.17663Z","steps":["trace[1705720266] 'read index received'  (duration: 119.547062ms)","trace[1705720266] 'applied index is now lower than readState.Index'  (duration: 265.335µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:26:29.176672Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-09-07T08:26:29.176921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.057072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-09-07T08:26:29.176922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.959961ms","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:4"}
{"level":"info","ts":"2026-09-07T08:26:29.176976Z","caller":"traceutil/trace.go:171","msg":"trace[446287461] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"120.187706ms","start":"2026-09-07T08:26:29.056776Z","end":"2026-09-07T08:26:29.176964Z","steps":["trace[446287461] 'agreement among raft nodes before linearized reading'  (duration: 119.94611ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:26:29.176996Z","caller":"traceutil/trace.go:171","msg":"trace[1524460214] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"120.124985ms","start":"2026-09-07T08:26:29.05685Z","end":"2026-09-07T08:26:29.176975Z","steps":["trace[1524460214] 'agreement among raft nodes before linearized reading'  (duration: 119.89303ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:26:34.165218Z","caller":"traceutil/trace.go:171","msg":"trace[82068711] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"109.471986ms","start":"2026-09-07T08:26:34.055688Z","end":"2026-09-07T08:26:34.16516Z","steps":["trace[82068711] 'process raft request'  (duration: 18.328957ms)","trace[82068711] 'compare'  (duration: 90.850083ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:27:17.586555Z","caller":"traceutil/trace.go:171","msg":"trace[115702980] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"177.388965ms","start":"2026-09-07T08:27:17.409122Z","end":"2026-09-07T08:27:17.586511Z","steps":["trace[115702980] 'process raft request'  (duration: 177.180851ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:17.596303Z","caller":"traceutil/trace.go:171","msg":"trace[1264495801] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"180.936005ms","start":"2026-09-07T08:27:17.415337Z","end":"2026-09-07T08:27:17.596273Z","steps":["trace[1264495801] 'process raft request'  (duration: 180.575689ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:17.596521Z","caller":"traceutil/trace.go:171","msg":"trace[1273724019] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"166.005201ms","start":"2026-09-07T08:27:17.430497Z","end":"2026-09-07T08:27:17.596502Z","steps":["trace[1273724019] 'process raft request'  (duration: 165.626185ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:17.596661Z","caller":"traceutil/trace.go:171","msg":"trace[820308536] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"163.455457ms","start":"2026-09-07T08:27:17.433185Z","end":"2026-09-07T08:27:17.59664Z","steps":["trace[820308536] 'process raft request'  (duration: 163.132282ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:17.596647Z","caller":"traceutil/trace.go:171","msg":"trace[229904217] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"181.120308ms","start":"2026-09-07T08:27:17.415449Z","end":"2026-09-07T08:27:17.596569Z","steps":["trace[229904217] 'process raft request'  (duration: 180.584349ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:17.597034Z","caller":"traceutil/trace.go:171","msg":"trace[1686602650] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"164.922023ms","start":"2026-09-07T08:27:17.431945Z","end":"2026-09-07T08:27:17.596867Z","steps":["trace[1686602650] 'process raft request'  (duration: 164.232981ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:17.597135Z","caller":"traceutil/trace.go:171","msg":"trace[182216937] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"131.484115ms","start":"2026-09-07T08:27:17.465631Z","end":"2026-09-07T08:27:17.597115Z","steps":["trace[182216937] 'process raft request'  (duration: 131.021587ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:17.597173Z","caller":"traceutil/trace.go:171","msg":"trace[754060268] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"150.984547ms","start":"2026-09-07T08:27:17.446171Z","end":"2026-09-07T08:27:17.597155Z","steps":["trace[754060268] 'process raft request'  (duration: 150.384516ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:17.597283Z","caller":"traceutil/trace.go:171","msg":"trace[1757278393] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"164.026919ms","start":"2026-09-07T08:27:17.433241Z","end":"2026-09-07T08:27:17.597268Z","steps":["trace[1757278393] 'process raft request'  (duration: 163.166584ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:17.597428Z","caller":"traceutil/trace.go:171","msg":"trace[290025916] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"157.587839ms","start":"2026-09-07T08:27:17.439819Z","end":"2026-09-07T08:27:17.597407Z","steps":["trace[290025916] 'process raft request'  (duration: 156.659393ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:17.597525Z","caller":"traceutil/trace.go:171","msg":"trace[1962137671] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"101.20592ms","start":"2026-09-07T08:27:17.496293Z","end":"2026-09-07T08:27:17.597226Z","steps":["trace[1962137671] 'process raft request'  (duration: 100.563399ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:23.961849Z","caller":"traceutil/trace.go:171","msg":"trace[205804064] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"246.035366ms","start":"2026-09-07T08:27:23.715784Z","end":"2026-09-07T08:27:23.961819Z","steps":["trace[205804064] 'read index received'  (duration: 245.051219ms)","trace[205804064] 'applied index is now lower than readState.Index'  (duration: 983.257µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:27:23.961933Z","caller":"traceutil/trace.go:171","msg":"trace[1233513605] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"262.365058ms","start":"2026-09-07T08:27:23.699536Z","end":"2026-09-07T08:27:23.961901Z","steps":["trace[1233513605] 'process raft request'  (duration: 261.677976ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:27:23.962223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.415354ms","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-07T08:27:23.96235Z","caller":"traceutil/trace.go:171","msg":"trace[2103190750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:659; }","duration":"246.541765ms","start":"2026-09-07T08:27:23.715737Z","end":"2026-09-07T08:27:23.962279Z","steps":["trace[2103190750] 'agreement among raft nodes before linearized reading'  (duration: 246.2407ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:27:23.962754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.878597ms","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-07T08:27:23.962812Z","caller":"traceutil/trace.go:171","msg":"trace[1828055377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:659; }","duration":"194.975339ms","start":"2026-09-07T08:27:23.767821Z","end":"2026-09-07T08:27:23.962796Z","steps":["trace[1828055377] 'agreement among raft nodes before linearized reading'  (duration: 194.818277ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:24.154999Z","caller":"traceutil/trace.go:171","msg":"trace[568980729] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"186.951897ms","start":"2026-09-07T08:27:23.968013Z","end":"2026-09-07T08:27:24.154965Z","steps":["trace[568980729] 'process raft request'  (duration: 101.881958ms)","trace[568980729] 'compare'  (duration: 84.927996ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:27:24.253185Z","caller":"traceutil/trace.go:171","msg":"trace[1595167598] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"284.591982ms","start":"2026-09-07T08:27:23.968545Z","end":"2026-09-07T08:27:24.253137Z","steps":["trace[1595167598] 'process raft request'  (duration: 284.373759ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:24.253274Z","caller":"traceutil/trace.go:171","msg":"trace[31391030] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:686; }","duration":"240.677584ms","start":"2026-09-07T08:27:24.012564Z","end":"2026-09-07T08:27:24.253241Z","steps":["trace[31391030] 'read index received'  (duration: 57.337189ms)","trace[31391030] 'applied index is now lower than readState.Index'  (duration: 183.339385ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:27:24.253306Z","caller":"traceutil/trace.go:171","msg":"trace[1487509694] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"217.349678ms","start":"2026-09-07T08:27:24.035923Z","end":"2026-09-07T08:27:24.253272Z","steps":["trace[1487509694] 'process raft request'  (duration: 217.109184ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:27:24.253415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.839236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:27:24.25345Z","caller":"traceutil/trace.go:171","msg":"trace[1979869458] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:662; }","duration":"240.937618ms","start":"2026-09-07T08:27:24.012501Z","end":"2026-09-07T08:27:24.253439Z","steps":["trace[1979869458] 'agreement among raft nodes before linearized reading'  (duration: 240.843017ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:27:24.754217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.392315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:27:24.754334Z","caller":"traceutil/trace.go:171","msg":"trace[1588455984] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:662; }","duration":"487.5637ms","start":"2026-09-07T08:27:24.266735Z","end":"2026-09-07T08:27:24.754299Z","steps":["trace[1588455984] 'range keys from in-memory index tree'  (duration: 487.308334ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:27:24.754428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:27:24.266709Z","time spent":"487.695212ms","remote":"127.0.0.1:38104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "}
{"level":"warn","ts":"2026-09-07T08:27:24.755046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.088637ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2652515155582351244 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-rbkr8\" mod_revision:543 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-rbkr8\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-rbkr8\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:27:24.755145Z","caller":"traceutil/trace.go:171","msg":"trace[1257834920] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"479.708249ms","start":"2026-09-07T08:27:24.275416Z","end":"2026-09-07T08:27:24.755124Z","steps":["trace[1257834920] 'process raft request'  (duration: 91.743198ms)","trace[1257834920] 'compare'  (duration: 386.913563ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:27:24.755221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:27:24.275383Z","time spent":"479.79596ms","remote":"127.0.0.1:38072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-rbkr8\" mod_revision:543 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-rbkr8\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-rbkr8\" > >"}
{"level":"info","ts":"2026-09-07T08:27:25.068864Z","caller":"traceutil/trace.go:171","msg":"trace[899733994] linearizableReadLoop","detail":"{readStateIndex:691; appliedIndex:690; }","duration":"102.172228ms","start":"2026-09-07T08:27:24.966653Z","end":"2026-09-07T08:27:25.068825Z","steps":["trace[899733994] 'read index received'  (duration: 44.915863ms)","trace[899733994] 'applied index is now lower than readState.Index'  (duration: 57.254495ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:27:25.068924Z","caller":"traceutil/trace.go:171","msg":"trace[112661124] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"159.72768ms","start":"2026-09-07T08:27:24.90916Z","end":"2026-09-07T08:27:25.068888Z","steps":["trace[112661124] 'process raft request'  (duration: 102.476155ms)","trace[112661124] 'compare'  (duration: 56.95207ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:27:25.069172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.488193ms","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-07T08:27:25.069247Z","caller":"traceutil/trace.go:171","msg":"trace[1510209505] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:664; }","duration":"102.637905ms","start":"2026-09-07T08:27:24.966595Z","end":"2026-09-07T08:27:25.069233Z","steps":["trace[1510209505] 'agreement among raft nodes before linearized reading'  (duration: 102.383141ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:27:41.691383Z","caller":"traceutil/trace.go:171","msg":"trace[1792686584] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"313.959454ms","start":"2026-09-07T08:27:41.377399Z","end":"2026-09-07T08:27:41.691358Z","steps":["trace[1792686584] 'process raft request'  (duration: 313.804551ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:27:41.691673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:27:41.37738Z","time spent":"314.198247ms","remote":"127.0.0.1:38072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2jzfm\" mod_revision:764 > success:<request_put:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2jzfm\" value_size:3943 >> failure:<request_range:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2jzfm\" > >"}
{"level":"info","ts":"2026-09-07T08:28:33.791178Z","caller":"traceutil/trace.go:171","msg":"trace[1273580095] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"130.579869ms","start":"2026-09-07T08:28:33.660571Z","end":"2026-09-07T08:28:33.791151Z","steps":["trace[1273580095] 'process raft request'  (duration: 130.385186ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:29:07.424567Z","caller":"traceutil/trace.go:171","msg":"trace[873884710] linearizableReadLoop","detail":"{readStateIndex:2014; appliedIndex:2013; }","duration":"269.924495ms","start":"2026-09-07T08:29:07.154609Z","end":"2026-09-07T08:29:07.424534Z","steps":["trace[873884710] 'read index received'  (duration: 269.736003ms)","trace[873884710] 'applied index is now lower than readState.Index'  (duration: 187.092µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:29:07.424883Z","caller":"traceutil/trace.go:171","msg":"trace[164014906] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"347.688982ms","start":"2026-09-07T08:29:07.077013Z","end":"2026-09-07T08:29:07.424702Z","steps":["trace[164014906] 'process raft request'  (duration: 347.322867ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:07.425032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.405411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"}
{"level":"info","ts":"2026-09-07T08:29:07.42508Z","caller":"traceutil/trace.go:171","msg":"trace[1492745148] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1938; }","duration":"270.515793ms","start":"2026-09-07T08:29:07.154549Z","end":"2026-09-07T08:29:07.425065Z","steps":["trace[1492745148] 'agreement among raft nodes before linearized reading'  (duration: 270.141028ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:07.425443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:07.076982Z","time spent":"348.172858ms","remote":"127.0.0.1:38058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7740,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:1408 > success:<request_put:<key:\"/registry/minions/instance\" value_size:7706 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-09-07T08:29:07.551391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.223972ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2652515155582353813 > lease_revoke:<id:24cfa07af9d37fce>","response":"size:28"}
{"level":"info","ts":"2026-09-07T08:29:07.55179Z","caller":"traceutil/trace.go:171","msg":"trace[408418630] linearizableReadLoop","detail":"{readStateIndex:2015; appliedIndex:2014; }","duration":"127.10601ms","start":"2026-09-07T08:29:07.424656Z","end":"2026-09-07T08:29:07.551762Z","steps":["trace[408418630] 'read index received'  (duration: 8.607865ms)","trace[408418630] 'applied index is now lower than readState.Index'  (duration: 118.494285ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:29:07.551941Z","caller":"traceutil/trace.go:171","msg":"trace[686117495] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"119.814312ms","start":"2026-09-07T08:29:07.432099Z","end":"2026-09-07T08:29:07.551913Z","steps":["trace[686117495] 'process raft request'  (duration: 119.553899ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:07.552011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.218679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-09-07T08:29:07.55217Z","caller":"traceutil/trace.go:171","msg":"trace[1449319834] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1939; }","duration":"230.436232ms","start":"2026-09-07T08:29:07.321717Z","end":"2026-09-07T08:29:07.552153Z","steps":["trace[1449319834] 'agreement among raft nodes before linearized reading'  (duration: 230.123058ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:07.846988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.338876ms","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-07T08:29:07.847138Z","caller":"traceutil/trace.go:171","msg":"trace[2085911094] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1940; }","duration":"133.505578ms","start":"2026-09-07T08:29:07.71361Z","end":"2026-09-07T08:29:07.847116Z","steps":["trace[2085911094] 'range keys from in-memory index tree'  (duration: 133.127403ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:29:07.847666Z","caller":"traceutil/trace.go:171","msg":"trace[38074497] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"124.465927ms","start":"2026-09-07T08:29:07.723161Z","end":"2026-09-07T08:29:07.847627Z","steps":["trace[38074497] 'process raft request'  (duration: 91.821477ms)","trace[38074497] 'compare'  (duration: 31.747558ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:29:21.158382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.694463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:29:21.158511Z","caller":"traceutil/trace.go:171","msg":"trace[1457473623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2047; }","duration":"146.830754ms","start":"2026-09-07T08:29:21.011638Z","end":"2026-09-07T08:29:21.158469Z","steps":["trace[1457473623] 'range keys from in-memory index tree'  (duration: 146.584501ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:21.158542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.334257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-09-07T08:29:21.158634Z","caller":"traceutil/trace.go:171","msg":"trace[1346766356] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2047; }","duration":"179.54906ms","start":"2026-09-07T08:29:20.979063Z","end":"2026-09-07T08:29:21.158612Z","steps":["trace[1346766356] 'range keys from in-memory index tree'  (duration: 179.076205ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:21.159237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.762343ms","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-07T08:29:21.159307Z","caller":"traceutil/trace.go:171","msg":"trace[1473044670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2047; }","duration":"218.874215ms","start":"2026-09-07T08:29:20.940413Z","end":"2026-09-07T08:29:21.159287Z","steps":["trace[1473044670] 'range keys from in-memory index tree'  (duration: 217.89828ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:42.33375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.342897ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2652515155582354387 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2168 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:29:42.333935Z","caller":"traceutil/trace.go:171","msg":"trace[1631488394] linearizableReadLoop","detail":"{readStateIndex:2263; appliedIndex:2262; }","duration":"142.428071ms","start":"2026-09-07T08:29:42.191481Z","end":"2026-09-07T08:29:42.333909Z","steps":["trace[1631488394] 'read index received'  (duration: 29.811541ms)","trace[1631488394] 'applied index is now lower than readState.Index'  (duration: 112.61388ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:29:42.334036Z","caller":"traceutil/trace.go:171","msg":"trace[158887198] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"204.67178ms","start":"2026-09-07T08:29:42.129252Z","end":"2026-09-07T08:29:42.333924Z","steps":["trace[158887198] 'process raft request'  (duration: 91.972629ms)","trace[158887198] 'compare'  (duration: 112.065113ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:29:42.334208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.722516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.27\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-09-07T08:29:42.334243Z","caller":"traceutil/trace.go:171","msg":"trace[922664894] range","detail":"{range_begin:/registry/masterleases/162.253.55.27; range_end:; response_count:1; response_revision:2178; }","duration":"142.801817ms","start":"2026-09-07T08:29:42.191429Z","end":"2026-09-07T08:29:42.334231Z","steps":["trace[922664894] 'agreement among raft nodes before linearized reading'  (duration: 142.551763ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:29:42.696233Z","caller":"traceutil/trace.go:171","msg":"trace[189369329] linearizableReadLoop","detail":"{readStateIndex:2265; appliedIndex:2264; }","duration":"262.072894ms","start":"2026-09-07T08:29:42.434128Z","end":"2026-09-07T08:29:42.696201Z","steps":["trace[189369329] 'read index received'  (duration: 261.815861ms)","trace[189369329] 'applied index is now lower than readState.Index'  (duration: 255.553µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:29:42.696263Z","caller":"traceutil/trace.go:171","msg":"trace[1381765289] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"322.065713ms","start":"2026-09-07T08:29:42.374168Z","end":"2026-09-07T08:29:42.696234Z","steps":["trace[1381765289] 'process raft request'  (duration: 321.804759ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:42.696432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.281167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-07T08:29:42.696496Z","caller":"traceutil/trace.go:171","msg":"trace[2038516727] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2179; }","duration":"262.416799ms","start":"2026-09-07T08:29:42.434066Z","end":"2026-09-07T08:29:42.696483Z","steps":["trace[2038516727] 'agreement among raft nodes before linearized reading'  (duration: 262.252377ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:42.696681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:42.374132Z","time spent":"322.208284ms","remote":"127.0.0.1:37924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.27\" mod_revision:2125 > success:<request_put:<key:\"/registry/masterleases/162.253.55.27\" value_size:66 lease:2652515155582354390 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.27\" > >"}
{"level":"info","ts":"2026-09-07T08:29:42.716643Z","caller":"traceutil/trace.go:171","msg":"trace[1365814440] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"190.274671ms","start":"2026-09-07T08:29:42.526315Z","end":"2026-09-07T08:29:42.716589Z","steps":["trace[1365814440] 'process raft request'  (duration: 190.029098ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:29:42.71697Z","caller":"traceutil/trace.go:171","msg":"trace[750916984] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"127.289513ms","start":"2026-09-07T08:29:42.589663Z","end":"2026-09-07T08:29:42.716953Z","steps":["trace[750916984] 'process raft request'  (duration: 126.839527ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:43.078018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.88581ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2652515155582354399 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2171 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:29:43.078275Z","caller":"traceutil/trace.go:171","msg":"trace[2143735636] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"310.167107ms","start":"2026-09-07T08:29:42.768078Z","end":"2026-09-07T08:29:43.078245Z","steps":["trace[2143735636] 'process raft request'  (duration: 168.877461ms)","trace[2143735636] 'compare'  (duration: 140.723748ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:29:43.078386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:42.768037Z","time spent":"310.297978ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2171 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-07T08:29:43.078746Z","caller":"traceutil/trace.go:171","msg":"trace[1623907170] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"244.115318ms","start":"2026-09-07T08:29:42.834609Z","end":"2026-09-07T08:29:43.078724Z","steps":["trace[1623907170] 'process raft request'  (duration: 243.550561ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:43.455087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.777849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"warn","ts":"2026-09-07T08:29:43.45542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.201685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-09-07T08:29:43.456141Z","caller":"traceutil/trace.go:171","msg":"trace[1237360316] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2184; }","duration":"157.919025ms","start":"2026-09-07T08:29:43.298199Z","end":"2026-09-07T08:29:43.456118Z","steps":["trace[1237360316] 'range keys from in-memory index tree'  (duration: 157.085073ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:29:43.45615Z","caller":"traceutil/trace.go:171","msg":"trace[2015498128] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2184; }","duration":"112.584889ms","start":"2026-09-07T08:29:43.343219Z","end":"2026-09-07T08:29:43.455803Z","steps":["trace[2015498128] 'range keys from in-memory index tree'  (duration: 111.539926ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:43.455651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.170017ms","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-07T08:29:43.456334Z","caller":"traceutil/trace.go:171","msg":"trace[528936294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2184; }","duration":"164.896266ms","start":"2026-09-07T08:29:43.291417Z","end":"2026-09-07T08:29:43.456313Z","steps":["trace[528936294] 'range keys from in-memory index tree'  (duration: 163.990855ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:29:43.779615Z","caller":"traceutil/trace.go:171","msg":"trace[131541344] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"318.349602ms","start":"2026-09-07T08:29:43.461229Z","end":"2026-09-07T08:29:43.779578Z","steps":["trace[131541344] 'process raft request'  (duration: 317.859695ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:43.779992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:43.461189Z","time spent":"318.677747ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2174 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-09-07T08:29:44.094015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.408372ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2652515155582354407 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2175 > 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-07T08:29:44.094313Z","caller":"traceutil/trace.go:171","msg":"trace[1288135534] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"632.029362ms","start":"2026-09-07T08:29:43.46225Z","end":"2026-09-07T08:29:44.094279Z","steps":["trace[1288135534] 'process raft request'  (duration: 450.214934ms)","trace[1288135534] 'compare'  (duration: 181.22951ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:29:44.094442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:43.462226Z","time spent":"632.148863ms","remote":"127.0.0.1:38144","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:2175 > 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":"warn","ts":"2026-09-07T08:29:44.773885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.980554ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2652515155582354411 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2176 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:29:44.774221Z","caller":"traceutil/trace.go:171","msg":"trace[1261829695] linearizableReadLoop","detail":"{readStateIndex:2273; appliedIndex:2272; }","duration":"658.686209ms","start":"2026-09-07T08:29:44.115507Z","end":"2026-09-07T08:29:44.774193Z","steps":["trace[1261829695] 'read index received'  (duration: 113.133046ms)","trace[1261829695] 'applied index is now lower than readState.Index'  (duration: 545.551083ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:29:44.774238Z","caller":"traceutil/trace.go:171","msg":"trace[1704610504] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"671.528077ms","start":"2026-09-07T08:29:44.102678Z","end":"2026-09-07T08:29:44.774206Z","steps":["trace[1704610504] 'process raft request'  (duration: 126.046685ms)","trace[1704610504] 'compare'  (duration: 544.60411ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:29:44.774411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:44.102642Z","time spent":"671.667868ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2176 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-09-07T08:29:44.774534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.032463ms","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-07T08:29:44.774556Z","caller":"traceutil/trace.go:171","msg":"trace[649463636] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"295.52286ms","start":"2026-09-07T08:29:44.479023Z","end":"2026-09-07T08:29:44.774546Z","steps":["trace[649463636] 'process raft request'  (duration: 295.041184ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:29:44.774573Z","caller":"traceutil/trace.go:171","msg":"trace[631098365] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2188; }","duration":"659.119994ms","start":"2026-09-07T08:29:44.11544Z","end":"2026-09-07T08:29:44.77456Z","steps":["trace[631098365] 'agreement among raft nodes before linearized reading'  (duration: 658.895132ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:44.77462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:44.115392Z","time spent":"659.218265ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-09-07T08:29:44.774722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.360882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"warn","ts":"2026-09-07T08:29:44.774699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.247905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-09-07T08:29:44.774783Z","caller":"traceutil/trace.go:171","msg":"trace[103528463] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2189; }","duration":"309.430033ms","start":"2026-09-07T08:29:44.465313Z","end":"2026-09-07T08:29:44.774743Z","steps":["trace[103528463] 'agreement among raft nodes before linearized reading'  (duration: 309.306211ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:44.774803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:44.465287Z","time spent":"309.511644ms","remote":"127.0.0.1:38082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-09-07T08:29:44.774794Z","caller":"traceutil/trace.go:171","msg":"trace[1866695379] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2189; }","duration":"435.420847ms","start":"2026-09-07T08:29:44.339355Z","end":"2026-09-07T08:29:44.774776Z","steps":["trace[1866695379] 'agreement among raft nodes before linearized reading'  (duration: 435.173264ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:44.774832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:44.339326Z","time spent":"435.498818ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-07T08:30:37.153785Z","caller":"traceutil/trace.go:171","msg":"trace[979143542] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"123.248422ms","start":"2026-09-07T08:30:37.030479Z","end":"2026-09-07T08:30:37.153727Z","steps":["trace[979143542] 'process raft request'  (duration: 122.923218ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:30:37.355865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.54282ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2652515155582355188 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cilium.io/ciliumidentities/32255\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumidentities/32255\" value_size:1515 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:30:37.356136Z","caller":"traceutil/trace.go:171","msg":"trace[1856838803] transaction","detail":"{read_only:false; response_revision:2509; number_of_response:1; }","duration":"197.460877ms","start":"2026-09-07T08:30:37.158648Z","end":"2026-09-07T08:30:37.356109Z","steps":["trace[1856838803] 'process raft request'  (duration: 197.358033ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:30:37.356285Z","caller":"traceutil/trace.go:171","msg":"trace[892315053] linearizableReadLoop","detail":"{readStateIndex:2606; appliedIndex:2605; }","duration":"202.534709ms","start":"2026-09-07T08:30:37.153629Z","end":"2026-09-07T08:30:37.356164Z","steps":["trace[892315053] 'read index received'  (duration: 29.57941ms)","trace[892315053] 'applied index is now lower than readState.Index'  (duration: 172.950169ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:30:37.35653Z","caller":"traceutil/trace.go:171","msg":"trace[473895739] transaction","detail":"{read_only:false; response_revision:2508; number_of_response:1; }","duration":"259.179607ms","start":"2026-09-07T08:30:37.097298Z","end":"2026-09-07T08:30:37.356478Z","steps":["trace[473895739] 'process raft request'  (duration: 85.936476ms)","trace[473895739] 'compare'  (duration: 172.334601ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:30:37.35696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.86185ms","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-07T08:30:37.357183Z","caller":"traceutil/trace.go:171","msg":"trace[526291941] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2509; }","duration":"275.08826ms","start":"2026-09-07T08:30:37.082036Z","end":"2026-09-07T08:30:37.357124Z","steps":["trace[526291941] 'agreement among raft nodes before linearized reading'  (duration: 274.469744ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:30:37.357554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.97599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-07T08:30:37.357618Z","caller":"traceutil/trace.go:171","msg":"trace[151688518] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2509; }","duration":"123.148838ms","start":"2026-09-07T08:30:37.234453Z","end":"2026-09-07T08:30:37.357602Z","steps":["trace[151688518] 'agreement among raft nodes before linearized reading'  (duration: 122.985451ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:30:37.35795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.546031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-09-07T08:30:37.357996Z","caller":"traceutil/trace.go:171","msg":"trace[103071556] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2509; }","duration":"200.613783ms","start":"2026-09-07T08:30:37.157371Z","end":"2026-09-07T08:30:37.357984Z","steps":["trace[103071556] 'agreement among raft nodes before linearized reading'  (duration: 199.925494ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:30:37.602388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.206447ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2652515155582355196 > lease_revoke:<id:24cfa07af9d385f5>","response":"size:28"}
{"level":"info","ts":"2026-09-07T08:30:37.603824Z","caller":"traceutil/trace.go:171","msg":"trace[781186812] transaction","detail":"{read_only:false; response_revision:2513; number_of_response:1; }","duration":"189.952379ms","start":"2026-09-07T08:30:37.413828Z","end":"2026-09-07T08:30:37.60378Z","steps":["trace[781186812] 'process raft request'  (duration: 189.578783ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:30:37.604251Z","caller":"traceutil/trace.go:171","msg":"trace[981236186] transaction","detail":"{read_only:false; response_revision:2514; number_of_response:1; }","duration":"189.942419ms","start":"2026-09-07T08:30:37.414291Z","end":"2026-09-07T08:30:37.604234Z","steps":["trace[981236186] 'process raft request'  (duration: 189.393025ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:30:37.604629Z","caller":"traceutil/trace.go:171","msg":"trace[221206749] linearizableReadLoop","detail":"{readStateIndex:2614; appliedIndex:2610; }","duration":"139.452918ms","start":"2026-09-07T08:30:37.465134Z","end":"2026-09-07T08:30:37.604587Z","steps":["trace[221206749] 'read index received'  (duration: 8.831305ms)","trace[221206749] 'applied index is now lower than readState.Index'  (duration: 130.618963ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:30:37.604988Z","caller":"traceutil/trace.go:171","msg":"trace[124747831] transaction","detail":"{read_only:false; response_revision:2515; number_of_response:1; }","duration":"169.878553ms","start":"2026-09-07T08:30:37.435084Z","end":"2026-09-07T08:30:37.604962Z","steps":["trace[124747831] 'process raft request'  (duration: 168.969834ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:30:37.605431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.247984ms","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-07T08:30:37.60549Z","caller":"traceutil/trace.go:171","msg":"trace[328391521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2515; }","duration":"140.401411ms","start":"2026-09-07T08:30:37.465071Z","end":"2026-09-07T08:30:37.605472Z","steps":["trace[328391521] 'agreement among raft nodes before linearized reading'  (duration: 140.066295ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:30:37.83677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.900873ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2652515155582355203 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/specs/openstack/memcached-metrics\" mod_revision:0 > success:<request_put:<key:\"/registry/services/specs/openstack/memcached-metrics\" value_size:686 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:30:37.837042Z","caller":"traceutil/trace.go:171","msg":"trace[1864135650] transaction","detail":"{read_only:false; response_revision:2516; number_of_response:1; }","duration":"230.12674ms","start":"2026-09-07T08:30:37.60685Z","end":"2026-09-07T08:30:37.836977Z","steps":["trace[1864135650] 'process raft request'  (duration: 26.876052ms)","trace[1864135650] 'compare'  (duration: 202.029386ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:30:37.859877Z","caller":"traceutil/trace.go:171","msg":"trace[1772119576] linearizableReadLoop","detail":"{readStateIndex:2616; appliedIndex:2614; }","duration":"240.518682ms","start":"2026-09-07T08:30:37.619331Z","end":"2026-09-07T08:30:37.85985Z","steps":["trace[1772119576] 'read index received'  (duration: 14.430499ms)","trace[1772119576] 'applied index is now lower than readState.Index'  (duration: 226.086993ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:30:37.860242Z","caller":"traceutil/trace.go:171","msg":"trace[662608223] transaction","detail":"{read_only:false; response_revision:2517; number_of_response:1; }","duration":"250.839353ms","start":"2026-09-07T08:30:37.609349Z","end":"2026-09-07T08:30:37.860188Z","steps":["trace[662608223] 'process raft request'  (duration: 250.356812ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:30:37.860442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.083088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"}
{"level":"info","ts":"2026-09-07T08:30:37.860557Z","caller":"traceutil/trace.go:171","msg":"trace[1522069556] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2517; }","duration":"241.228476ms","start":"2026-09-07T08:30:37.619277Z","end":"2026-09-07T08:30:37.860506Z","steps":["trace[1522069556] 'agreement among raft nodes before linearized reading'  (duration: 240.963014ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:30:37.870988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.819582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-09-07T08:30:37.87118Z","caller":"traceutil/trace.go:171","msg":"trace[1887491430] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2519; }","duration":"148.091114ms","start":"2026-09-07T08:30:37.723071Z","end":"2026-09-07T08:30:37.871162Z","steps":["trace[1887491430] 'agreement among raft nodes before linearized reading'  (duration: 147.723478ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:30:49.470261Z","caller":"traceutil/trace.go:171","msg":"trace[759083112] transaction","detail":"{read_only:false; response_revision:2636; number_of_response:1; }","duration":"219.227595ms","start":"2026-09-07T08:30:49.250996Z","end":"2026-09-07T08:30:49.470223Z","steps":["trace[759083112] 'process raft request'  (duration: 217.608338ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:31:22.574836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.691826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18d2fcb660450e7a\" ","response":"range_response_count:1 size:781"}
{"level":"info","ts":"2026-09-07T08:31:22.574961Z","caller":"traceutil/trace.go:171","msg":"trace[1815533019] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18d2fcb660450e7a; range_end:; response_count:1; response_revision:2821; }","duration":"323.849931ms","start":"2026-09-07T08:31:22.251088Z","end":"2026-09-07T08:31:22.574938Z","steps":["trace[1815533019] 'range keys from in-memory index tree'  (duration: 323.51809ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:31:22.575004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:31:22.251075Z","time spent":"323.919223ms","remote":"127.0.0.1:37950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":804,"request content":"key:\"/registry/events/auth-system/keycloak-0.18d2fcb660450e7a\" "}
{"level":"warn","ts":"2026-09-07T08:31:22.575175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.816649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-07T08:31:22.575342Z","caller":"traceutil/trace.go:171","msg":"trace[1581271556] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2821; }","duration":"279.084169ms","start":"2026-09-07T08:31:22.296205Z","end":"2026-09-07T08:31:22.575289Z","steps":["trace[1581271556] 'count revisions from in-memory index tree'  (duration: 278.694354ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:31:22.756507Z","caller":"traceutil/trace.go:171","msg":"trace[848204184] transaction","detail":"{read_only:false; response_revision:2822; number_of_response:1; }","duration":"177.320319ms","start":"2026-09-07T08:31:22.579153Z","end":"2026-09-07T08:31:22.756474Z","steps":["trace[848204184] 'process raft request'  (duration: 177.090421ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:31:22.758682Z","caller":"traceutil/trace.go:171","msg":"trace[706853121] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"176.944915ms","start":"2026-09-07T08:31:22.581089Z","end":"2026-09-07T08:31:22.758034Z","steps":["trace[706853121] 'process raft request'  (duration: 176.730697ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:36:05.307629Z","caller":"traceutil/trace.go:171","msg":"trace[1268582346] linearizableReadLoop","detail":"{readStateIndex:5052; appliedIndex:5051; }","duration":"166.471483ms","start":"2026-09-07T08:36:05.141125Z","end":"2026-09-07T08:36:05.307596Z","steps":["trace[1268582346] 'read index received'  (duration: 5.033605ms)","trace[1268582346] 'applied index is now lower than readState.Index'  (duration: 161.436758ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:36:05.30774Z","caller":"traceutil/trace.go:171","msg":"trace[1227462734] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"168.464061ms","start":"2026-09-07T08:36:05.139217Z","end":"2026-09-07T08:36:05.307681Z","steps":["trace[1227462734] 'process raft request'  (duration: 168.150595ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:36:05.307971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.805349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"}
{"level":"info","ts":"2026-09-07T08:36:05.308017Z","caller":"traceutil/trace.go:171","msg":"trace[2060275570] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4861; }","duration":"166.899221ms","start":"2026-09-07T08:36:05.141107Z","end":"2026-09-07T08:36:05.308006Z","steps":["trace[2060275570] 'agreement among raft nodes before linearized reading'  (duration: 166.663576ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:36:11.599033Z","caller":"traceutil/trace.go:171","msg":"trace[218504992] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"125.931223ms","start":"2026-09-07T08:36:11.473069Z","end":"2026-09-07T08:36:11.599Z","steps":["trace[218504992] 'process raft request'  (duration: 125.728729ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:36:11.623147Z","caller":"traceutil/trace.go:171","msg":"trace[1739225601] linearizableReadLoop","detail":"{readStateIndex:5199; appliedIndex:5197; }","duration":"125.728949ms","start":"2026-09-07T08:36:11.497377Z","end":"2026-09-07T08:36:11.623106Z","steps":["trace[1739225601] 'read index received'  (duration: 101.451247ms)","trace[1739225601] 'applied index is now lower than readState.Index'  (duration: 24.275932ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:36:11.623284Z","caller":"traceutil/trace.go:171","msg":"trace[2047290091] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"140.910743ms","start":"2026-09-07T08:36:11.482346Z","end":"2026-09-07T08:36:11.623256Z","steps":["trace[2047290091] 'process raft request'  (duration: 140.553186ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:36:11.623959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.560264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"}
{"level":"info","ts":"2026-09-07T08:36:11.623992Z","caller":"traceutil/trace.go:171","msg":"trace[66572768] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5002; }","duration":"126.610755ms","start":"2026-09-07T08:36:11.49737Z","end":"2026-09-07T08:36:11.623981Z","steps":["trace[66572768] 'agreement among raft nodes before linearized reading'  (duration: 126.410382ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:36:11.738834Z","caller":"traceutil/trace.go:171","msg":"trace[1186403375] linearizableReadLoop","detail":"{readStateIndex:5200; appliedIndex:5199; }","duration":"115.588381ms","start":"2026-09-07T08:36:11.623216Z","end":"2026-09-07T08:36:11.738805Z","steps":["trace[1186403375] 'read index received'  (duration: 61.930282ms)","trace[1186403375] 'applied index is now lower than readState.Index'  (duration: 53.656659ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:36:11.739277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.544022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-09-07T08:36:11.739312Z","caller":"traceutil/trace.go:171","msg":"trace[84001173] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"120.150326ms","start":"2026-09-07T08:36:11.619074Z","end":"2026-09-07T08:36:11.739225Z","steps":["trace[84001173] 'process raft request'  (duration: 66.447956ms)","trace[84001173] 'compare'  (duration: 53.114519ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:36:11.739303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.416612ms","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-07T08:36:11.739388Z","caller":"traceutil/trace.go:171","msg":"trace[59988832] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5003; }","duration":"235.723966ms","start":"2026-09-07T08:36:11.503597Z","end":"2026-09-07T08:36:11.739321Z","steps":["trace[59988832] 'agreement among raft nodes before linearized reading'  (duration: 235.36358ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:36:11.739469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.600071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"}
{"level":"info","ts":"2026-09-07T08:36:11.739568Z","caller":"traceutil/trace.go:171","msg":"trace[213195622] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5003; }","duration":"220.706698ms","start":"2026-09-07T08:36:11.518793Z","end":"2026-09-07T08:36:11.739499Z","steps":["trace[213195622] 'agreement among raft nodes before linearized reading'  (duration: 220.063476ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:36:11.739383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.897901ms","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-07T08:36:11.739688Z","caller":"traceutil/trace.go:171","msg":"trace[1243058858] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5003; }","duration":"242.257868ms","start":"2026-09-07T08:36:11.497404Z","end":"2026-09-07T08:36:11.739662Z","steps":["trace[1243058858] 'agreement among raft nodes before linearized reading'  (duration: 241.706017ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:36:11.739709Z","caller":"traceutil/trace.go:171","msg":"trace[1224165664] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5003; }","duration":"101.803694ms","start":"2026-09-07T08:36:11.637767Z","end":"2026-09-07T08:36:11.739571Z","steps":["trace[1224165664] 'agreement among raft nodes before linearized reading'  (duration: 101.394866ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:36:18.015317Z","caller":"traceutil/trace.go:171","msg":"trace[608373136] transaction","detail":"{read_only:false; response_revision:5117; number_of_response:1; }","duration":"152.721789ms","start":"2026-09-07T08:36:17.862559Z","end":"2026-09-07T08:36:18.015281Z","steps":["trace[608373136] 'process raft request'  (duration: 152.360761ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:36:18.250871Z","caller":"traceutil/trace.go:171","msg":"trace[83089846] transaction","detail":"{read_only:false; response_revision:5118; number_of_response:1; }","duration":"385.534386ms","start":"2026-09-07T08:36:17.865312Z","end":"2026-09-07T08:36:18.250846Z","steps":["trace[83089846] 'process raft request'  (duration: 385.314262ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:36:18.251015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:36:17.865289Z","time spent":"385.651788ms","remote":"127.0.0.1:38144","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:5048 > 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-07T08:36:18.250985Z","caller":"traceutil/trace.go:171","msg":"trace[129710377] transaction","detail":"{read_only:false; response_revision:5119; number_of_response:1; }","duration":"385.379083ms","start":"2026-09-07T08:36:17.865568Z","end":"2026-09-07T08:36:18.250947Z","steps":["trace[129710377] 'process raft request'  (duration: 385.21787ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:36:18.251156Z","caller":"traceutil/trace.go:171","msg":"trace[2134995940] linearizableReadLoop","detail":"{readStateIndex:5320; appliedIndex:5317; }","duration":"282.295284ms","start":"2026-09-07T08:36:17.968853Z","end":"2026-09-07T08:36:18.251149Z","steps":["trace[2134995940] 'read index received'  (duration: 45.97354ms)","trace[2134995940] 'applied index is now lower than readState.Index'  (duration: 236.321054ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:36:18.251219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:36:17.865533Z","time spent":"385.541266ms","remote":"127.0.0.1:38144","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:5049 > 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":"warn","ts":"2026-09-07T08:36:18.251906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.029178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc6fda91-70c8-40dd-bf2e-c61617f2b70e\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-09-07T08:36:18.252003Z","caller":"traceutil/trace.go:171","msg":"trace[1293274772] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cc6fda91-70c8-40dd-bf2e-c61617f2b70e; range_end:; response_count:1; response_revision:5119; }","duration":"283.213701ms","start":"2026-09-07T08:36:17.968762Z","end":"2026-09-07T08:36:18.251976Z","steps":["trace[1293274772] 'agreement among raft nodes before linearized reading'  (duration: 282.466227ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:36:18.330519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.763179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:36:18.330629Z","caller":"traceutil/trace.go:171","msg":"trace[1041176333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5120; }","duration":"317.931522ms","start":"2026-09-07T08:36:18.012667Z","end":"2026-09-07T08:36:18.330599Z","steps":["trace[1041176333] 'agreement among raft nodes before linearized reading'  (duration: 317.737349ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:36:18.330702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:36:18.012632Z","time spent":"318.047934ms","remote":"127.0.0.1:37886","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-07T08:36:18.33071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.797829ms","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-07T08:36:18.330807Z","caller":"traceutil/trace.go:171","msg":"trace[1467399533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5120; }","duration":"278.008934ms","start":"2026-09-07T08:36:18.052776Z","end":"2026-09-07T08:36:18.330785Z","steps":["trace[1467399533] 'agreement among raft nodes before linearized reading'  (duration: 277.729079ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:36:29.0229Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2856}
{"level":"info","ts":"2026-09-07T08:36:29.109359Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2856,"took":"84.424989ms","hash":3823322124,"current-db-size-bytes":52436992,"current-db-size":"52 MB","current-db-size-in-use-bytes":27435008,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-09-07T08:36:29.109457Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3823322124,"revision":2856,"compact-revision":-1}
{"level":"info","ts":"2026-09-07T08:36:30.82277Z","caller":"traceutil/trace.go:171","msg":"trace[1704098899] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"141.107107ms","start":"2026-09-07T08:36:30.681632Z","end":"2026-09-07T08:36:30.822739Z","steps":["trace[1704098899] 'process raft request'  (duration: 140.364093ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:36:31.113317Z","caller":"traceutil/trace.go:171","msg":"trace[1635911400] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"121.474156ms","start":"2026-09-07T08:36:30.991812Z","end":"2026-09-07T08:36:31.113286Z","steps":["trace[1635911400] 'process raft request'  (duration: 113.298256ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:36:31.951154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.456653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-07T08:36:31.951288Z","caller":"traceutil/trace.go:171","msg":"trace[1348896242] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:5305; }","duration":"182.608715ms","start":"2026-09-07T08:36:31.768644Z","end":"2026-09-07T08:36:31.951252Z","steps":["trace[1348896242] 'count revisions from in-memory index tree'  (duration: 182.399862ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:36:31.951674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.920549ms","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-09-07T08:36:31.951726Z","caller":"traceutil/trace.go:171","msg":"trace[714782182] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5305; }","duration":"298.0177ms","start":"2026-09-07T08:36:31.653696Z","end":"2026-09-07T08:36:31.951713Z","steps":["trace[714782182] 'range keys from in-memory index tree'  (duration: 297.842266ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:36:31.951962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.494411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-54dcdf47f8-4ftw2\" ","response":"range_response_count:1 size:11847"}
{"level":"info","ts":"2026-09-07T08:36:31.952115Z","caller":"traceutil/trace.go:171","msg":"trace[1281148836] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-54dcdf47f8-4ftw2; range_end:; response_count:1; response_revision:5305; }","duration":"183.681226ms","start":"2026-09-07T08:36:31.768384Z","end":"2026-09-07T08:36:31.952065Z","steps":["trace[1281148836] 'range keys from in-memory index tree'  (duration: 183.165456ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:41:29.030922Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5283}
{"level":"info","ts":"2026-09-07T08:41:29.114506Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5283,"took":"81.834427ms","hash":2843054588,"current-db-size-bytes":52436992,"current-db-size":"52 MB","current-db-size-in-use-bytes":19300352,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-09-07T08:41:29.114643Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2843054588,"revision":5283,"compact-revision":2856}