{"level":"warn","ts":"2026-09-07T08:29:09.377339Z","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:29:09.377432Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.32: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.32:2380","--initial-cluster=instance=https://162.253.55.32:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.32:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.32: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:29:09.377521Z","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:29:09.37753Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.32:2380"]}
{"level":"info","ts":"2026-09-07T08:29:09.377546Z","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:29:09.378257Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"]}
{"level":"info","ts":"2026-09-07T08:29:09.378347Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.32:2380"],"listen-peer-urls":["https://162.253.55.32:2380"],"advertise-client-urls":["https://162.253.55.32:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.32: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:29:09.383764Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.162058ms"}
{"level":"info","ts":"2026-09-07T08:29:09.391914Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c665390cd9eacc14","cluster-id":"d19b610fbe64baae"}
{"level":"info","ts":"2026-09-07T08:29:09.392031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-07T08:29:09.392053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became follower at term 0"}
{"level":"info","ts":"2026-09-07T08:29:09.392067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c665390cd9eacc14 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-07T08:29:09.392076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became follower at term 1"}
{"level":"info","ts":"2026-09-07T08:29:09.392108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=(14295895319515941908)"}
{"level":"warn","ts":"2026-09-07T08:29:09.404919Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-07T08:29:09.406688Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-07T08:29:09.408239Z","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:29:09.411191Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c665390cd9eacc14","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-07T08:29:09.411727Z","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:29:09.411865Z","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:29:09.41188Z","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:29:09.411577Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c665390cd9eacc14","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-07T08:29:09.414292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=(14295895319515941908)"}
{"level":"info","ts":"2026-09-07T08:29:09.414539Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d19b610fbe64baae","local-member-id":"c665390cd9eacc14","added-peer-id":"c665390cd9eacc14","added-peer-peer-urls":["https://162.253.55.32:2380"]}
{"level":"info","ts":"2026-09-07T08:29:09.417906Z","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:29:09.418095Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.32:2380"}
{"level":"info","ts":"2026-09-07T08:29:09.418173Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.32:2380"}
{"level":"info","ts":"2026-09-07T08:29:09.418448Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-07T08:29:09.418378Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c665390cd9eacc14","initial-advertise-peer-urls":["https://162.253.55.32:2380"],"listen-peer-urls":["https://162.253.55.32:2380"],"advertise-client-urls":["https://162.253.55.32:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-07T08:29:09.794366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-07T08:29:09.794487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-07T08:29:09.794556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 received MsgPreVoteResp from c665390cd9eacc14 at term 1"}
{"level":"info","ts":"2026-09-07T08:29:09.79459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became candidate at term 2"}
{"level":"info","ts":"2026-09-07T08:29:09.794608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 received MsgVoteResp from c665390cd9eacc14 at term 2"}
{"level":"info","ts":"2026-09-07T08:29:09.794627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became leader at term 2"}
{"level":"info","ts":"2026-09-07T08:29:09.79465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c665390cd9eacc14 elected leader c665390cd9eacc14 at term 2"}
{"level":"info","ts":"2026-09-07T08:29:09.795976Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T08:29:09.797312Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c665390cd9eacc14","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.32:2379]}","request-path":"/0/members/c665390cd9eacc14/attributes","cluster-id":"d19b610fbe64baae","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-07T08:29:09.797324Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-07T08:29:09.797382Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-07T08:29:09.797691Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-07T08:29:09.79775Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-07T08:29:09.799442Z","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:29:09.799521Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d19b610fbe64baae","local-member-id":"c665390cd9eacc14","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T08:29:09.799637Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T08:29:09.799673Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T08:29:09.800751Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.32:2379"}
{"level":"info","ts":"2026-09-07T08:29:12.957083Z","caller":"traceutil/trace.go:171","msg":"trace[1006192236] transaction","detail":"{read_only:false; response_revision:193; number_of_response:1; }","duration":"123.33608ms","start":"2026-09-07T08:29:12.833723Z","end":"2026-09-07T08:29:12.957059Z","steps":["trace[1006192236] 'process raft request'  (duration: 111.593527ms)","trace[1006192236] 'compare'  (duration: 11.612199ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:29:22.295188Z","caller":"traceutil/trace.go:171","msg":"trace[1410136822] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"133.82614ms","start":"2026-09-07T08:29:22.161304Z","end":"2026-09-07T08:29:22.29513Z","steps":["trace[1410136822] 'process raft request'  (duration: 94.391928ms)","trace[1410136822] 'compare'  (duration: 39.216147ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:29:27.859223Z","caller":"traceutil/trace.go:171","msg":"trace[68502490] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:424; }","duration":"196.297677ms","start":"2026-09-07T08:29:27.6629Z","end":"2026-09-07T08:29:27.859198Z","steps":["trace[68502490] 'read index received'  (duration: 196.025619ms)","trace[68502490] 'applied index is now lower than readState.Index'  (duration: 271.088µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:29:27.859285Z","caller":"traceutil/trace.go:171","msg":"trace[647629457] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"607.875285ms","start":"2026-09-07T08:29:27.25139Z","end":"2026-09-07T08:29:27.859265Z","steps":["trace[647629457] 'process raft request'  (duration: 607.66772ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:27.859414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.496422ms","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-07T08:29:27.859733Z","caller":"traceutil/trace.go:171","msg":"trace[1614929934] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:416; }","duration":"196.847371ms","start":"2026-09-07T08:29:27.662858Z","end":"2026-09-07T08:29:27.859705Z","steps":["trace[1614929934] 'agreement among raft nodes before linearized reading'  (duration: 196.490842ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:27.860669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:27.251371Z","time spent":"608.220125ms","remote":"127.0.0.1:50060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7279,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:323 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7221 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >"}
{"level":"warn","ts":"2026-09-07T08:29:28.304385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.958591ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705555133350646934 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:412 > 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-07T08:29:28.304521Z","caller":"traceutil/trace.go:171","msg":"trace[1827664059] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"438.294662ms","start":"2026-09-07T08:29:27.866201Z","end":"2026-09-07T08:29:28.304496Z","steps":["trace[1827664059] 'process raft request'  (duration: 176.90765ms)","trace[1827664059] 'compare'  (duration: 260.730205ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:29:28.30464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:27.866185Z","time spent":"438.413355ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:412 > 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:29:28.623299Z","caller":"traceutil/trace.go:171","msg":"trace[838015746] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"748.328513ms","start":"2026-09-07T08:29:27.874893Z","end":"2026-09-07T08:29:28.623221Z","steps":["trace[838015746] 'process raft request'  (duration: 666.291674ms)","trace[838015746] 'compare'  (duration: 81.70939ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:29:28.623451Z","caller":"traceutil/trace.go:171","msg":"trace[1864789492] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:426; }","duration":"442.363411ms","start":"2026-09-07T08:29:28.181046Z","end":"2026-09-07T08:29:28.623409Z","steps":["trace[1864789492] 'read index received'  (duration: 360.130867ms)","trace[1864789492] 'applied index is now lower than readState.Index'  (duration: 82.228004ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:29:28.623689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:27.874862Z","time spent":"748.58493ms","remote":"127.0.0.1:50060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6736,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:325 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:6669 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" > >"}
{"level":"warn","ts":"2026-09-07T08:29:28.623722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.694889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-09-07T08:29:28.623783Z","caller":"traceutil/trace.go:171","msg":"trace[346192762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:418; }","duration":"442.849583ms","start":"2026-09-07T08:29:28.180915Z","end":"2026-09-07T08:29:28.623765Z","steps":["trace[346192762] 'agreement among raft nodes before linearized reading'  (duration: 442.683369ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:28.623821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:28.180882Z","time spent":"442.928265ms","remote":"127.0.0.1:50150","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:28.629865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.155718ms","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:28.629989Z","caller":"traceutil/trace.go:171","msg":"trace[2030227020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:418; }","duration":"113.393755ms","start":"2026-09-07T08:29:28.516576Z","end":"2026-09-07T08:29:28.62997Z","steps":["trace[2030227020] 'agreement among raft nodes before linearized reading'  (duration: 113.163218ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:28.629972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.388133ms","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-07T08:29:28.630137Z","caller":"traceutil/trace.go:171","msg":"trace[753421493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:418; }","duration":"309.592869ms","start":"2026-09-07T08:29:28.320461Z","end":"2026-09-07T08:29:28.630053Z","steps":["trace[753421493] 'agreement among raft nodes before linearized reading'  (duration: 309.361363ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:28.63028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:28.32043Z","time spent":"309.798074ms","remote":"127.0.0.1:50150","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-07T08:29:59.04208Z","caller":"traceutil/trace.go:171","msg":"trace[28549760] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"159.737542ms","start":"2026-09-07T08:29:58.882305Z","end":"2026-09-07T08:29:59.042042Z","steps":["trace[28549760] 'process raft request'  (duration: 159.375872ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:29:59.126045Z","caller":"traceutil/trace.go:171","msg":"trace[1477018827] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"105.943796ms","start":"2026-09-07T08:29:59.020033Z","end":"2026-09-07T08:29:59.125977Z","steps":["trace[1477018827] 'process raft request'  (duration: 85.682505ms)","trace[1477018827] 'compare'  (duration: 19.550042ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:29:59.126512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.917163ms","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-07T08:29:59.126623Z","caller":"traceutil/trace.go:171","msg":"trace[1216193165] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:647; }","duration":"164.136508ms","start":"2026-09-07T08:29:58.962463Z","end":"2026-09-07T08:29:59.126599Z","steps":["trace[1216193165] 'agreement among raft nodes before linearized reading'  (duration: 163.633835ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:29:59.564219Z","caller":"traceutil/trace.go:171","msg":"trace[1279485251] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"374.537111ms","start":"2026-09-07T08:29:59.18963Z","end":"2026-09-07T08:29:59.564167Z","steps":["trace[1279485251] 'process raft request'  (duration: 374.239313ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:59.564417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:59.189591Z","time spent":"374.732536ms","remote":"127.0.0.1:50366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-09-07T08:29:59.982404Z","caller":"traceutil/trace.go:171","msg":"trace[600301415] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"398.335146ms","start":"2026-09-07T08:29:59.584049Z","end":"2026-09-07T08:29:59.982385Z","steps":["trace[600301415] 'process raft request'  (duration: 398.214993ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:29:59.982528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:59.583981Z","time spent":"398.479539ms","remote":"127.0.0.1:50060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-lzm9k\" mod_revision:529 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-lzm9k\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-lzm9k\" > >"}
{"level":"info","ts":"2026-09-07T08:30:00.222504Z","caller":"traceutil/trace.go:171","msg":"trace[324922787] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"231.072464ms","start":"2026-09-07T08:29:59.9914Z","end":"2026-09-07T08:30:00.222473Z","steps":["trace[324922787] 'process raft request'  (duration: 229.209454ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:30:15.355968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.803502ms","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-07T08:30:15.355987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.411172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-09-07T08:30:15.356064Z","caller":"traceutil/trace.go:171","msg":"trace[441946119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:811; }","duration":"117.547096ms","start":"2026-09-07T08:30:15.238501Z","end":"2026-09-07T08:30:15.356048Z","steps":["trace[441946119] 'range keys from in-memory index tree'  (duration: 117.206537ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:30:15.356061Z","caller":"traceutil/trace.go:171","msg":"trace[1794449420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:811; }","duration":"150.932076ms","start":"2026-09-07T08:30:15.205106Z","end":"2026-09-07T08:30:15.356038Z","steps":["trace[1794449420] 'range keys from in-memory index tree'  (duration: 150.627908ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:31:08.354743Z","caller":"traceutil/trace.go:171","msg":"trace[1391477236] linearizableReadLoop","detail":"{readStateIndex:1515; appliedIndex:1514; }","duration":"396.797675ms","start":"2026-09-07T08:31:07.957909Z","end":"2026-09-07T08:31:08.354707Z","steps":["trace[1391477236] 'read index received'  (duration: 396.532488ms)","trace[1391477236] 'applied index is now lower than readState.Index'  (duration: 262.837µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:31:08.354896Z","caller":"traceutil/trace.go:171","msg":"trace[851442290] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"456.408495ms","start":"2026-09-07T08:31:07.898443Z","end":"2026-09-07T08:31:08.354851Z","steps":["trace[851442290] 'process raft request'  (duration: 455.972843ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:31:08.354984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.028501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:31:08.355067Z","caller":"traceutil/trace.go:171","msg":"trace[1647790125] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1473; }","duration":"397.186475ms","start":"2026-09-07T08:31:07.95786Z","end":"2026-09-07T08:31:08.355047Z","steps":["trace[1647790125] 'agreement among raft nodes before linearized reading'  (duration: 397.02005ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:31:08.355124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:31:07.898418Z","time spent":"456.57903ms","remote":"127.0.0.1:50060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-99mtm\" mod_revision:1457 > success:<request_put:<key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-99mtm\" value_size:4419 >> failure:<request_range:<key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-99mtm\" > >"}
{"level":"warn","ts":"2026-09-07T08:31:08.355193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:31:07.957815Z","time spent":"397.324599ms","remote":"127.0.0.1:50042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"info","ts":"2026-09-07T08:31:08.394677Z","caller":"traceutil/trace.go:171","msg":"trace[328203373] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"364.00009ms","start":"2026-09-07T08:31:08.030565Z","end":"2026-09-07T08:31:08.394565Z","steps":["trace[328203373] 'process raft request'  (duration: 363.657051ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:31:08.394766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.031052ms","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-07T08:31:08.394917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:31:08.030542Z","time spent":"364.234056ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1381 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-09-07T08:31:08.394919Z","caller":"traceutil/trace.go:171","msg":"trace[160538867] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1474; }","duration":"135.233278ms","start":"2026-09-07T08:31:08.259653Z","end":"2026-09-07T08:31:08.394886Z","steps":["trace[160538867] 'agreement among raft nodes before linearized reading'  (duration: 134.832987ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:31:37.250025Z","caller":"traceutil/trace.go:171","msg":"trace[340493584] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"199.68284ms","start":"2026-09-07T08:31:37.050299Z","end":"2026-09-07T08:31:37.249982Z","steps":["trace[340493584] 'process raft request'  (duration: 199.469394ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:31:37.766907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.743044ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705555133350649864 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1884 > 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:31:37.767083Z","caller":"traceutil/trace.go:171","msg":"trace[1058262605] linearizableReadLoop","detail":"{readStateIndex:1982; appliedIndex:1981; }","duration":"247.856311ms","start":"2026-09-07T08:31:37.519208Z","end":"2026-09-07T08:31:37.767064Z","steps":["trace[1058262605] 'read index received'  (duration: 81.84032ms)","trace[1058262605] 'applied index is now lower than readState.Index'  (duration: 166.014691ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:31:37.767193Z","caller":"traceutil/trace.go:171","msg":"trace[1770246647] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"512.66244ms","start":"2026-09-07T08:31:37.254515Z","end":"2026-09-07T08:31:37.767177Z","steps":["trace[1770246647] 'process raft request'  (duration: 346.520256ms)","trace[1770246647] 'compare'  (duration: 165.541418ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:31:37.767271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:31:37.254488Z","time spent":"512.741981ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1884 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-09-07T08:31:37.76743Z","caller":"traceutil/trace.go:171","msg":"trace[1155549478] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"224.376022ms","start":"2026-09-07T08:31:37.543016Z","end":"2026-09-07T08:31:37.767392Z","steps":["trace[1155549478] 'process raft request'  (duration: 224.019112ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:31:37.767647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.204364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-31fc0a25-0f97-4d9c-b6d3-14453f2ce2ca\" ","response":"range_response_count:1 size:3743"}
{"level":"warn","ts":"2026-09-07T08:31:37.767661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.921407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-09-07T08:31:37.76763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.406445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:31:37.76772Z","caller":"traceutil/trace.go:171","msg":"trace[1579235380] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-31fc0a25-0f97-4d9c-b6d3-14453f2ce2ca; range_end:; response_count:1; response_revision:1912; }","duration":"164.320357ms","start":"2026-09-07T08:31:37.603388Z","end":"2026-09-07T08:31:37.767708Z","steps":["trace[1579235380] 'agreement among raft nodes before linearized reading'  (duration: 164.04487ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:31:37.767851Z","caller":"traceutil/trace.go:171","msg":"trace[1129668852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1912; }","duration":"248.684313ms","start":"2026-09-07T08:31:37.519157Z","end":"2026-09-07T08:31:37.767841Z","steps":["trace[1129668852] 'agreement among raft nodes before linearized reading'  (duration: 248.354894ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:31:37.767863Z","caller":"traceutil/trace.go:171","msg":"trace[1123551071] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1912; }","duration":"161.149443ms","start":"2026-09-07T08:31:37.606693Z","end":"2026-09-07T08:31:37.767842Z","steps":["trace[1123551071] 'agreement among raft nodes before linearized reading'  (duration: 160.802733ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:31:37.957353Z","caller":"traceutil/trace.go:171","msg":"trace[1408116972] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"178.639664ms","start":"2026-09-07T08:31:37.778685Z","end":"2026-09-07T08:31:37.957325Z","steps":["trace[1408116972] 'process raft request'  (duration: 178.433529ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:31:37.986428Z","caller":"traceutil/trace.go:171","msg":"trace[805225414] linearizableReadLoop","detail":"{readStateIndex:1985; appliedIndex:1983; }","duration":"114.629086ms","start":"2026-09-07T08:31:37.871771Z","end":"2026-09-07T08:31:37.9864Z","steps":["trace[805225414] 'read index received'  (duration: 85.369303ms)","trace[805225414] 'applied index is now lower than readState.Index'  (duration: 29.258873ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:31:37.986622Z","caller":"traceutil/trace.go:171","msg":"trace[349654688] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"181.240533ms","start":"2026-09-07T08:31:37.805315Z","end":"2026-09-07T08:31:37.986555Z","steps":["trace[349654688] 'process raft request'  (duration: 180.954545ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:31:37.986752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.972644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-07T08:31:37.986823Z","caller":"traceutil/trace.go:171","msg":"trace[1835289841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1914; }","duration":"115.076627ms","start":"2026-09-07T08:31:37.871711Z","end":"2026-09-07T08:31:37.986788Z","steps":["trace[1835289841] 'agreement among raft nodes before linearized reading'  (duration: 114.82135ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:31:37.986919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.025276ms","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-07T08:31:37.987037Z","caller":"traceutil/trace.go:171","msg":"trace[472943324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1914; }","duration":"112.227862ms","start":"2026-09-07T08:31:37.87478Z","end":"2026-09-07T08:31:37.987008Z","steps":["trace[472943324] 'agreement among raft nodes before linearized reading'  (duration: 111.875563ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:31:54.616423Z","caller":"traceutil/trace.go:171","msg":"trace[1334357292] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"216.680758ms","start":"2026-09-07T08:31:54.399716Z","end":"2026-09-07T08:31:54.616397Z","steps":["trace[1334357292] 'process raft request'  (duration: 216.494703ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:32:34.661069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.579145ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705555133350650697 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2256 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:32:34.661357Z","caller":"traceutil/trace.go:171","msg":"trace[1087040304] transaction","detail":"{read_only:false; response_revision:2266; number_of_response:1; }","duration":"292.51263ms","start":"2026-09-07T08:32:34.368818Z","end":"2026-09-07T08:32:34.66133Z","steps":["trace[1087040304] 'process raft request'  (duration: 180.531535ms)","trace[1087040304] 'compare'  (duration: 111.305607ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:32:34.665406Z","caller":"traceutil/trace.go:171","msg":"trace[599328778] linearizableReadLoop","detail":"{readStateIndex:2351; appliedIndex:2349; }","duration":"219.517183ms","start":"2026-09-07T08:32:34.445866Z","end":"2026-09-07T08:32:34.665383Z","steps":["trace[599328778] 'read index received'  (duration: 103.493291ms)","trace[599328778] 'applied index is now lower than readState.Index'  (duration: 116.022712ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:32:34.665433Z","caller":"traceutil/trace.go:171","msg":"trace[1976267568] transaction","detail":"{read_only:false; response_revision:2267; number_of_response:1; }","duration":"296.230088ms","start":"2026-09-07T08:32:34.369182Z","end":"2026-09-07T08:32:34.665412Z","steps":["trace[1976267568] 'process raft request'  (duration: 296.066893ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:32:34.66565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.77202ms","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-07T08:32:34.665684Z","caller":"traceutil/trace.go:171","msg":"trace[371412116] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2267; }","duration":"219.876003ms","start":"2026-09-07T08:32:34.445797Z","end":"2026-09-07T08:32:34.665673Z","steps":["trace[371412116] 'agreement among raft nodes before linearized reading'  (duration: 219.709998ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:32:34.665679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.583049ms","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:32:34.665716Z","caller":"traceutil/trace.go:171","msg":"trace[1054105102] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2267; }","duration":"118.662361ms","start":"2026-09-07T08:32:34.547044Z","end":"2026-09-07T08:32:34.665706Z","steps":["trace[1054105102] 'agreement among raft nodes before linearized reading'  (duration: 118.555499ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:32:34.665678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.753139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:32:34.665835Z","caller":"traceutil/trace.go:171","msg":"trace[180923985] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2267; }","duration":"147.983535ms","start":"2026-09-07T08:32:34.517832Z","end":"2026-09-07T08:32:34.665815Z","steps":["trace[180923985] 'agreement among raft nodes before linearized reading'  (duration: 147.741929ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:33:47.650134Z","caller":"traceutil/trace.go:171","msg":"trace[96364923] transaction","detail":"{read_only:false; response_revision:2827; number_of_response:1; }","duration":"217.347066ms","start":"2026-09-07T08:33:47.432759Z","end":"2026-09-07T08:33:47.650107Z","steps":["trace[96364923] 'process raft request'  (duration: 211.130912ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:33:47.650167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.100882ms","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:33:47.650224Z","caller":"traceutil/trace.go:171","msg":"trace[1268547781] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2826; }","duration":"305.209135ms","start":"2026-09-07T08:33:47.345Z","end":"2026-09-07T08:33:47.650209Z","steps":["trace[1268547781] 'range keys from in-memory index tree'  (duration: 304.916028ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:33:47.650263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:33:47.344969Z","time spent":"305.282207ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-07T08:34:21.566266Z","caller":"traceutil/trace.go:171","msg":"trace[1571254238] transaction","detail":"{read_only:false; response_revision:3033; number_of_response:1; }","duration":"203.524621ms","start":"2026-09-07T08:34:21.362709Z","end":"2026-09-07T08:34:21.566233Z","steps":["trace[1571254238] 'process raft request'  (duration: 178.247884ms)","trace[1571254238] 'compare'  (duration: 25.042591ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:34:21.96592Z","caller":"traceutil/trace.go:171","msg":"trace[1775280688] linearizableReadLoop","detail":"{readStateIndex:3146; appliedIndex:3145; }","duration":"224.143256ms","start":"2026-09-07T08:34:21.741745Z","end":"2026-09-07T08:34:21.965888Z","steps":["trace[1775280688] 'read index received'  (duration: 167.159662ms)","trace[1775280688] 'applied index is now lower than readState.Index'  (duration: 56.982303ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:34:21.966071Z","caller":"traceutil/trace.go:171","msg":"trace[1335106853] transaction","detail":"{read_only:false; response_revision:3034; number_of_response:1; }","duration":"231.272013ms","start":"2026-09-07T08:34:21.734756Z","end":"2026-09-07T08:34:21.966028Z","steps":["trace[1335106853] 'process raft request'  (duration: 174.075234ms)","trace[1335106853] 'compare'  (duration: 56.519851ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:34:21.96646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.665579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-07T08:34:21.9666Z","caller":"traceutil/trace.go:171","msg":"trace[1889399499] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:3034; }","duration":"224.865744ms","start":"2026-09-07T08:34:21.741697Z","end":"2026-09-07T08:34:21.966563Z","steps":["trace[1889399499] 'agreement among raft nodes before linearized reading'  (duration: 224.564426ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:34:22.052291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.10157ms","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:34:22.052406Z","caller":"traceutil/trace.go:171","msg":"trace[1542901533] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3035; }","duration":"167.237053ms","start":"2026-09-07T08:34:21.885148Z","end":"2026-09-07T08:34:22.052385Z","steps":["trace[1542901533] 'agreement among raft nodes before linearized reading'  (duration: 166.960796ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:34:22.052286Z","caller":"traceutil/trace.go:171","msg":"trace[1058464311] transaction","detail":"{read_only:false; response_revision:3035; number_of_response:1; }","duration":"190.429726ms","start":"2026-09-07T08:34:21.861818Z","end":"2026-09-07T08:34:22.052247Z","steps":["trace[1058464311] 'process raft request'  (duration: 190.061296ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:34:27.3802Z","caller":"traceutil/trace.go:171","msg":"trace[454808030] transaction","detail":"{read_only:false; response_revision:3063; number_of_response:1; }","duration":"105.196207ms","start":"2026-09-07T08:34:27.274978Z","end":"2026-09-07T08:34:27.380174Z","steps":["trace[454808030] 'process raft request'  (duration: 105.037692ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:34:27.394141Z","caller":"traceutil/trace.go:171","msg":"trace[205607057] transaction","detail":"{read_only:false; response_revision:3064; number_of_response:1; }","duration":"100.610045ms","start":"2026-09-07T08:34:27.293504Z","end":"2026-09-07T08:34:27.394114Z","steps":["trace[205607057] 'process raft request'  (duration: 100.454561ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:37:45.787715Z","caller":"traceutil/trace.go:171","msg":"trace[932586808] transaction","detail":"{read_only:false; response_revision:4307; number_of_response:1; }","duration":"114.007819ms","start":"2026-09-07T08:37:45.673672Z","end":"2026-09-07T08:37:45.78768Z","steps":["trace[932586808] 'process raft request'  (duration: 113.718131ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:09.824423Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2969}
{"level":"info","ts":"2026-09-07T08:39:09.902652Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2969,"took":"77.31486ms","hash":3279523224,"current-db-size-bytes":46374912,"current-db-size":"46 MB","current-db-size-in-use-bytes":21970944,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-09-07T08:39:09.902754Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3279523224,"revision":2969,"compact-revision":-1}
{"level":"info","ts":"2026-09-07T08:39:18.80383Z","caller":"traceutil/trace.go:171","msg":"trace[2130376725] transaction","detail":"{read_only:false; response_revision:5258; number_of_response:1; }","duration":"174.652225ms","start":"2026-09-07T08:39:18.629149Z","end":"2026-09-07T08:39:18.803801Z","steps":["trace[2130376725] 'process raft request'  (duration: 174.413819ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:18.80418Z","caller":"traceutil/trace.go:171","msg":"trace[322068536] transaction","detail":"{read_only:false; response_revision:5259; number_of_response:1; }","duration":"172.412026ms","start":"2026-09-07T08:39:18.631723Z","end":"2026-09-07T08:39:18.804135Z","steps":["trace[322068536] 'process raft request'  (duration: 172.028826ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:18.80431Z","caller":"traceutil/trace.go:171","msg":"trace[1473533886] transaction","detail":"{read_only:false; response_revision:5260; number_of_response:1; }","duration":"161.626668ms","start":"2026-09-07T08:39:18.642635Z","end":"2026-09-07T08:39:18.804262Z","steps":["trace[1473533886] 'process raft request'  (duration: 161.396882ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:18.804665Z","caller":"traceutil/trace.go:171","msg":"trace[2005602790] transaction","detail":"{read_only:false; response_revision:5261; number_of_response:1; }","duration":"160.077647ms","start":"2026-09-07T08:39:18.644547Z","end":"2026-09-07T08:39:18.804625Z","steps":["trace[2005602790] 'process raft request'  (duration: 159.634645ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:18.815779Z","caller":"traceutil/trace.go:171","msg":"trace[170745306] linearizableReadLoop","detail":"{readStateIndex:5458; appliedIndex:5456; }","duration":"184.275173ms","start":"2026-09-07T08:39:18.631464Z","end":"2026-09-07T08:39:18.81574Z","steps":["trace[170745306] 'read index received'  (duration: 43.052728ms)","trace[170745306] 'applied index is now lower than readState.Index'  (duration: 141.221335ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:39:18.815968Z","caller":"traceutil/trace.go:171","msg":"trace[1231406811] transaction","detail":"{read_only:false; response_revision:5262; number_of_response:1; }","duration":"168.934163ms","start":"2026-09-07T08:39:18.646977Z","end":"2026-09-07T08:39:18.815911Z","steps":["trace[1231406811] 'process raft request'  (duration: 168.584674ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:18.816097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.607101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"warn","ts":"2026-09-07T08:39:18.816173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.276372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-09-07T08:39:18.816185Z","caller":"traceutil/trace.go:171","msg":"trace[821101679] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:5262; }","duration":"184.739225ms","start":"2026-09-07T08:39:18.631416Z","end":"2026-09-07T08:39:18.816155Z","steps":["trace[821101679] 'agreement among raft nodes before linearized reading'  (duration: 184.526199ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:18.816214Z","caller":"traceutil/trace.go:171","msg":"trace[559719607] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:5262; }","duration":"184.350645ms","start":"2026-09-07T08:39:18.631851Z","end":"2026-09-07T08:39:18.816201Z","steps":["trace[559719607] 'agreement among raft nodes before linearized reading'  (duration: 184.15251ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:24.067058Z","caller":"traceutil/trace.go:171","msg":"trace[134470072] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"112.665944ms","start":"2026-09-07T08:39:23.954362Z","end":"2026-09-07T08:39:24.067028Z","steps":["trace[134470072] 'process raft request'  (duration: 112.50312ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:24.089168Z","caller":"traceutil/trace.go:171","msg":"trace[1900914546] transaction","detail":"{read_only:false; response_revision:5401; number_of_response:1; }","duration":"126.269116ms","start":"2026-09-07T08:39:23.962859Z","end":"2026-09-07T08:39:24.089128Z","steps":["trace[1900914546] 'process raft request'  (duration: 125.955828ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:24.089291Z","caller":"traceutil/trace.go:171","msg":"trace[913942585] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"102.301637ms","start":"2026-09-07T08:39:23.986957Z","end":"2026-09-07T08:39:24.089258Z","steps":["trace[913942585] 'process raft request'  (duration: 102.03494ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:24.972174Z","caller":"traceutil/trace.go:171","msg":"trace[1389028908] transaction","detail":"{read_only:false; response_revision:5443; number_of_response:1; }","duration":"147.77988ms","start":"2026-09-07T08:39:24.824367Z","end":"2026-09-07T08:39:24.972147Z","steps":["trace[1389028908] 'process raft request'  (duration: 147.368589ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:24.972573Z","caller":"traceutil/trace.go:171","msg":"trace[61895949] linearizableReadLoop","detail":"{readStateIndex:5649; appliedIndex:5647; }","duration":"146.154916ms","start":"2026-09-07T08:39:24.826357Z","end":"2026-09-07T08:39:24.972512Z","steps":["trace[61895949] 'read index received'  (duration: 40.161891ms)","trace[61895949] 'applied index is now lower than readState.Index'  (duration: 105.991075ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:39:24.97263Z","caller":"traceutil/trace.go:171","msg":"trace[1450677103] transaction","detail":"{read_only:false; response_revision:5444; number_of_response:1; }","duration":"123.298537ms","start":"2026-09-07T08:39:24.849272Z","end":"2026-09-07T08:39:24.97257Z","steps":["trace[1450677103] 'process raft request'  (duration: 122.827834ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:24.972769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.388052ms","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-07T08:39:24.972843Z","caller":"traceutil/trace.go:171","msg":"trace[1664659833] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5444; }","duration":"146.479695ms","start":"2026-09-07T08:39:24.826342Z","end":"2026-09-07T08:39:24.972822Z","steps":["trace[1664659833] 'agreement among raft nodes before linearized reading'  (duration: 146.277989ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:24.976093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.7988ms","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:39:24.976143Z","caller":"traceutil/trace.go:171","msg":"trace[1890461797] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5445; }","duration":"111.884463ms","start":"2026-09-07T08:39:24.864249Z","end":"2026-09-07T08:39:24.976133Z","steps":["trace[1890461797] 'agreement among raft nodes before linearized reading'  (duration: 111.666757ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:28.415159Z","caller":"traceutil/trace.go:171","msg":"trace[92313001] linearizableReadLoop","detail":"{readStateIndex:5793; appliedIndex:5792; }","duration":"205.605661ms","start":"2026-09-07T08:39:28.209521Z","end":"2026-09-07T08:39:28.415126Z","steps":["trace[92313001] 'read index received'  (duration: 205.348814ms)","trace[92313001] 'applied index is now lower than readState.Index'  (duration: 255.597µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:39:28.415377Z","caller":"traceutil/trace.go:171","msg":"trace[1831325533] transaction","detail":"{read_only:false; response_revision:5584; number_of_response:1; }","duration":"209.487864ms","start":"2026-09-07T08:39:28.205836Z","end":"2026-09-07T08:39:28.415324Z","steps":["trace[1831325533] 'process raft request'  (duration: 209.119534ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:28.415526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.661163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hvxm8\" ","response":"range_response_count:1 size:6526"}
{"level":"info","ts":"2026-09-07T08:39:28.415629Z","caller":"traceutil/trace.go:171","msg":"trace[156018100] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hvxm8; range_end:; response_count:1; response_revision:5584; }","duration":"181.852148ms","start":"2026-09-07T08:39:28.23376Z","end":"2026-09-07T08:39:28.415612Z","steps":["trace[156018100] 'agreement among raft nodes before linearized reading'  (duration: 181.581781ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:28.417865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.322953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787137"}
{"level":"info","ts":"2026-09-07T08:39:28.41797Z","caller":"traceutil/trace.go:171","msg":"trace[1471521479] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5584; }","duration":"208.426006ms","start":"2026-09-07T08:39:28.209513Z","end":"2026-09-07T08:39:28.417939Z","steps":["trace[1471521479] 'agreement among raft nodes before linearized reading'  (duration: 205.761155ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:30.898848Z","caller":"traceutil/trace.go:171","msg":"trace[1759278271] transaction","detail":"{read_only:false; response_revision:5618; number_of_response:1; }","duration":"140.460103ms","start":"2026-09-07T08:39:30.758361Z","end":"2026-09-07T08:39:30.898821Z","steps":["trace[1759278271] 'process raft request'  (duration: 140.266658ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:30.954645Z","caller":"traceutil/trace.go:171","msg":"trace[1068438721] transaction","detail":"{read_only:false; response_revision:5619; number_of_response:1; }","duration":"185.969786ms","start":"2026-09-07T08:39:30.768647Z","end":"2026-09-07T08:39:30.954617Z","steps":["trace[1068438721] 'process raft request'  (duration: 185.690648ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:31.060967Z","caller":"traceutil/trace.go:171","msg":"trace[224371056] transaction","detail":"{read_only:false; response_revision:5622; number_of_response:1; }","duration":"100.044047ms","start":"2026-09-07T08:39:30.960877Z","end":"2026-09-07T08:39:31.060921Z","steps":["trace[224371056] 'process raft request'  (duration: 99.724108ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:31.173182Z","caller":"traceutil/trace.go:171","msg":"trace[971978981] transaction","detail":"{read_only:false; response_revision:5624; number_of_response:1; }","duration":"182.68802ms","start":"2026-09-07T08:39:30.990456Z","end":"2026-09-07T08:39:31.173144Z","steps":["trace[971978981] 'process raft request'  (duration: 152.6913ms)","trace[971978981] 'compare'  (duration: 29.768504ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:39:31.173583Z","caller":"traceutil/trace.go:171","msg":"trace[636813964] linearizableReadLoop","detail":"{readStateIndex:5836; appliedIndex:5832; }","duration":"178.796146ms","start":"2026-09-07T08:39:30.994753Z","end":"2026-09-07T08:39:31.173549Z","steps":["trace[636813964] 'read index received'  (duration: 65.970248ms)","trace[636813964] 'applied index is now lower than readState.Index'  (duration: 112.824938ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:39:31.173679Z","caller":"traceutil/trace.go:171","msg":"trace[1237955603] transaction","detail":"{read_only:false; response_revision:5626; number_of_response:1; }","duration":"178.868179ms","start":"2026-09-07T08:39:30.994787Z","end":"2026-09-07T08:39:31.173655Z","steps":["trace[1237955603] 'process raft request'  (duration: 178.53843ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:31.17371Z","caller":"traceutil/trace.go:171","msg":"trace[241229428] transaction","detail":"{read_only:false; response_revision:5625; number_of_response:1; }","duration":"179.604018ms","start":"2026-09-07T08:39:30.994089Z","end":"2026-09-07T08:39:31.173693Z","steps":["trace[241229428] 'process raft request'  (duration: 178.986971ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:31.1739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.958163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/goldpinger-t28sh\" ","response":"range_response_count:1 size:3945"}
{"level":"info","ts":"2026-09-07T08:39:31.173951Z","caller":"traceutil/trace.go:171","msg":"trace[1779524514] range","detail":"{range_begin:/registry/pods/monitoring/goldpinger-t28sh; range_end:; response_count:1; response_revision:5626; }","duration":"175.077867ms","start":"2026-09-07T08:39:30.998859Z","end":"2026-09-07T08:39:31.173937Z","steps":["trace[1779524514] 'agreement among raft nodes before linearized reading'  (duration: 174.881472ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:31.17413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.678484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4dfa61fb-d1a9-48cd-8bb6-35c44c70c887\" ","response":"range_response_count:1 size:3906"}
{"level":"warn","ts":"2026-09-07T08:39:31.174196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.596508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-09-07T08:39:31.174248Z","caller":"traceutil/trace.go:171","msg":"trace[2006318210] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4dfa61fb-d1a9-48cd-8bb6-35c44c70c887; range_end:; response_count:1; response_revision:5626; }","duration":"109.833928ms","start":"2026-09-07T08:39:31.064384Z","end":"2026-09-07T08:39:31.174218Z","steps":["trace[2006318210] 'agreement among raft nodes before linearized reading'  (duration: 109.53254ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:31.174257Z","caller":"traceutil/trace.go:171","msg":"trace[1478978357] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5626; }","duration":"152.705421ms","start":"2026-09-07T08:39:31.021534Z","end":"2026-09-07T08:39:31.174239Z","steps":["trace[1478978357] 'agreement among raft nodes before linearized reading'  (duration: 152.456364ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:31.17424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.324053ms","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:39:31.17433Z","caller":"traceutil/trace.go:171","msg":"trace[78635464] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5626; }","duration":"166.480898ms","start":"2026-09-07T08:39:31.007827Z","end":"2026-09-07T08:39:31.174308Z","steps":["trace[78635464] 'agreement among raft nodes before linearized reading'  (duration: 166.19501ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:31.174327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.545407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:26 size:797373"}
{"level":"info","ts":"2026-09-07T08:39:31.174605Z","caller":"traceutil/trace.go:171","msg":"trace[779484802] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:26; response_revision:5626; }","duration":"179.835584ms","start":"2026-09-07T08:39:30.994712Z","end":"2026-09-07T08:39:31.174548Z","steps":["trace[779484802] 'agreement among raft nodes before linearized reading'  (duration: 178.972361ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:42.995646Z","caller":"traceutil/trace.go:171","msg":"trace[926092424] transaction","detail":"{read_only:false; response_revision:5838; number_of_response:1; }","duration":"119.807204ms","start":"2026-09-07T08:39:42.875813Z","end":"2026-09-07T08:39:42.99562Z","steps":["trace[926092424] 'process raft request'  (duration: 94.294384ms)","trace[926092424] 'compare'  (duration: 25.325375ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:39:42.995961Z","caller":"traceutil/trace.go:171","msg":"trace[923274449] transaction","detail":"{read_only:false; response_revision:5840; number_of_response:1; }","duration":"119.948528ms","start":"2026-09-07T08:39:42.875986Z","end":"2026-09-07T08:39:42.995934Z","steps":["trace[923274449] 'process raft request'  (duration: 119.797994ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:42.996042Z","caller":"traceutil/trace.go:171","msg":"trace[822717862] transaction","detail":"{read_only:false; response_revision:5839; number_of_response:1; }","duration":"120.147973ms","start":"2026-09-07T08:39:42.875875Z","end":"2026-09-07T08:39:42.996023Z","steps":["trace[822717862] 'process raft request'  (duration: 119.707741ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:43.730198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.622061ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705555133350659244 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5794 > 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:39:43.730332Z","caller":"traceutil/trace.go:171","msg":"trace[1999413769] linearizableReadLoop","detail":"{readStateIndex:6064; appliedIndex:6062; }","duration":"480.127838ms","start":"2026-09-07T08:39:43.250182Z","end":"2026-09-07T08:39:43.73031Z","steps":["trace[1999413769] 'read index received'  (duration: 11.016893ms)","trace[1999413769] 'applied index is now lower than readState.Index'  (duration: 469.109415ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:39:43.730426Z","caller":"traceutil/trace.go:171","msg":"trace[655646174] transaction","detail":"{read_only:false; response_revision:5847; number_of_response:1; }","duration":"511.572287ms","start":"2026-09-07T08:39:43.218794Z","end":"2026-09-07T08:39:43.730367Z","steps":["trace[655646174] 'process raft request'  (duration: 323.598656ms)","trace[655646174] 'compare'  (duration: 187.345354ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:39:43.730603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.417686ms","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:39:43.730878Z","caller":"traceutil/trace.go:171","msg":"trace[1816582615] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5847; }","duration":"480.688334ms","start":"2026-09-07T08:39:43.250124Z","end":"2026-09-07T08:39:43.730813Z","steps":["trace[1816582615] 'agreement among raft nodes before linearized reading'  (duration: 480.287783ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:43.730933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:39:43.218764Z","time spent":"511.928097ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5794 > 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:39:43.731013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:39:43.250104Z","time spent":"480.862768ms","remote":"127.0.0.1:50150","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-07T08:39:43.731072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.289919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-07T08:39:43.731076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.823462ms","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:39:43.731172Z","caller":"traceutil/trace.go:171","msg":"trace[108964156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5847; }","duration":"212.439583ms","start":"2026-09-07T08:39:43.518706Z","end":"2026-09-07T08:39:43.731146Z","steps":["trace[108964156] 'agreement among raft nodes before linearized reading'  (duration: 212.266968ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:43.731181Z","caller":"traceutil/trace.go:171","msg":"trace[1243455032] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5847; }","duration":"323.984776ms","start":"2026-09-07T08:39:43.407171Z","end":"2026-09-07T08:39:43.731156Z","steps":["trace[1243455032] 'agreement among raft nodes before linearized reading'  (duration: 323.77158ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:43.73118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.121826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.32\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-09-07T08:39:43.731257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:39:43.40715Z","time spent":"324.086689ms","remote":"127.0.0.1:56486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"info","ts":"2026-09-07T08:39:43.731264Z","caller":"traceutil/trace.go:171","msg":"trace[160499892] range","detail":"{range_begin:/registry/masterleases/162.253.55.32; range_end:; response_count:1; response_revision:5847; }","duration":"355.25672ms","start":"2026-09-07T08:39:43.375985Z","end":"2026-09-07T08:39:43.731242Z","steps":["trace[160499892] 'agreement among raft nodes before linearized reading'  (duration: 354.999433ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:43.731306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:39:43.375949Z","time spent":"355.347413ms","remote":"127.0.0.1:49908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.32\" "}
{"level":"warn","ts":"2026-09-07T08:39:43.731301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.693221ms","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:39:43.731403Z","caller":"traceutil/trace.go:171","msg":"trace[1226606572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5847; }","duration":"445.855045ms","start":"2026-09-07T08:39:43.285523Z","end":"2026-09-07T08:39:43.731378Z","steps":["trace[1226606572] 'agreement among raft nodes before linearized reading'  (duration: 445.480945ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:43.731463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:39:43.285502Z","time spent":"445.949858ms","remote":"127.0.0.1:50150","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":"warn","ts":"2026-09-07T08:39:43.731885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.671537ms","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-07T08:39:43.731957Z","caller":"traceutil/trace.go:171","msg":"trace[921864411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5847; }","duration":"449.78382ms","start":"2026-09-07T08:39:43.282155Z","end":"2026-09-07T08:39:43.731939Z","steps":["trace[921864411] 'agreement among raft nodes before linearized reading'  (duration: 448.774953ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:43.732002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:39:43.282127Z","time spent":"449.862362ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-09-07T08:39:43.847711Z","caller":"traceutil/trace.go:171","msg":"trace[2078264565] transaction","detail":"{read_only:false; response_revision:5848; number_of_response:1; }","duration":"110.102485ms","start":"2026-09-07T08:39:43.737585Z","end":"2026-09-07T08:39:43.847687Z","steps":["trace[2078264565] 'process raft request'  (duration: 109.816088ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:43.847698Z","caller":"traceutil/trace.go:171","msg":"trace[1465556581] transaction","detail":"{read_only:false; response_revision:5849; number_of_response:1; }","duration":"109.856329ms","start":"2026-09-07T08:39:43.737815Z","end":"2026-09-07T08:39:43.847671Z","steps":["trace[1465556581] 'process raft request'  (duration: 109.755316ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:43.848271Z","caller":"traceutil/trace.go:171","msg":"trace[769703806] transaction","detail":"{read_only:false; response_revision:5850; number_of_response:1; }","duration":"110.415294ms","start":"2026-09-07T08:39:43.737815Z","end":"2026-09-07T08:39:43.84823Z","steps":["trace[769703806] 'process raft request'  (duration: 109.815328ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:52.18471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.522779ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705555133350659698 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5948 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:39:52.184912Z","caller":"traceutil/trace.go:171","msg":"trace[876195825] linearizableReadLoop","detail":"{readStateIndex:6263; appliedIndex:6260; }","duration":"215.156686ms","start":"2026-09-07T08:39:51.969736Z","end":"2026-09-07T08:39:52.184892Z","steps":["trace[876195825] 'read index received'  (duration: 30.73102ms)","trace[876195825] 'applied index is now lower than readState.Index'  (duration: 184.424376ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:39:52.184963Z","caller":"traceutil/trace.go:171","msg":"trace[1314972176] transaction","detail":"{read_only:false; response_revision:6040; number_of_response:1; }","duration":"245.260908ms","start":"2026-09-07T08:39:51.939679Z","end":"2026-09-07T08:39:52.18494Z","steps":["trace[1314972176] 'process raft request'  (duration: 245.161665ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:39:52.18523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.498825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1020133-d685-44b3-b5ce-3fbcfef54122\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-09-07T08:39:52.185261Z","caller":"traceutil/trace.go:171","msg":"trace[1323198107] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d1020133-d685-44b3-b5ce-3fbcfef54122; range_end:; response_count:1; response_revision:6040; }","duration":"215.580536ms","start":"2026-09-07T08:39:51.969666Z","end":"2026-09-07T08:39:52.185247Z","steps":["trace[1323198107] 'agreement among raft nodes before linearized reading'  (duration: 215.270848ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:39:52.185252Z","caller":"traceutil/trace.go:171","msg":"trace[1334727628] transaction","detail":"{read_only:false; response_revision:6039; number_of_response:1; }","duration":"245.560966ms","start":"2026-09-07T08:39:51.939664Z","end":"2026-09-07T08:39:52.185225Z","steps":["trace[1334727628] 'process raft request'  (duration: 114.42859ms)","trace[1334727628] 'compare'  (duration: 130.375006ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:40:04.211277Z","caller":"traceutil/trace.go:171","msg":"trace[531988735] linearizableReadLoop","detail":"{readStateIndex:6388; appliedIndex:6387; }","duration":"126.625956ms","start":"2026-09-07T08:40:04.084616Z","end":"2026-09-07T08:40:04.211242Z","steps":["trace[531988735] 'read index received'  (duration: 126.462782ms)","trace[531988735] 'applied index is now lower than readState.Index'  (duration: 162.264µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:40:04.211344Z","caller":"traceutil/trace.go:171","msg":"trace[1207521356] transaction","detail":"{read_only:false; response_revision:6162; number_of_response:1; }","duration":"142.293003ms","start":"2026-09-07T08:40:04.069009Z","end":"2026-09-07T08:40:04.211302Z","steps":["trace[1207521356] 'process raft request'  (duration: 142.078748ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:40:04.211458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.824911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:40:04.211507Z","caller":"traceutil/trace.go:171","msg":"trace[628736305] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:6162; }","duration":"127.042107ms","start":"2026-09-07T08:40:04.084458Z","end":"2026-09-07T08:40:04.2115Z","steps":["trace[628736305] 'agreement among raft nodes before linearized reading'  (duration: 126.915403ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:40:04.39295Z","caller":"traceutil/trace.go:171","msg":"trace[1959421043] transaction","detail":"{read_only:false; response_revision:6164; number_of_response:1; }","duration":"142.637552ms","start":"2026-09-07T08:40:04.250275Z","end":"2026-09-07T08:40:04.392913Z","steps":["trace[1959421043] 'process raft request'  (duration: 84.430031ms)","trace[1959421043] 'compare'  (duration: 57.676587ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:42:47.519761Z","caller":"traceutil/trace.go:171","msg":"trace[683048633] linearizableReadLoop","detail":"{readStateIndex:7545; appliedIndex:7544; }","duration":"108.621586ms","start":"2026-09-07T08:42:47.411102Z","end":"2026-09-07T08:42:47.519724Z","steps":["trace[683048633] 'read index received'  (duration: 79.991673ms)","trace[683048633] 'applied index is now lower than readState.Index'  (duration: 28.628783ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:42:47.519937Z","caller":"traceutil/trace.go:171","msg":"trace[624903059] transaction","detail":"{read_only:false; response_revision:7283; number_of_response:1; }","duration":"116.526407ms","start":"2026-09-07T08:42:47.403345Z","end":"2026-09-07T08:42:47.519871Z","steps":["trace[624903059] 'process raft request'  (duration: 87.835282ms)","trace[624903059] 'compare'  (duration: 28.398717ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:42:47.520014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.899553ms","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:42:47.520133Z","caller":"traceutil/trace.go:171","msg":"trace[1966568031] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7283; }","duration":"109.089988ms","start":"2026-09-07T08:42:47.411024Z","end":"2026-09-07T08:42:47.520114Z","steps":["trace[1966568031] 'agreement among raft nodes before linearized reading'  (duration: 108.829951ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:44:09.83068Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4845}
{"level":"info","ts":"2026-09-07T08:44:09.900501Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4845,"took":"68.158187ms","hash":1521080976,"current-db-size-bytes":46374912,"current-db-size":"46 MB","current-db-size-in-use-bytes":39178240,"current-db-size-in-use":"39 MB"}
{"level":"info","ts":"2026-09-07T08:44:09.900571Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1521080976,"revision":4845,"compact-revision":2969}
{"level":"info","ts":"2026-09-07T08:46:22.008634Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000242f.wal"}
{"level":"info","ts":"2026-09-07T08:46:25.525006Z","caller":"traceutil/trace.go:171","msg":"trace[1713837182] transaction","detail":"{read_only:false; response_revision:8969; number_of_response:1; }","duration":"595.679629ms","start":"2026-09-07T08:46:24.9293Z","end":"2026-09-07T08:46:25.52498Z","steps":["trace[1713837182] 'process raft request'  (duration: 595.470863ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:46:25.525203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:46:24.929284Z","time spent":"595.808902ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8957 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-09-07T08:46:25.528015Z","caller":"traceutil/trace.go:171","msg":"trace[580301017] linearizableReadLoop","detail":"{readStateIndex:9287; appliedIndex:9285; }","duration":"463.608928ms","start":"2026-09-07T08:46:25.064375Z","end":"2026-09-07T08:46:25.527984Z","steps":["trace[580301017] 'read index received'  (duration: 460.381082ms)","trace[580301017] 'applied index is now lower than readState.Index'  (duration: 3.226666ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:46:25.528073Z","caller":"traceutil/trace.go:171","msg":"trace[1404371128] transaction","detail":"{read_only:false; response_revision:8970; number_of_response:1; }","duration":"598.121794ms","start":"2026-09-07T08:46:24.929917Z","end":"2026-09-07T08:46:25.528039Z","steps":["trace[1404371128] 'process raft request'  (duration: 597.828256ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:46:25.528153Z","caller":"traceutil/trace.go:171","msg":"trace[786653545] transaction","detail":"{read_only:false; response_revision:8971; number_of_response:1; }","duration":"284.304709ms","start":"2026-09-07T08:46:25.243838Z","end":"2026-09-07T08:46:25.528143Z","steps":["trace[786653545] 'process raft request'  (duration: 284.101794ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:46:25.528283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:46:24.92989Z","time spent":"598.258037ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8956 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-09-07T08:46:25.528437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.624716ms","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-07T08:46:25.528499Z","caller":"traceutil/trace.go:171","msg":"trace[838808001] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8971; }","duration":"356.744159ms","start":"2026-09-07T08:46:25.17174Z","end":"2026-09-07T08:46:25.528484Z","steps":["trace[838808001] 'agreement among raft nodes before linearized reading'  (duration: 356.569314ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:46:25.528528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:46:25.17172Z","time spent":"356.801181ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-09-07T08:46:25.528611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.416247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hvxm8\" ","response":"range_response_count:1 size:6526"}
{"level":"info","ts":"2026-09-07T08:46:25.528652Z","caller":"traceutil/trace.go:171","msg":"trace[622198171] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hvxm8; range_end:; response_count:1; response_revision:8971; }","duration":"345.543971ms","start":"2026-09-07T08:46:25.183099Z","end":"2026-09-07T08:46:25.528643Z","steps":["trace[622198171] 'agreement among raft nodes before linearized reading'  (duration: 345.349586ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:46:25.528678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:46:25.183067Z","time spent":"345.603592ms","remote":"127.0.0.1:50060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6550,"request content":"key:\"/registry/pods/openstack/keepalived-hvxm8\" "}
{"level":"warn","ts":"2026-09-07T08:46:25.528722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.344368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-07T08:46:25.528784Z","caller":"traceutil/trace.go:171","msg":"trace[403902901] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:8971; }","duration":"464.458061ms","start":"2026-09-07T08:46:25.064311Z","end":"2026-09-07T08:46:25.52877Z","steps":["trace[403902901] 'agreement among raft nodes before linearized reading'  (duration: 464.297436ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:46:25.528831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:46:25.064284Z","time spent":"464.523723ms","remote":"127.0.0.1:50226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":112,"response size":31,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "}
{"level":"info","ts":"2026-09-07T08:46:39.065924Z","caller":"traceutil/trace.go:171","msg":"trace[791624329] transaction","detail":"{read_only:false; response_revision:9039; number_of_response:1; }","duration":"133.843838ms","start":"2026-09-07T08:46:38.932054Z","end":"2026-09-07T08:46:39.065898Z","steps":["trace[791624329] 'process raft request'  (duration: 133.685843ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:08.146244Z","caller":"traceutil/trace.go:171","msg":"trace[596177910] linearizableReadLoop","detail":"{readStateIndex:9572; appliedIndex:9571; }","duration":"353.867203ms","start":"2026-09-07T08:47:07.792347Z","end":"2026-09-07T08:47:08.146214Z","steps":["trace[596177910] 'read index received'  (duration: 353.672278ms)","trace[596177910] 'applied index is now lower than readState.Index'  (duration: 193.515µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:47:08.146289Z","caller":"traceutil/trace.go:171","msg":"trace[109074439] transaction","detail":"{read_only:false; response_revision:9244; number_of_response:1; }","duration":"391.693831ms","start":"2026-09-07T08:47:07.75456Z","end":"2026-09-07T08:47:08.146254Z","steps":["trace[109074439] 'process raft request'  (duration: 391.464845ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:08.146544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:47:07.754511Z","time spent":"391.867966ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:9233 > 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":"warn","ts":"2026-09-07T08:47:08.147256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.182151ms","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:47:08.147336Z","caller":"traceutil/trace.go:171","msg":"trace[1686879921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9244; }","duration":"355.023783ms","start":"2026-09-07T08:47:07.792294Z","end":"2026-09-07T08:47:08.147318Z","steps":["trace[1686879921] 'agreement among raft nodes before linearized reading'  (duration: 354.074048ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:08.147383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:47:07.792263Z","time spent":"355.106766ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-07T08:47:08.394851Z","caller":"traceutil/trace.go:171","msg":"trace[2101096040] transaction","detail":"{read_only:false; response_revision:9246; number_of_response:1; }","duration":"489.092768ms","start":"2026-09-07T08:47:07.905732Z","end":"2026-09-07T08:47:08.394824Z","steps":["trace[2101096040] 'process raft request'  (duration: 489.033276ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:08.395014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:47:07.905707Z","time spent":"489.227401ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:9161 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-09-07T08:47:08.395371Z","caller":"traceutil/trace.go:171","msg":"trace[1645277064] transaction","detail":"{read_only:false; response_revision:9245; number_of_response:1; }","duration":"544.463373ms","start":"2026-09-07T08:47:07.850893Z","end":"2026-09-07T08:47:08.395356Z","steps":["trace[1645277064] 'process raft request'  (duration: 543.719733ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:08.395478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:47:07.850856Z","time spent":"544.581976ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:9237 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-07T08:47:08.395668Z","caller":"traceutil/trace.go:171","msg":"trace[2028203439] linearizableReadLoop","detail":"{readStateIndex:9574; appliedIndex:9574; }","duration":"249.307136ms","start":"2026-09-07T08:47:08.146331Z","end":"2026-09-07T08:47:08.395638Z","steps":["trace[2028203439] 'read index received'  (duration: 249.289895ms)","trace[2028203439] 'applied index is now lower than readState.Index'  (duration: 15.86µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:47:08.395931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.753894ms","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:47:08.395971Z","caller":"traceutil/trace.go:171","msg":"trace[641733528] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9246; }","duration":"597.879087ms","start":"2026-09-07T08:47:07.798082Z","end":"2026-09-07T08:47:08.395961Z","steps":["trace[641733528] 'agreement among raft nodes before linearized reading'  (duration: 597.664681ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:08.396009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:47:07.798061Z","time spent":"597.939569ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-09-07T08:47:08.396028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.813319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hvxm8\" ","response":"range_response_count:1 size:6526"}
{"level":"info","ts":"2026-09-07T08:47:08.396081Z","caller":"traceutil/trace.go:171","msg":"trace[934023365] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hvxm8; range_end:; response_count:1; response_revision:9246; }","duration":"584.886441ms","start":"2026-09-07T08:47:07.811181Z","end":"2026-09-07T08:47:08.396067Z","steps":["trace[934023365] 'agreement among raft nodes before linearized reading'  (duration: 584.722477ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:08.396121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:47:07.811168Z","time spent":"584.944392ms","remote":"127.0.0.1:50060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6550,"request content":"key:\"/registry/pods/openstack/keepalived-hvxm8\" "}
{"level":"warn","ts":"2026-09-07T08:47:08.396295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.143165ms","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-07T08:47:08.396338Z","caller":"traceutil/trace.go:171","msg":"trace[1221550343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9246; }","duration":"592.207216ms","start":"2026-09-07T08:47:07.804119Z","end":"2026-09-07T08:47:08.396326Z","steps":["trace[1221550343] 'agreement among raft nodes before linearized reading'  (duration: 592.111133ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:08.396378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:47:07.804108Z","time spent":"592.261747ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-09-07T08:47:08.396395Z","caller":"traceutil/trace.go:171","msg":"trace[775823901] transaction","detail":"{read_only:false; response_revision:9247; number_of_response:1; }","duration":"244.809826ms","start":"2026-09-07T08:47:08.151571Z","end":"2026-09-07T08:47:08.396381Z","steps":["trace[775823901] 'process raft request'  (duration: 244.743485ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:12.464039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.213474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:47:12.464162Z","caller":"traceutil/trace.go:171","msg":"trace[1667081035] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:9264; }","duration":"153.399329ms","start":"2026-09-07T08:47:12.310728Z","end":"2026-09-07T08:47:12.464127Z","steps":["trace[1667081035] 'count revisions from in-memory index tree'  (duration: 153.104031ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:12.70725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.460161ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705555133350668254 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:9257 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:47:12.707571Z","caller":"traceutil/trace.go:171","msg":"trace[231703499] linearizableReadLoop","detail":"{readStateIndex:9597; appliedIndex:9594; }","duration":"222.191961ms","start":"2026-09-07T08:47:12.485358Z","end":"2026-09-07T08:47:12.70755Z","steps":["trace[231703499] 'read index received'  (duration: 95.405222ms)","trace[231703499] 'applied index is now lower than readState.Index'  (duration: 126.785289ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:47:12.707662Z","caller":"traceutil/trace.go:171","msg":"trace[792431041] transaction","detail":"{read_only:false; response_revision:9268; number_of_response:1; }","duration":"232.050014ms","start":"2026-09-07T08:47:12.475601Z","end":"2026-09-07T08:47:12.707651Z","steps":["trace[792431041] 'process raft request'  (duration: 231.89567ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:12.707666Z","caller":"traceutil/trace.go:171","msg":"trace[628841303] transaction","detail":"{read_only:false; response_revision:9267; number_of_response:1; }","duration":"232.148777ms","start":"2026-09-07T08:47:12.475474Z","end":"2026-09-07T08:47:12.707623Z","steps":["trace[628841303] 'process raft request'  (duration: 231.969672ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:12.70764Z","caller":"traceutil/trace.go:171","msg":"trace[1227515257] transaction","detail":"{read_only:false; response_revision:9266; number_of_response:1; }","duration":"232.151027ms","start":"2026-09-07T08:47:12.475339Z","end":"2026-09-07T08:47:12.70749Z","steps":["trace[1227515257] 'process raft request'  (duration: 105.331106ms)","trace[1227515257] 'compare'  (duration: 126.280506ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:47:12.708237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.88497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228844"}
{"level":"info","ts":"2026-09-07T08:47:12.708268Z","caller":"traceutil/trace.go:171","msg":"trace[832055494] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:9268; }","duration":"222.949762ms","start":"2026-09-07T08:47:12.48531Z","end":"2026-09-07T08:47:12.70826Z","steps":["trace[832055494] 'agreement among raft nodes before linearized reading'  (duration: 222.48876ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:12.787194Z","caller":"traceutil/trace.go:171","msg":"trace[126297645] transaction","detail":"{read_only:false; response_revision:9269; number_of_response:1; }","duration":"155.945277ms","start":"2026-09-07T08:47:12.631194Z","end":"2026-09-07T08:47:12.78714Z","steps":["trace[126297645] 'process raft request'  (duration: 155.703771ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:12.787227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.282564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:47:12.787335Z","caller":"traceutil/trace.go:171","msg":"trace[558330894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9269; }","duration":"267.456209ms","start":"2026-09-07T08:47:12.519854Z","end":"2026-09-07T08:47:12.78731Z","steps":["trace[558330894] 'agreement among raft nodes before linearized reading'  (duration: 267.241193ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:23.047175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.948135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-09-07T08:47:23.047277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.752128ms","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:47:23.047322Z","caller":"traceutil/trace.go:171","msg":"trace[545121041] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9319; }","duration":"279.126791ms","start":"2026-09-07T08:47:22.768171Z","end":"2026-09-07T08:47:23.047297Z","steps":["trace[545121041] 'range keys from in-memory index tree'  (duration: 278.72728ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:23.047981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.710106ms","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-07T08:47:23.04807Z","caller":"traceutil/trace.go:171","msg":"trace[283105697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9319; }","duration":"282.84445ms","start":"2026-09-07T08:47:22.765203Z","end":"2026-09-07T08:47:23.048047Z","steps":["trace[283105697] 'range keys from in-memory index tree'  (duration: 282.089639ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:23.047334Z","caller":"traceutil/trace.go:171","msg":"trace[351756327] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9319; }","duration":"270.833869ms","start":"2026-09-07T08:47:22.776484Z","end":"2026-09-07T08:47:23.047318Z","steps":["trace[351756327] 'range keys from in-memory index tree'  (duration: 270.645695ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:23.047182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.882791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hvxm8\" ","response":"range_response_count:1 size:6526"}
{"level":"info","ts":"2026-09-07T08:47:23.048254Z","caller":"traceutil/trace.go:171","msg":"trace[448471818] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hvxm8; range_end:; response_count:1; response_revision:9319; }","duration":"253.9492ms","start":"2026-09-07T08:47:22.794255Z","end":"2026-09-07T08:47:23.048204Z","steps":["trace[448471818] 'range keys from in-memory index tree'  (duration: 252.775308ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:23.047922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.828148ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705555133350668395 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:9313 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:47:23.048398Z","caller":"traceutil/trace.go:171","msg":"trace[1627139561] linearizableReadLoop","detail":"{readStateIndex:9651; appliedIndex:9650; }","duration":"185.914195ms","start":"2026-09-07T08:47:22.862462Z","end":"2026-09-07T08:47:23.048376Z","steps":["trace[1627139561] 'read index received'  (duration: 51.478272ms)","trace[1627139561] 'applied index is now lower than readState.Index'  (duration: 134.433853ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:47:23.048396Z","caller":"traceutil/trace.go:171","msg":"trace[1744205732] transaction","detail":"{read_only:false; response_revision:9320; number_of_response:1; }","duration":"229.797646ms","start":"2026-09-07T08:47:22.818582Z","end":"2026-09-07T08:47:23.04838Z","steps":["trace[1744205732] 'process raft request'  (duration: 95.420914ms)","trace[1744205732] 'compare'  (duration: 133.691393ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:47:23.048553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.082621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:47:23.048627Z","caller":"traceutil/trace.go:171","msg":"trace[589473138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9320; }","duration":"186.223054ms","start":"2026-09-07T08:47:22.862383Z","end":"2026-09-07T08:47:23.048606Z","steps":["trace[589473138] 'agreement among raft nodes before linearized reading'  (duration: 186.09482ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:23.048657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.934167ms","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":"warn","ts":"2026-09-07T08:47:23.048711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.694147ms","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:47:23.04881Z","caller":"traceutil/trace.go:171","msg":"trace[1235753006] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9320; }","duration":"150.836171ms","start":"2026-09-07T08:47:22.897958Z","end":"2026-09-07T08:47:23.048795Z","steps":["trace[1235753006] 'agreement among raft nodes before linearized reading'  (duration: 150.580944ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:23.048733Z","caller":"traceutil/trace.go:171","msg":"trace[79807886] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:9320; }","duration":"129.04777ms","start":"2026-09-07T08:47:22.919667Z","end":"2026-09-07T08:47:23.048714Z","steps":["trace[79807886] 'agreement among raft nodes before linearized reading'  (duration: 128.906797ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:23.252817Z","caller":"traceutil/trace.go:171","msg":"trace[1689497288] transaction","detail":"{read_only:false; response_revision:9322; number_of_response:1; }","duration":"198.490581ms","start":"2026-09-07T08:47:23.054306Z","end":"2026-09-07T08:47:23.252797Z","steps":["trace[1689497288] 'process raft request'  (duration: 99.488253ms)","trace[1689497288] 'compare'  (duration: 98.848494ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:47:23.253231Z","caller":"traceutil/trace.go:171","msg":"trace[1250355640] transaction","detail":"{read_only:false; response_revision:9323; number_of_response:1; }","duration":"198.685406ms","start":"2026-09-07T08:47:23.0545Z","end":"2026-09-07T08:47:23.253185Z","steps":["trace[1250355640] 'process raft request'  (duration: 198.265775ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:23.25329Z","caller":"traceutil/trace.go:171","msg":"trace[1910831835] transaction","detail":"{read_only:false; response_revision:9324; number_of_response:1; }","duration":"198.676166ms","start":"2026-09-07T08:47:23.054563Z","end":"2026-09-07T08:47:23.25324Z","steps":["trace[1910831835] 'process raft request'  (duration: 198.372218ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:23.2535Z","caller":"traceutil/trace.go:171","msg":"trace[1918422491] transaction","detail":"{read_only:false; response_revision:9325; number_of_response:1; }","duration":"198.985094ms","start":"2026-09-07T08:47:23.0545Z","end":"2026-09-07T08:47:23.253485Z","steps":["trace[1918422491] 'process raft request'  (duration: 198.667975ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:23.253521Z","caller":"traceutil/trace.go:171","msg":"trace[756421597] linearizableReadLoop","detail":"{readStateIndex:9656; appliedIndex:9651; }","duration":"169.95306ms","start":"2026-09-07T08:47:23.083504Z","end":"2026-09-07T08:47:23.253457Z","steps":["trace[756421597] 'read index received'  (duration: 4.199602ms)","trace[756421597] 'applied index is now lower than readState.Index'  (duration: 165.750658ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:47:23.253841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.31506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:47:23.253893Z","caller":"traceutil/trace.go:171","msg":"trace[836658266] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:9325; }","duration":"170.406732ms","start":"2026-09-07T08:47:23.083476Z","end":"2026-09-07T08:47:23.253883Z","steps":["trace[836658266] 'agreement among raft nodes before linearized reading'  (duration: 170.093694ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:23.648088Z","caller":"traceutil/trace.go:171","msg":"trace[191892872] linearizableReadLoop","detail":"{readStateIndex:9660; appliedIndex:9659; }","duration":"132.221115ms","start":"2026-09-07T08:47:23.515842Z","end":"2026-09-07T08:47:23.648063Z","steps":["trace[191892872] 'read index received'  (duration: 73.597502ms)","trace[191892872] 'applied index is now lower than readState.Index'  (duration: 58.622153ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:47:23.648214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.359128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:47:23.648248Z","caller":"traceutil/trace.go:171","msg":"trace[1275925837] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9328; }","duration":"132.4434ms","start":"2026-09-07T08:47:23.515796Z","end":"2026-09-07T08:47:23.648239Z","steps":["trace[1275925837] 'agreement among raft nodes before linearized reading'  (duration: 132.360788ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:23.871359Z","caller":"traceutil/trace.go:171","msg":"trace[1792755879] transaction","detail":"{read_only:false; response_revision:9329; number_of_response:1; }","duration":"221.937416ms","start":"2026-09-07T08:47:23.649378Z","end":"2026-09-07T08:47:23.871315Z","steps":["trace[1792755879] 'process raft request'  (duration: 142.680633ms)","trace[1792755879] 'compare'  (duration: 79.093959ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:47:24.281104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.166124ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705555133350668420 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-detect-version-ss7nr.18d2fd9af2e3228a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-detect-version-ss7nr.18d2fd9af2e3228a\" value_size:736 lease:5482183096495892331 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:47:24.282102Z","caller":"traceutil/trace.go:171","msg":"trace[340541965] transaction","detail":"{read_only:false; response_revision:9330; number_of_response:1; }","duration":"317.488623ms","start":"2026-09-07T08:47:23.96459Z","end":"2026-09-07T08:47:24.282079Z","steps":["trace[340541965] 'process raft request'  (duration: 14.273501ms)","trace[340541965] 'compare'  (duration: 301.817535ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:47:24.282328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:47:23.964558Z","time spent":"317.73392ms","remote":"127.0.0.1:49948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":828,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-detect-version-ss7nr.18d2fd9af2e3228a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-detect-version-ss7nr.18d2fd9af2e3228a\" value_size:736 lease:5482183096495892331 >> failure:<>"}
{"level":"warn","ts":"2026-09-07T08:47:24.681653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.342952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"}
{"level":"info","ts":"2026-09-07T08:47:24.681763Z","caller":"traceutil/trace.go:171","msg":"trace[1201799991] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:9331; }","duration":"295.508527ms","start":"2026-09-07T08:47:24.386227Z","end":"2026-09-07T08:47:24.681736Z","steps":["trace[1201799991] 'range keys from in-memory index tree'  (duration: 295.080105ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:24.685306Z","caller":"traceutil/trace.go:171","msg":"trace[1055642296] transaction","detail":"{read_only:false; response_revision:9332; number_of_response:1; }","duration":"274.595609ms","start":"2026-09-07T08:47:24.410663Z","end":"2026-09-07T08:47:24.685259Z","steps":["trace[1055642296] 'process raft request'  (duration: 265.850836ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:24.936339Z","caller":"traceutil/trace.go:171","msg":"trace[2128407460] transaction","detail":"{read_only:false; response_revision:9333; number_of_response:1; }","duration":"456.623892ms","start":"2026-09-07T08:47:24.479655Z","end":"2026-09-07T08:47:24.936279Z","steps":["trace[2128407460] 'process raft request'  (duration: 381.929321ms)","trace[2128407460] 'compare'  (duration: 74.252889ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:47:24.936558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:47:24.479629Z","time spent":"456.838888ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:9254 > 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-07T08:47:24.936822Z","caller":"traceutil/trace.go:171","msg":"trace[1847487728] transaction","detail":"{read_only:false; response_revision:9334; number_of_response:1; }","duration":"366.186651ms","start":"2026-09-07T08:47:24.570592Z","end":"2026-09-07T08:47:24.936778Z","steps":["trace[1847487728] 'process raft request'  (duration: 365.589315ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:24.936912Z","caller":"traceutil/trace.go:171","msg":"trace[1125140504] linearizableReadLoop","detail":"{readStateIndex:9665; appliedIndex:9663; }","duration":"420.669313ms","start":"2026-09-07T08:47:24.516195Z","end":"2026-09-07T08:47:24.936865Z","steps":["trace[1125140504] 'read index received'  (duration: 160.404586ms)","trace[1125140504] 'applied index is now lower than readState.Index'  (duration: 260.257437ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:47:24.937044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:47:24.570566Z","time spent":"366.355326ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:9319 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-07T08:47:24.937092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.893749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:47:24.937132Z","caller":"traceutil/trace.go:171","msg":"trace[1894882196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9335; }","duration":"420.975861ms","start":"2026-09-07T08:47:24.516145Z","end":"2026-09-07T08:47:24.937121Z","steps":["trace[1894882196] 'agreement among raft nodes before linearized reading'  (duration: 420.908129ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:47:24.937166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:47:24.516122Z","time spent":"421.035593ms","remote":"127.0.0.1:49888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-09-07T08:47:24.937334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.616117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-993a8af9-25e5-4f74-9f4e-cac842ac26d2\" ","response":"range_response_count:1 size:1293"}
{"level":"info","ts":"2026-09-07T08:47:24.937462Z","caller":"traceutil/trace.go:171","msg":"trace[2001412104] range","detail":"{range_begin:/registry/persistentvolumes/pvc-993a8af9-25e5-4f74-9f4e-cac842ac26d2; range_end:; response_count:1; response_revision:9335; }","duration":"251.806803ms","start":"2026-09-07T08:47:24.685627Z","end":"2026-09-07T08:47:24.937434Z","steps":["trace[2001412104] 'agreement among raft nodes before linearized reading'  (duration: 251.477234ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:47:54.430271Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c665390cd9eacc14","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-07T08:47:54.437909Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-07T08:47:54.438104Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-07T08:48:41.456772Z","caller":"traceutil/trace.go:171","msg":"trace[329838673] transaction","detail":"{read_only:false; response_revision:10120; number_of_response:1; }","duration":"109.033696ms","start":"2026-09-07T08:48:41.347713Z","end":"2026-09-07T08:48:41.456747Z","steps":["trace[329838673] 'process raft request'  (duration: 108.885372ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:48:57.870925Z","caller":"traceutil/trace.go:171","msg":"trace[753673509] transaction","detail":"{read_only:false; response_revision:10212; number_of_response:1; }","duration":"220.368824ms","start":"2026-09-07T08:48:57.650534Z","end":"2026-09-07T08:48:57.870903Z","steps":["trace[753673509] 'process raft request'  (duration: 193.155068ms)","trace[753673509] 'compare'  (duration: 26.99718ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:48:57.871136Z","caller":"traceutil/trace.go:171","msg":"trace[846593777] linearizableReadLoop","detail":"{readStateIndex:10573; appliedIndex:10571; }","duration":"120.493752ms","start":"2026-09-07T08:48:57.750609Z","end":"2026-09-07T08:48:57.871103Z","steps":["trace[846593777] 'read index received'  (duration: 93.161734ms)","trace[846593777] 'applied index is now lower than readState.Index'  (duration: 27.329218ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:48:57.871319Z","caller":"traceutil/trace.go:171","msg":"trace[2057918444] transaction","detail":"{read_only:false; response_revision:10213; number_of_response:1; }","duration":"195.943954ms","start":"2026-09-07T08:48:57.675358Z","end":"2026-09-07T08:48:57.871302Z","steps":["trace[2057918444] 'process raft request'  (duration: 195.483052ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:48:57.871722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.091918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hvxm8\" ","response":"range_response_count:1 size:6526"}
{"level":"warn","ts":"2026-09-07T08:48:57.871728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.925147ms","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:48:57.871823Z","caller":"traceutil/trace.go:171","msg":"trace[375774162] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hvxm8; range_end:; response_count:1; response_revision:10213; }","duration":"121.213311ms","start":"2026-09-07T08:48:57.750575Z","end":"2026-09-07T08:48:57.871788Z","steps":["trace[375774162] 'agreement among raft nodes before linearized reading'  (duration: 120.999515ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:48:57.871836Z","caller":"traceutil/trace.go:171","msg":"trace[999722583] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:10213; }","duration":"114.06141ms","start":"2026-09-07T08:48:57.757744Z","end":"2026-09-07T08:48:57.871805Z","steps":["trace[999722583] 'agreement among raft nodes before linearized reading'  (duration: 113.709461ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:48:58.041274Z","caller":"traceutil/trace.go:171","msg":"trace[1275775915] transaction","detail":"{read_only:false; response_revision:10214; number_of_response:1; }","duration":"163.853117ms","start":"2026-09-07T08:48:57.877384Z","end":"2026-09-07T08:48:58.041238Z","steps":["trace[1275775915] 'process raft request'  (duration: 163.658032ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:48:58.047176Z","caller":"traceutil/trace.go:171","msg":"trace[1740274986] transaction","detail":"{read_only:false; response_revision:10215; number_of_response:1; }","duration":"169.692643ms","start":"2026-09-07T08:48:57.877455Z","end":"2026-09-07T08:48:58.047147Z","steps":["trace[1740274986] 'process raft request'  (duration: 169.367164ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:48:58.047252Z","caller":"traceutil/trace.go:171","msg":"trace[459099793] transaction","detail":"{read_only:false; response_revision:10216; number_of_response:1; }","duration":"169.322264ms","start":"2026-09-07T08:48:57.877885Z","end":"2026-09-07T08:48:58.047208Z","steps":["trace[459099793] 'process raft request'  (duration: 169.139689ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:48:58.047354Z","caller":"traceutil/trace.go:171","msg":"trace[1973915814] linearizableReadLoop","detail":"{readStateIndex:10575; appliedIndex:10573; }","duration":"169.789156ms","start":"2026-09-07T08:48:57.877526Z","end":"2026-09-07T08:48:58.047315Z","steps":["trace[1973915814] 'read index received'  (duration: 163.57753ms)","trace[1973915814] 'applied index is now lower than readState.Index'  (duration: 6.207316ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:48:58.047375Z","caller":"traceutil/trace.go:171","msg":"trace[1552082495] transaction","detail":"{read_only:false; response_revision:10217; number_of_response:1; }","duration":"169.343495ms","start":"2026-09-07T08:48:57.878004Z","end":"2026-09-07T08:48:58.047348Z","steps":["trace[1552082495] 'process raft request'  (duration: 169.084378ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:48:58.048062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.508496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:31 size:291484"}
{"level":"info","ts":"2026-09-07T08:48:58.048144Z","caller":"traceutil/trace.go:171","msg":"trace[300917556] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:31; response_revision:10217; }","duration":"170.612538ms","start":"2026-09-07T08:48:57.877514Z","end":"2026-09-07T08:48:58.048127Z","steps":["trace[300917556] 'agreement among raft nodes before linearized reading'  (duration: 169.966771ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:49:09.838256Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7868}
{"level":"info","ts":"2026-09-07T08:49:09.940944Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7868,"took":"100.505919ms","hash":1936315625,"current-db-size-bytes":46374912,"current-db-size":"46 MB","current-db-size-in-use-bytes":25616384,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-07T08:49:09.941017Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1936315625,"revision":7868,"compact-revision":4845}
{"level":"info","ts":"2026-09-07T08:50:40.573891Z","caller":"traceutil/trace.go:171","msg":"trace[1175332105] transaction","detail":"{read_only:false; response_revision:10890; number_of_response:1; }","duration":"131.391643ms","start":"2026-09-07T08:50:40.442453Z","end":"2026-09-07T08:50:40.573844Z","steps":["trace[1175332105] 'process raft request'  (duration: 118.587881ms)","trace[1175332105] 'compare'  (duration: 12.418021ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:52:53.508893Z","caller":"traceutil/trace.go:171","msg":"trace[1503413589] transaction","detail":"{read_only:false; response_revision:11665; number_of_response:1; }","duration":"109.688467ms","start":"2026-09-07T08:52:53.39918Z","end":"2026-09-07T08:52:53.508868Z","steps":["trace[1503413589] 'process raft request'  (duration: 106.556893ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:52:53.508844Z","caller":"traceutil/trace.go:171","msg":"trace[1098036925] linearizableReadLoop","detail":"{readStateIndex:12079; appliedIndex:12078; }","duration":"103.674746ms","start":"2026-09-07T08:52:53.405093Z","end":"2026-09-07T08:52:53.508768Z","steps":["trace[1098036925] 'read index received'  (duration: 100.670186ms)","trace[1098036925] 'applied index is now lower than readState.Index'  (duration: 3.00358ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:52:53.509062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.960363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:52:53.509205Z","caller":"traceutil/trace.go:171","msg":"trace[1807336369] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:11665; }","duration":"104.082026ms","start":"2026-09-07T08:52:53.405065Z","end":"2026-09-07T08:52:53.509147Z","steps":["trace[1807336369] 'agreement among raft nodes before linearized reading'  (duration: 103.886301ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:54:09.844961Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10308}
{"level":"info","ts":"2026-09-07T08:54:09.931818Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10308,"took":"84.72526ms","hash":4066798838,"current-db-size-bytes":46374912,"current-db-size":"46 MB","current-db-size-in-use-bytes":25567232,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-07T08:54:09.93191Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4066798838,"revision":10308,"compact-revision":7868}
{"level":"warn","ts":"2026-09-07T08:54:18.315472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.158405ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705555133350676899 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:12528 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T08:54:18.315609Z","caller":"traceutil/trace.go:171","msg":"trace[1355469679] linearizableReadLoop","detail":"{readStateIndex:12976; appliedIndex:12975; }","duration":"207.466804ms","start":"2026-09-07T08:54:18.108122Z","end":"2026-09-07T08:54:18.315589Z","steps":["trace[1355469679] 'read index received'  (duration: 56.98134ms)","trace[1355469679] 'applied index is now lower than readState.Index'  (duration: 150.483914ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:54:18.315681Z","caller":"traceutil/trace.go:171","msg":"trace[1817015487] transaction","detail":"{read_only:false; response_revision:12540; number_of_response:1; }","duration":"212.19724ms","start":"2026-09-07T08:54:18.103434Z","end":"2026-09-07T08:54:18.315631Z","steps":["trace[1817015487] 'process raft request'  (duration: 61.749487ms)","trace[1817015487] 'compare'  (duration: 150.033782ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:54:18.315949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.828853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-07T08:54:18.315993Z","caller":"traceutil/trace.go:171","msg":"trace[1193362018] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12540; }","duration":"207.897265ms","start":"2026-09-07T08:54:18.10808Z","end":"2026-09-07T08:54:18.315977Z","steps":["trace[1193362018] 'agreement among raft nodes before linearized reading'  (duration: 207.608788ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:54:18.316202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.830547ms","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-07T08:54:18.316271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.808526ms","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-07T08:54:18.316325Z","caller":"traceutil/trace.go:171","msg":"trace[523831332] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12540; }","duration":"128.95617ms","start":"2026-09-07T08:54:18.187302Z","end":"2026-09-07T08:54:18.316258Z","steps":["trace[523831332] 'agreement among raft nodes before linearized reading'  (duration: 128.702703ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:54:18.316343Z","caller":"traceutil/trace.go:171","msg":"trace[1114918901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12540; }","duration":"128.966341ms","start":"2026-09-07T08:54:18.187358Z","end":"2026-09-07T08:54:18.316325Z","steps":["trace[1114918901] 'agreement among raft nodes before linearized reading'  (duration: 128.802436ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:54:42.235857Z","caller":"traceutil/trace.go:171","msg":"trace[1959395269] linearizableReadLoop","detail":"{readStateIndex:13114; appliedIndex:13113; }","duration":"136.859621ms","start":"2026-09-07T08:54:42.098973Z","end":"2026-09-07T08:54:42.235833Z","steps":["trace[1959395269] 'read index received'  (duration: 136.654726ms)","trace[1959395269] 'applied index is now lower than readState.Index'  (duration: 203.765µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:54:42.235928Z","caller":"traceutil/trace.go:171","msg":"trace[268455461] transaction","detail":"{read_only:false; response_revision:12673; number_of_response:1; }","duration":"140.092447ms","start":"2026-09-07T08:54:42.095807Z","end":"2026-09-07T08:54:42.2359Z","steps":["trace[268455461] 'process raft request'  (duration: 139.84017ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:54:42.236077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.084617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-09-07T08:54:42.236118Z","caller":"traceutil/trace.go:171","msg":"trace[125634350] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:12673; }","duration":"137.162869ms","start":"2026-09-07T08:54:42.098945Z","end":"2026-09-07T08:54:42.236108Z","steps":["trace[125634350] 'agreement among raft nodes before linearized reading'  (duration: 136.986714ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:54:42.578398Z","caller":"traceutil/trace.go:171","msg":"trace[567699423] transaction","detail":"{read_only:false; response_revision:12675; number_of_response:1; }","duration":"100.323886ms","start":"2026-09-07T08:54:42.478051Z","end":"2026-09-07T08:54:42.578375Z","steps":["trace[567699423] 'process raft request'  (duration: 100.038539ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:54:42.707143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.171543ms","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:54:42.707249Z","caller":"traceutil/trace.go:171","msg":"trace[1458344219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12675; }","duration":"196.301827ms","start":"2026-09-07T08:54:42.510919Z","end":"2026-09-07T08:54:42.70722Z","steps":["trace[1458344219] 'agreement among raft nodes before linearized reading'  (duration: 67.695846ms)","trace[1458344219] 'range keys from in-memory index tree'  (duration: 128.330403ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T08:54:42.707268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.983831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-09-07T08:54:42.707252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.553906ms","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-07T08:54:42.707549Z","caller":"traceutil/trace.go:171","msg":"trace[1603662887] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12675; }","duration":"198.076744ms","start":"2026-09-07T08:54:42.509265Z","end":"2026-09-07T08:54:42.707342Z","steps":["trace[1603662887] 'agreement among raft nodes before linearized reading'  (duration: 69.393581ms)","trace[1603662887] 'range keys from in-memory index tree'  (duration: 128.511969ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:54:42.707562Z","caller":"traceutil/trace.go:171","msg":"trace[1950156106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12675; }","duration":"192.854454ms","start":"2026-09-07T08:54:42.514623Z","end":"2026-09-07T08:54:42.707478Z","steps":["trace[1950156106] 'agreement among raft nodes before linearized reading'  (duration: 64.038118ms)","trace[1950156106] 'range keys from in-memory index tree'  (duration: 128.405186ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:54:42.82898Z","caller":"traceutil/trace.go:171","msg":"trace[45294625] transaction","detail":"{read_only:false; response_revision:12676; number_of_response:1; }","duration":"115.83693ms","start":"2026-09-07T08:54:42.713109Z","end":"2026-09-07T08:54:42.828946Z","steps":["trace[45294625] 'process raft request'  (duration: 115.618144ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:54:42.876009Z","caller":"traceutil/trace.go:171","msg":"trace[2125600399] transaction","detail":"{read_only:false; response_revision:12678; number_of_response:1; }","duration":"162.065703ms","start":"2026-09-07T08:54:42.713905Z","end":"2026-09-07T08:54:42.87597Z","steps":["trace[2125600399] 'process raft request'  (duration: 161.926549ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:54:42.876064Z","caller":"traceutil/trace.go:171","msg":"trace[81347247] transaction","detail":"{read_only:false; response_revision:12677; number_of_response:1; }","duration":"162.933226ms","start":"2026-09-07T08:54:42.713109Z","end":"2026-09-07T08:54:42.876042Z","steps":["trace[81347247] 'process raft request'  (duration: 162.530035ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:54:43.669271Z","caller":"traceutil/trace.go:171","msg":"trace[940769717] linearizableReadLoop","detail":"{readStateIndex:13125; appliedIndex:13124; }","duration":"107.028275ms","start":"2026-09-07T08:54:43.56222Z","end":"2026-09-07T08:54:43.669248Z","steps":["trace[940769717] 'read index received'  (duration: 106.743267ms)","trace[940769717] 'applied index is now lower than readState.Index'  (duration: 283.508µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T08:54:43.669389Z","caller":"traceutil/trace.go:171","msg":"trace[1848411406] transaction","detail":"{read_only:false; response_revision:12683; number_of_response:1; }","duration":"146.600481ms","start":"2026-09-07T08:54:43.522778Z","end":"2026-09-07T08:54:43.669379Z","steps":["trace[1848411406] 'process raft request'  (duration: 146.265552ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:54:43.669721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.486888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:54:43.669765Z","caller":"traceutil/trace.go:171","msg":"trace[2069168236] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12683; }","duration":"107.59254ms","start":"2026-09-07T08:54:43.562162Z","end":"2026-09-07T08:54:43.669755Z","steps":["trace[2069168236] 'agreement among raft nodes before linearized reading'  (duration: 107.476327ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:54:43.669731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.22541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-07T08:54:43.669803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.9682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"}
{"level":"info","ts":"2026-09-07T08:54:43.669879Z","caller":"traceutil/trace.go:171","msg":"trace[641896161] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12683; }","duration":"105.074323ms","start":"2026-09-07T08:54:43.564787Z","end":"2026-09-07T08:54:43.669862Z","steps":["trace[641896161] 'agreement among raft nodes before linearized reading'  (duration: 104.837197ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:54:43.669826Z","caller":"traceutil/trace.go:171","msg":"trace[408942796] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12683; }","duration":"107.409385ms","start":"2026-09-07T08:54:43.562394Z","end":"2026-09-07T08:54:43.669803Z","steps":["trace[408942796] 'agreement among raft nodes before linearized reading'  (duration: 107.188399ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:54:43.670008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.072667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:54:43.670058Z","caller":"traceutil/trace.go:171","msg":"trace[1372175471] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12683; }","duration":"107.163249ms","start":"2026-09-07T08:54:43.562883Z","end":"2026-09-07T08:54:43.670046Z","steps":["trace[1372175471] 'agreement among raft nodes before linearized reading'  (duration: 107.100657ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T08:54:43.670081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.59539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T08:54:43.670187Z","caller":"traceutil/trace.go:171","msg":"trace[1744501204] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12683; }","duration":"107.657291ms","start":"2026-09-07T08:54:43.562449Z","end":"2026-09-07T08:54:43.670106Z","steps":["trace[1744501204] 'agreement among raft nodes before linearized reading'  (duration: 107.59402ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T08:59:09.852581Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12470}
{"level":"info","ts":"2026-09-07T08:59:09.956688Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12470,"took":"102.119074ms","hash":2584261672,"current-db-size-bytes":46374912,"current-db-size":"46 MB","current-db-size-in-use-bytes":27688960,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-07T08:59:09.956822Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2584261672,"revision":12470,"compact-revision":10308}
{"level":"info","ts":"2026-09-07T09:01:31.087828Z","caller":"traceutil/trace.go:171","msg":"trace[1820874560] transaction","detail":"{read_only:false; response_revision:15370; number_of_response:1; }","duration":"197.344184ms","start":"2026-09-07T09:01:30.890372Z","end":"2026-09-07T09:01:31.087717Z","steps":["trace[1820874560] 'process raft request'  (duration: 197.19757ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:01:50.170997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.691343ms","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-07T09:01:50.171119Z","caller":"traceutil/trace.go:171","msg":"trace[1292302695] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:15483; }","duration":"140.854737ms","start":"2026-09-07T09:01:50.030235Z","end":"2026-09-07T09:01:50.171089Z","steps":["trace[1292302695] 'count revisions from in-memory index tree'  (duration: 140.55356ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:02:16.645779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.681364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-zlld8\" ","response":"range_response_count:1 size:20640"}
{"level":"warn","ts":"2026-09-07T09:02:16.645821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.057686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-07T09:02:16.645891Z","caller":"traceutil/trace.go:171","msg":"trace[603070433] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-zlld8; range_end:; response_count:1; response_revision:15814; }","duration":"272.826988ms","start":"2026-09-07T09:02:16.373026Z","end":"2026-09-07T09:02:16.645853Z","steps":["trace[603070433] 'range keys from in-memory index tree'  (duration: 272.467398ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:02:16.645906Z","caller":"traceutil/trace.go:171","msg":"trace[1497938548] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:15814; }","duration":"122.19706ms","start":"2026-09-07T09:02:16.523684Z","end":"2026-09-07T09:02:16.645881Z","steps":["trace[1497938548] 'count revisions from in-memory index tree'  (duration: 121.951703ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:02:16.879384Z","caller":"traceutil/trace.go:171","msg":"trace[1536122987] transaction","detail":"{read_only:false; response_revision:15815; number_of_response:1; }","duration":"120.299359ms","start":"2026-09-07T09:02:16.759051Z","end":"2026-09-07T09:02:16.87935Z","steps":["trace[1536122987] 'process raft request'  (duration: 120.093694ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:03:10.039075Z","caller":"traceutil/trace.go:171","msg":"trace[1851699667] transaction","detail":"{read_only:false; response_revision:16452; number_of_response:1; }","duration":"192.207987ms","start":"2026-09-07T09:03:09.846833Z","end":"2026-09-07T09:03:10.039041Z","steps":["trace[1851699667] 'process raft request'  (duration: 192.007471ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:03:10.04634Z","caller":"traceutil/trace.go:171","msg":"trace[1871912307] transaction","detail":"{read_only:false; response_revision:16453; number_of_response:1; }","duration":"199.43145ms","start":"2026-09-07T09:03:09.846882Z","end":"2026-09-07T09:03:10.046313Z","steps":["trace[1871912307] 'process raft request'  (duration: 199.260725ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:03:10.046643Z","caller":"traceutil/trace.go:171","msg":"trace[482962286] linearizableReadLoop","detail":"{readStateIndex:17025; appliedIndex:17021; }","duration":"166.82841ms","start":"2026-09-07T09:03:09.879793Z","end":"2026-09-07T09:03:10.046622Z","steps":["trace[482962286] 'read index received'  (duration: 159.144635ms)","trace[482962286] 'applied index is now lower than readState.Index'  (duration: 7.682735ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T09:03:10.046718Z","caller":"traceutil/trace.go:171","msg":"trace[787761318] transaction","detail":"{read_only:false; response_revision:16455; number_of_response:1; }","duration":"199.712957ms","start":"2026-09-07T09:03:09.84699Z","end":"2026-09-07T09:03:10.046703Z","steps":["trace[787761318] 'process raft request'  (duration: 199.552403ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:03:10.046805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.013595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-07T09:03:10.04673Z","caller":"traceutil/trace.go:171","msg":"trace[72623463] transaction","detail":"{read_only:false; response_revision:16454; number_of_response:1; }","duration":"199.718338ms","start":"2026-09-07T09:03:09.846969Z","end":"2026-09-07T09:03:10.046687Z","steps":["trace[72623463] 'process raft request'  (duration: 199.306607ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:03:10.046857Z","caller":"traceutil/trace.go:171","msg":"trace[1917460347] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16455; }","duration":"167.130729ms","start":"2026-09-07T09:03:09.879708Z","end":"2026-09-07T09:03:10.046838Z","steps":["trace[1917460347] 'agreement among raft nodes before linearized reading'  (duration: 167.022306ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:03:10.046885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.320767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-07T09:03:10.046968Z","caller":"traceutil/trace.go:171","msg":"trace[573792328] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16455; }","duration":"166.499532ms","start":"2026-09-07T09:03:09.880446Z","end":"2026-09-07T09:03:10.046946Z","steps":["trace[573792328] 'agreement among raft nodes before linearized reading'  (duration: 166.346128ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:03:10.046973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.418493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-07T09:03:10.047046Z","caller":"traceutil/trace.go:171","msg":"trace[2005284153] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16455; }","duration":"165.543986ms","start":"2026-09-07T09:03:09.88148Z","end":"2026-09-07T09:03:10.047024Z","steps":["trace[2005284153] 'agreement among raft nodes before linearized reading'  (duration: 165.413052ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:03:10.047051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.636421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5524"}
{"level":"info","ts":"2026-09-07T09:03:10.047355Z","caller":"traceutil/trace.go:171","msg":"trace[436582623] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16455; }","duration":"158.981501ms","start":"2026-09-07T09:03:09.888347Z","end":"2026-09-07T09:03:10.047328Z","steps":["trace[436582623] 'agreement among raft nodes before linearized reading'  (duration: 158.471247ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:03:44.133689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.559606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-07T09:03:44.133775Z","caller":"traceutil/trace.go:171","msg":"trace[24816408] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:16631; }","duration":"150.677409ms","start":"2026-09-07T09:03:43.983079Z","end":"2026-09-07T09:03:44.133757Z","steps":["trace[24816408] 'count revisions from in-memory index tree'  (duration: 150.491114ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:03:44.134086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.103507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-wthtf\" ","response":"range_response_count:1 size:22097"}
{"level":"info","ts":"2026-09-07T09:03:44.134132Z","caller":"traceutil/trace.go:171","msg":"trace[80962685] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-wthtf; range_end:; response_count:1; response_revision:16631; }","duration":"197.181289ms","start":"2026-09-07T09:03:43.936941Z","end":"2026-09-07T09:03:44.134122Z","steps":["trace[80962685] 'range keys from in-memory index tree'  (duration: 196.972533ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:03:44.134499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.873741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hvxm8\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-09-07T09:03:44.134786Z","caller":"traceutil/trace.go:171","msg":"trace[1044510769] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hvxm8; range_end:; response_count:1; response_revision:16631; }","duration":"152.094527ms","start":"2026-09-07T09:03:43.982551Z","end":"2026-09-07T09:03:44.134646Z","steps":["trace[1044510769] 'range keys from in-memory index tree'  (duration: 151.657885ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:03:44.333194Z","caller":"traceutil/trace.go:171","msg":"trace[1924801779] linearizableReadLoop","detail":"{readStateIndex:17209; appliedIndex:17208; }","duration":"114.382621ms","start":"2026-09-07T09:03:44.218785Z","end":"2026-09-07T09:03:44.333168Z","steps":["trace[1924801779] 'read index received'  (duration: 114.262997ms)","trace[1924801779] 'applied index is now lower than readState.Index'  (duration: 118.283µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T09:03:44.333319Z","caller":"traceutil/trace.go:171","msg":"trace[1154588993] transaction","detail":"{read_only:false; response_revision:16632; number_of_response:1; }","duration":"165.917826ms","start":"2026-09-07T09:03:44.16737Z","end":"2026-09-07T09:03:44.333288Z","steps":["trace[1154588993] 'process raft request'  (duration: 165.629338ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:03:44.333519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.70868ms","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-07T09:03:44.333672Z","caller":"traceutil/trace.go:171","msg":"trace[1886163959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16632; }","duration":"114.918815ms","start":"2026-09-07T09:03:44.218726Z","end":"2026-09-07T09:03:44.333645Z","steps":["trace[1886163959] 'agreement among raft nodes before linearized reading'  (duration: 114.589976ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:03:44.334073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.3346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-09-07T09:03:44.33426Z","caller":"traceutil/trace.go:171","msg":"trace[956394171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:16632; }","duration":"114.621487ms","start":"2026-09-07T09:03:44.219623Z","end":"2026-09-07T09:03:44.334245Z","steps":["trace[956394171] 'agreement among raft nodes before linearized reading'  (duration: 113.695323ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:03:44.334859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.198403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-09-07T09:03:44.336027Z","caller":"traceutil/trace.go:171","msg":"trace[551550670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16632; }","duration":"110.416825ms","start":"2026-09-07T09:03:44.225583Z","end":"2026-09-07T09:03:44.336Z","steps":["trace[551550670] 'agreement among raft nodes before linearized reading'  (duration: 107.925339ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:03:50.482346Z","caller":"traceutil/trace.go:171","msg":"trace[285893070] transaction","detail":"{read_only:false; response_revision:16663; number_of_response:1; }","duration":"126.077793ms","start":"2026-09-07T09:03:50.356247Z","end":"2026-09-07T09:03:50.482325Z","steps":["trace[285893070] 'process raft request'  (duration: 125.737064ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:04:09.861751Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14482}
{"level":"info","ts":"2026-09-07T09:04:09.938211Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14482,"took":"74.139348ms","hash":50094102,"current-db-size-bytes":46374912,"current-db-size":"46 MB","current-db-size-in-use-bytes":30019584,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-07T09:04:09.938265Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":50094102,"revision":14482,"compact-revision":12470}
{"level":"info","ts":"2026-09-07T09:09:09.869644Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16764}
{"level":"info","ts":"2026-09-07T09:09:09.966548Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16764,"took":"94.636684ms","hash":3270096944,"current-db-size-bytes":46796800,"current-db-size":"47 MB","current-db-size-in-use-bytes":30199808,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-07T09:09:09.966609Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3270096944,"revision":16764,"compact-revision":14482}
{"level":"info","ts":"2026-09-07T09:10:02.024985Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c665390cd9eacc14","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-07T09:10:02.030424Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-07T09:10:02.030508Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"warn","ts":"2026-09-07T09:10:39.359107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.074056ms","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:8"}
{"level":"info","ts":"2026-09-07T09:10:39.359197Z","caller":"traceutil/trace.go:171","msg":"trace[1840506160] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:19577; }","duration":"107.22414ms","start":"2026-09-07T09:10:39.251954Z","end":"2026-09-07T09:10:39.359178Z","steps":["trace[1840506160] 'count revisions from in-memory index tree'  (duration: 106.983724ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:48.646672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.389242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-07T09:10:48.646743Z","caller":"traceutil/trace.go:171","msg":"trace[1256114724] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:19634; }","duration":"189.503375ms","start":"2026-09-07T09:10:48.457225Z","end":"2026-09-07T09:10:48.646728Z","steps":["trace[1256114724] 'count revisions from in-memory index tree'  (duration: 189.33681ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:48.646816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.911323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-07T09:10:48.647064Z","caller":"traceutil/trace.go:171","msg":"trace[220550920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19634; }","duration":"131.238421ms","start":"2026-09-07T09:10:48.515799Z","end":"2026-09-07T09:10:48.647037Z","steps":["trace[220550920] 'range keys from in-memory index tree'  (duration: 130.766678ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:49.039711Z","caller":"traceutil/trace.go:171","msg":"trace[249064847] transaction","detail":"{read_only:false; response_revision:19635; number_of_response:1; }","duration":"199.761148ms","start":"2026-09-07T09:10:48.839924Z","end":"2026-09-07T09:10:49.039686Z","steps":["trace[249064847] 'process raft request'  (duration: 199.48088ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:49.039831Z","caller":"traceutil/trace.go:171","msg":"trace[350300448] linearizableReadLoop","detail":"{readStateIndex:20314; appliedIndex:20313; }","duration":"139.691946ms","start":"2026-09-07T09:10:48.899896Z","end":"2026-09-07T09:10:49.039587Z","steps":["trace[350300448] 'read index received'  (duration: 139.391228ms)","trace[350300448] 'applied index is now lower than readState.Index'  (duration: 299.448µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T09:10:49.039906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.952593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-07T09:10:49.039968Z","caller":"traceutil/trace.go:171","msg":"trace[1496559263] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:19635; }","duration":"140.106167ms","start":"2026-09-07T09:10:48.899842Z","end":"2026-09-07T09:10:49.039948Z","steps":["trace[1496559263] 'agreement among raft nodes before linearized reading'  (duration: 139.960263ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:49.040115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.727817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-09-07T09:10:49.04016Z","caller":"traceutil/trace.go:171","msg":"trace[540360014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19635; }","duration":"109.784538ms","start":"2026-09-07T09:10:48.930359Z","end":"2026-09-07T09:10:49.040143Z","steps":["trace[540360014] 'agreement among raft nodes before linearized reading'  (duration: 109.678685ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:49.040447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.616907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-09-07T09:10:49.040491Z","caller":"traceutil/trace.go:171","msg":"trace[1968532076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19635; }","duration":"114.706019ms","start":"2026-09-07T09:10:48.925771Z","end":"2026-09-07T09:10:49.040477Z","steps":["trace[1968532076] 'agreement among raft nodes before linearized reading'  (duration: 114.184845ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:49.166048Z","caller":"traceutil/trace.go:171","msg":"trace[1592872872] transaction","detail":"{read_only:false; response_revision:19636; number_of_response:1; }","duration":"120.384771ms","start":"2026-09-07T09:10:49.045643Z","end":"2026-09-07T09:10:49.166028Z","steps":["trace[1592872872] 'process raft request'  (duration: 120.213577ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:49.182144Z","caller":"traceutil/trace.go:171","msg":"trace[824423262] transaction","detail":"{read_only:false; response_revision:19637; number_of_response:1; }","duration":"136.340976ms","start":"2026-09-07T09:10:49.045774Z","end":"2026-09-07T09:10:49.182115Z","steps":["trace[824423262] 'process raft request'  (duration: 135.943756ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:49.182194Z","caller":"traceutil/trace.go:171","msg":"trace[235944171] linearizableReadLoop","detail":"{readStateIndex:20316; appliedIndex:20314; }","duration":"136.256655ms","start":"2026-09-07T09:10:49.045906Z","end":"2026-09-07T09:10:49.182163Z","steps":["trace[235944171] 'read index received'  (duration: 119.938039ms)","trace[235944171] 'applied index is now lower than readState.Index'  (duration: 16.317186ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T09:10:49.182265Z","caller":"traceutil/trace.go:171","msg":"trace[207093138] transaction","detail":"{read_only:false; response_revision:19638; number_of_response:1; }","duration":"129.215796ms","start":"2026-09-07T09:10:49.053011Z","end":"2026-09-07T09:10:49.182227Z","steps":["trace[207093138] 'process raft request'  (duration: 128.98608ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:49.182329Z","caller":"traceutil/trace.go:171","msg":"trace[778563583] transaction","detail":"{read_only:false; response_revision:19639; number_of_response:1; }","duration":"127.403698ms","start":"2026-09-07T09:10:49.054911Z","end":"2026-09-07T09:10:49.182315Z","steps":["trace[778563583] 'process raft request'  (duration: 127.147691ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:49.182495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.570553ms","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-07T09:10:49.182556Z","caller":"traceutil/trace.go:171","msg":"trace[1695166301] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:19639; }","duration":"136.687207ms","start":"2026-09-07T09:10:49.045847Z","end":"2026-09-07T09:10:49.182534Z","steps":["trace[1695166301] 'agreement among raft nodes before linearized reading'  (duration: 136.529082ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:49.81989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.838187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-09-07T09:10:49.819939Z","caller":"traceutil/trace.go:171","msg":"trace[1413361059] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19639; }","duration":"185.906819ms","start":"2026-09-07T09:10:49.634019Z","end":"2026-09-07T09:10:49.819926Z","steps":["trace[1413361059] 'range keys from in-memory index tree'  (duration: 185.741284ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:49.819965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.114171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"info","ts":"2026-09-07T09:10:49.819995Z","caller":"traceutil/trace.go:171","msg":"trace[956240032] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:19639; }","duration":"551.158363ms","start":"2026-09-07T09:10:49.268826Z","end":"2026-09-07T09:10:49.819985Z","steps":["trace[956240032] 'range keys from in-memory index tree'  (duration: 550.986858ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:49.820014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:10:49.268804Z","time spent":"551.205133ms","remote":"127.0.0.1:56548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5676,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-09-07T09:10:49.820043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.188687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-07T09:10:49.820099Z","caller":"traceutil/trace.go:171","msg":"trace[660419295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19639; }","duration":"303.29876ms","start":"2026-09-07T09:10:49.516787Z","end":"2026-09-07T09:10:49.820086Z","steps":["trace[660419295] 'range keys from in-memory index tree'  (duration: 303.066834ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:49.820129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:10:49.516764Z","time spent":"303.358822ms","remote":"127.0.0.1:49888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-09-07T09:10:49.819885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.558869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"}
{"level":"info","ts":"2026-09-07T09:10:49.820246Z","caller":"traceutil/trace.go:171","msg":"trace[1621160233] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:19639; }","duration":"444.945119ms","start":"2026-09-07T09:10:49.375291Z","end":"2026-09-07T09:10:49.820236Z","steps":["trace[1621160233] 'range keys from in-memory index tree'  (duration: 444.371834ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:49.820271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:10:49.375239Z","time spent":"445.024061ms","remote":"127.0.0.1:50042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":1,"response size":1874,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" "}
{"level":"info","ts":"2026-09-07T09:10:58.360053Z","caller":"traceutil/trace.go:171","msg":"trace[1353797106] transaction","detail":"{read_only:false; response_revision:19762; number_of_response:1; }","duration":"112.634135ms","start":"2026-09-07T09:10:58.247392Z","end":"2026-09-07T09:10:58.360027Z","steps":["trace[1353797106] 'process raft request'  (duration: 94.83952ms)","trace[1353797106] 'compare'  (duration: 17.058715ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T09:10:58.360474Z","caller":"traceutil/trace.go:171","msg":"trace[1555377714] transaction","detail":"{read_only:false; number_of_response:1; response_revision:19762; }","duration":"111.224647ms","start":"2026-09-07T09:10:58.249235Z","end":"2026-09-07T09:10:58.360459Z","steps":["trace[1555377714] 'process raft request'  (duration: 111.030152ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.525241Z","caller":"traceutil/trace.go:171","msg":"trace[1705331624] transaction","detail":"{read_only:false; response_revision:19764; number_of_response:1; }","duration":"244.160013ms","start":"2026-09-07T09:10:58.281059Z","end":"2026-09-07T09:10:58.525219Z","steps":["trace[1705331624] 'process raft request'  (duration: 243.993258ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.525439Z","caller":"traceutil/trace.go:171","msg":"trace[501532465] linearizableReadLoop","detail":"{readStateIndex:20446; appliedIndex:20442; }","duration":"238.156503ms","start":"2026-09-07T09:10:58.28725Z","end":"2026-09-07T09:10:58.525407Z","steps":["trace[501532465] 'read index received'  (duration: 54.959296ms)","trace[501532465] 'applied index is now lower than readState.Index'  (duration: 183.195167ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T09:10:58.525551Z","caller":"traceutil/trace.go:171","msg":"trace[1170578546] transaction","detail":"{read_only:false; response_revision:19765; number_of_response:1; }","duration":"185.96283ms","start":"2026-09-07T09:10:58.339551Z","end":"2026-09-07T09:10:58.525514Z","steps":["trace[1170578546] 'process raft request'  (duration: 185.618801ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:58.525764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.491672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2d9dbbfa-176d-4d36-a8fd-c31bf2db1e27\" ","response":"range_response_count:1 size:3639"}
{"level":"info","ts":"2026-09-07T09:10:58.525798Z","caller":"traceutil/trace.go:171","msg":"trace[1056736566] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2d9dbbfa-176d-4d36-a8fd-c31bf2db1e27; range_end:; response_count:1; response_revision:19765; }","duration":"238.569864ms","start":"2026-09-07T09:10:58.287218Z","end":"2026-09-07T09:10:58.525788Z","steps":["trace[1056736566] 'agreement among raft nodes before linearized reading'  (duration: 238.317557ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.593832Z","caller":"traceutil/trace.go:171","msg":"trace[176738612] transaction","detail":"{read_only:false; response_revision:19770; number_of_response:1; }","duration":"151.006158ms","start":"2026-09-07T09:10:58.442806Z","end":"2026-09-07T09:10:58.593812Z","steps":["trace[176738612] 'process raft request'  (duration: 150.939947ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.594185Z","caller":"traceutil/trace.go:171","msg":"trace[1741455215] transaction","detail":"{read_only:false; response_revision:19766; number_of_response:1; }","duration":"235.118452ms","start":"2026-09-07T09:10:58.359056Z","end":"2026-09-07T09:10:58.594175Z","steps":["trace[1741455215] 'process raft request'  (duration: 234.467115ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.594584Z","caller":"traceutil/trace.go:171","msg":"trace[1531648577] transaction","detail":"{read_only:false; response_revision:19767; number_of_response:1; }","duration":"226.334567ms","start":"2026-09-07T09:10:58.368035Z","end":"2026-09-07T09:10:58.59437Z","steps":["trace[1531648577] 'process raft request'  (duration: 225.584827ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.59482Z","caller":"traceutil/trace.go:171","msg":"trace[412508806] transaction","detail":"{read_only:false; response_revision:19768; number_of_response:1; }","duration":"226.643266ms","start":"2026-09-07T09:10:58.368169Z","end":"2026-09-07T09:10:58.594812Z","steps":["trace[412508806] 'process raft request'  (duration: 225.503686ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.595087Z","caller":"traceutil/trace.go:171","msg":"trace[1082691357] transaction","detail":"{read_only:false; response_revision:19769; number_of_response:1; }","duration":"222.468815ms","start":"2026-09-07T09:10:58.372609Z","end":"2026-09-07T09:10:58.595078Z","steps":["trace[1082691357] 'process raft request'  (duration: 221.098739ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:58.595593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.343864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-09-07T09:10:58.595623Z","caller":"traceutil/trace.go:171","msg":"trace[1803609819] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:19770; }","duration":"227.423676ms","start":"2026-09-07T09:10:58.36819Z","end":"2026-09-07T09:10:58.595614Z","steps":["trace[1803609819] 'agreement among raft nodes before linearized reading'  (duration: 227.289183ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:58.596166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.389448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-09-07T09:10:58.596189Z","caller":"traceutil/trace.go:171","msg":"trace[342309615] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:19770; }","duration":"115.44259ms","start":"2026-09-07T09:10:58.48074Z","end":"2026-09-07T09:10:58.596183Z","steps":["trace[342309615] 'agreement among raft nodes before linearized reading'  (duration: 115.210663ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:58.596311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.825841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-09-07T09:10:58.596332Z","caller":"traceutil/trace.go:171","msg":"trace[1300064524] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19770; }","duration":"211.870251ms","start":"2026-09-07T09:10:58.384455Z","end":"2026-09-07T09:10:58.596325Z","steps":["trace[1300064524] 'agreement among raft nodes before linearized reading'  (duration: 211.81265ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.772845Z","caller":"traceutil/trace.go:171","msg":"trace[336081438] transaction","detail":"{read_only:false; response_revision:19771; number_of_response:1; }","duration":"241.107302ms","start":"2026-09-07T09:10:58.531698Z","end":"2026-09-07T09:10:58.772805Z","steps":["trace[336081438] 'process raft request'  (duration: 240.617629ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.779414Z","caller":"traceutil/trace.go:171","msg":"trace[1866978305] linearizableReadLoop","detail":"{readStateIndex:20454; appliedIndex:20452; }","duration":"177.076313ms","start":"2026-09-07T09:10:58.602317Z","end":"2026-09-07T09:10:58.779393Z","steps":["trace[1866978305] 'read index received'  (duration: 169.978904ms)","trace[1866978305] 'applied index is now lower than readState.Index'  (duration: 7.096259ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T09:10:58.779564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.206947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-07T09:10:58.779612Z","caller":"traceutil/trace.go:171","msg":"trace[256469153] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19771; }","duration":"177.3109ms","start":"2026-09-07T09:10:58.602287Z","end":"2026-09-07T09:10:58.779598Z","steps":["trace[256469153] 'agreement among raft nodes before linearized reading'  (duration: 177.205597ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.782231Z","caller":"traceutil/trace.go:171","msg":"trace[2054720178] transaction","detail":"{read_only:false; response_revision:19774; number_of_response:1; }","duration":"175.948403ms","start":"2026-09-07T09:10:58.606253Z","end":"2026-09-07T09:10:58.782201Z","steps":["trace[2054720178] 'process raft request'  (duration: 175.889952ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:58.782319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.281342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-zlld8-vnc\" ","response":"range_response_count:1 size:2048"}
{"level":"warn","ts":"2026-09-07T09:10:58.782334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.693144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-cd4cd10f-2fde-4063-a5ac-8f201ece420e\" ","response":"range_response_count:1 size:1323"}
{"level":"info","ts":"2026-09-07T09:10:58.782359Z","caller":"traceutil/trace.go:171","msg":"trace[1171425468] range","detail":"{range_begin:/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-zlld8-vnc; range_end:; response_count:1; response_revision:19774; }","duration":"176.327023ms","start":"2026-09-07T09:10:58.606018Z","end":"2026-09-07T09:10:58.782345Z","steps":["trace[1171425468] 'agreement among raft nodes before linearized reading'  (duration: 176.19444ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.782377Z","caller":"traceutil/trace.go:171","msg":"trace[970510208] transaction","detail":"{read_only:false; response_revision:19773; number_of_response:1; }","duration":"178.334817ms","start":"2026-09-07T09:10:58.604026Z","end":"2026-09-07T09:10:58.782361Z","steps":["trace[970510208] 'process raft request'  (duration: 178.062969ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.782415Z","caller":"traceutil/trace.go:171","msg":"trace[971282157] range","detail":"{range_begin:/registry/persistentvolumes/pvc-cd4cd10f-2fde-4063-a5ac-8f201ece420e; range_end:; response_count:1; response_revision:19774; }","duration":"179.837997ms","start":"2026-09-07T09:10:58.602549Z","end":"2026-09-07T09:10:58.782387Z","steps":["trace[971282157] 'agreement among raft nodes before linearized reading'  (duration: 179.630032ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:58.782437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.631515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-zlld8-api\" ","response":"range_response_count:1 size:2048"}
{"level":"warn","ts":"2026-09-07T09:10:58.782357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.279942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1125"}
{"level":"info","ts":"2026-09-07T09:10:58.782482Z","caller":"traceutil/trace.go:171","msg":"trace[1121027311] range","detail":"{range_begin:/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-zlld8-api; range_end:; response_count:1; response_revision:19774; }","duration":"175.710378ms","start":"2026-09-07T09:10:58.606756Z","end":"2026-09-07T09:10:58.782466Z","steps":["trace[1121027311] 'agreement among raft nodes before linearized reading'  (duration: 175.595174ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.782538Z","caller":"traceutil/trace.go:171","msg":"trace[468845281] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:19774; }","duration":"176.457217ms","start":"2026-09-07T09:10:58.606049Z","end":"2026-09-07T09:10:58.782506Z","steps":["trace[468845281] 'agreement among raft nodes before linearized reading'  (duration: 176.168699ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:10:58.782767Z","caller":"traceutil/trace.go:171","msg":"trace[1143280091] transaction","detail":"{read_only:false; response_revision:19772; number_of_response:1; }","duration":"180.210937ms","start":"2026-09-07T09:10:58.602534Z","end":"2026-09-07T09:10:58.782745Z","steps":["trace[1143280091] 'process raft request'  (duration: 179.404905ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:58.782974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.869548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:963186"}
{"level":"info","ts":"2026-09-07T09:10:58.782996Z","caller":"traceutil/trace.go:171","msg":"trace[382837688] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:19774; }","duration":"176.924259ms","start":"2026-09-07T09:10:58.606065Z","end":"2026-09-07T09:10:58.78299Z","steps":["trace[382837688] 'agreement among raft nodes before linearized reading'  (duration: 176.317563ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:10:58.784211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.595741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1125"}
{"level":"info","ts":"2026-09-07T09:10:58.784291Z","caller":"traceutil/trace.go:171","msg":"trace[1406464271] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:19774; }","duration":"179.692884ms","start":"2026-09-07T09:10:58.604575Z","end":"2026-09-07T09:10:58.784267Z","steps":["trace[1406464271] 'agreement among raft nodes before linearized reading'  (duration: 179.465938ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:14:09.877562Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18986}
{"level":"info","ts":"2026-09-07T09:14:09.98716Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18986,"took":"104.314882ms","hash":2961580461,"current-db-size-bytes":48484352,"current-db-size":"48 MB","current-db-size-in-use-bytes":33849344,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-09-07T09:14:09.987314Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2961580461,"revision":18986,"compact-revision":16764}
{"level":"info","ts":"2026-09-07T09:17:16.324481Z","caller":"traceutil/trace.go:171","msg":"trace[1311339313] transaction","detail":"{read_only:false; response_revision:22557; number_of_response:1; }","duration":"107.749141ms","start":"2026-09-07T09:17:16.216707Z","end":"2026-09-07T09:17:16.324457Z","steps":["trace[1311339313] 'process raft request'  (duration: 107.593857ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:17:16.622364Z","caller":"traceutil/trace.go:171","msg":"trace[627054596] linearizableReadLoop","detail":"{readStateIndex:23334; appliedIndex:23333; }","duration":"103.713696ms","start":"2026-09-07T09:17:16.518618Z","end":"2026-09-07T09:17:16.622332Z","steps":["trace[627054596] 'read index received'  (duration: 103.510831ms)","trace[627054596] 'applied index is now lower than readState.Index'  (duration: 201.525µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T09:17:16.62258Z","caller":"traceutil/trace.go:171","msg":"trace[125398874] transaction","detail":"{read_only:false; response_revision:22558; number_of_response:1; }","duration":"384.484454ms","start":"2026-09-07T09:17:16.23808Z","end":"2026-09-07T09:17:16.622564Z","steps":["trace[125398874] 'process raft request'  (duration: 384.089094ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:17:16.622747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:17:16.238055Z","time spent":"384.612098ms","remote":"127.0.0.1:49948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1376,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/events/openstack/neutron-dhcp-agent-default-psjs4.18d2ff3c3eb3c046\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/neutron-dhcp-agent-default-psjs4.18d2ff3c3eb3c046\" value_size:1282 lease:5482183096495933612 >> failure:<>"}
{"level":"warn","ts":"2026-09-07T09:17:16.623099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.476506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-07T09:17:16.623223Z","caller":"traceutil/trace.go:171","msg":"trace[289693542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22558; }","duration":"104.6287ms","start":"2026-09-07T09:17:16.518554Z","end":"2026-09-07T09:17:16.623182Z","steps":["trace[289693542] 'agreement among raft nodes before linearized reading'  (duration: 104.270381ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:17:32.24395Z","caller":"traceutil/trace.go:171","msg":"trace[794914935] transaction","detail":"{read_only:false; response_revision:22637; number_of_response:1; }","duration":"174.351123ms","start":"2026-09-07T09:17:32.069575Z","end":"2026-09-07T09:17:32.243926Z","steps":["trace[794914935] 'process raft request'  (duration: 138.915422ms)","trace[794914935] 'compare'  (duration: 35.180624ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T09:17:37.858209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.565706ms","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:8"}
{"level":"warn","ts":"2026-09-07T09:17:37.858292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.919959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-07T09:17:37.858311Z","caller":"traceutil/trace.go:171","msg":"trace[1847730904] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:22665; }","duration":"102.7166ms","start":"2026-09-07T09:17:37.755573Z","end":"2026-09-07T09:17:37.858289Z","steps":["trace[1847730904] 'count revisions from in-memory index tree'  (duration: 102.487614ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:17:37.858347Z","caller":"traceutil/trace.go:171","msg":"trace[885555189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22665; }","duration":"342.007901ms","start":"2026-09-07T09:17:37.516322Z","end":"2026-09-07T09:17:37.85833Z","steps":["trace[885555189] 'range keys from in-memory index tree'  (duration: 341.781535ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:17:37.858378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:17:37.516302Z","time spent":"342.066983ms","remote":"127.0.0.1:49888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-07T09:17:37.905099Z","caller":"traceutil/trace.go:171","msg":"trace[325914698] transaction","detail":"{read_only:false; response_revision:22666; number_of_response:1; }","duration":"128.159782ms","start":"2026-09-07T09:17:37.776905Z","end":"2026-09-07T09:17:37.905064Z","steps":["trace[325914698] 'process raft request'  (duration: 127.884235ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:17:38.196402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.1805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-09-07T09:17:38.196514Z","caller":"traceutil/trace.go:171","msg":"trace[2003074020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22666; }","duration":"106.347034ms","start":"2026-09-07T09:17:38.090147Z","end":"2026-09-07T09:17:38.196494Z","steps":["trace[2003074020] 'range keys from in-memory index tree'  (duration: 105.976805ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:17:38.588064Z","caller":"traceutil/trace.go:171","msg":"trace[1152067698] transaction","detail":"{read_only:false; response_revision:22668; number_of_response:1; }","duration":"319.883246ms","start":"2026-09-07T09:17:38.268155Z","end":"2026-09-07T09:17:38.588038Z","steps":["trace[1152067698] 'process raft request'  (duration: 319.745193ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:17:38.588233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:17:38.268133Z","time spent":"320.006519ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:22658 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-09-07T09:17:38.593168Z","caller":"traceutil/trace.go:171","msg":"trace[553570175] linearizableReadLoop","detail":"{readStateIndex:23449; appliedIndex:23448; }","duration":"142.450814ms","start":"2026-09-07T09:17:38.450676Z","end":"2026-09-07T09:17:38.593127Z","steps":["trace[553570175] 'read index received'  (duration: 137.347451ms)","trace[553570175] 'applied index is now lower than readState.Index'  (duration: 5.101363ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T09:17:38.5933Z","caller":"traceutil/trace.go:171","msg":"trace[903216868] transaction","detail":"{read_only:false; response_revision:22669; number_of_response:1; }","duration":"186.044177ms","start":"2026-09-07T09:17:38.407242Z","end":"2026-09-07T09:17:38.593286Z","steps":["trace[903216868] 'process raft request'  (duration: 185.668607ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:17:38.593469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.776132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-07T09:17:38.593536Z","caller":"traceutil/trace.go:171","msg":"trace[916217107] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:22669; }","duration":"142.880745ms","start":"2026-09-07T09:17:38.450627Z","end":"2026-09-07T09:17:38.593508Z","steps":["trace[916217107] 'agreement among raft nodes before linearized reading'  (duration: 142.746481ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:17:39.091315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.320448ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14705555133350709878 > lease_revoke:<id:4c14a07afc4a89ad>","response":"size:30"}
{"level":"info","ts":"2026-09-07T09:17:39.09152Z","caller":"traceutil/trace.go:171","msg":"trace[799591832] linearizableReadLoop","detail":"{readStateIndex:23450; appliedIndex:23449; }","duration":"432.012101ms","start":"2026-09-07T09:17:38.65949Z","end":"2026-09-07T09:17:39.091502Z","steps":["trace[799591832] 'read index received'  (duration: 106.474428ms)","trace[799591832] 'applied index is now lower than readState.Index'  (duration: 325.535933ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T09:17:39.091626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.126714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-07T09:17:39.091663Z","caller":"traceutil/trace.go:171","msg":"trace[171773776] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:22669; }","duration":"432.213446ms","start":"2026-09-07T09:17:38.659441Z","end":"2026-09-07T09:17:39.091654Z","steps":["trace[171773776] 'agreement among raft nodes before linearized reading'  (duration: 432.133854ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:17:39.091685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:17:38.659417Z","time spent":"432.260978ms","remote":"127.0.0.1:50042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":13,"response size":32,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"info","ts":"2026-09-07T09:17:39.091791Z","caller":"traceutil/trace.go:171","msg":"trace[940186369] transaction","detail":"{read_only:false; response_revision:22671; number_of_response:1; }","duration":"222.444403ms","start":"2026-09-07T09:17:38.869335Z","end":"2026-09-07T09:17:39.091779Z","steps":["trace[940186369] 'process raft request'  (duration: 222.29699ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:17:39.091905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.825724ms","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-07T09:17:39.09194Z","caller":"traceutil/trace.go:171","msg":"trace[849411734] transaction","detail":"{read_only:false; response_revision:22670; number_of_response:1; }","duration":"243.445188ms","start":"2026-09-07T09:17:38.848487Z","end":"2026-09-07T09:17:39.091932Z","steps":["trace[849411734] 'process raft request'  (duration: 242.972636ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:17:39.09199Z","caller":"traceutil/trace.go:171","msg":"trace[1224199556] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22671; }","duration":"294.910057ms","start":"2026-09-07T09:17:38.797038Z","end":"2026-09-07T09:17:39.091948Z","steps":["trace[1224199556] 'agreement among raft nodes before linearized reading'  (duration: 294.734902ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:17:39.092032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.372133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-07T09:17:39.092063Z","caller":"traceutil/trace.go:171","msg":"trace[480754329] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:22671; }","duration":"164.447795ms","start":"2026-09-07T09:17:38.927608Z","end":"2026-09-07T09:17:39.092055Z","steps":["trace[480754329] 'agreement among raft nodes before linearized reading'  (duration: 164.400363ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:17:39.092294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.464319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-09-07T09:17:39.092339Z","caller":"traceutil/trace.go:171","msg":"trace[709303083] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22671; }","duration":"173.557313ms","start":"2026-09-07T09:17:38.918769Z","end":"2026-09-07T09:17:39.092327Z","steps":["trace[709303083] 'agreement among raft nodes before linearized reading'  (duration: 173.433929ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:19:09.888735Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21278}
{"level":"info","ts":"2026-09-07T09:19:10.004445Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21278,"took":"112.715702ms","hash":3681277723,"current-db-size-bytes":48484352,"current-db-size":"48 MB","current-db-size-in-use-bytes":28905472,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-09-07T09:19:10.004533Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3681277723,"revision":21278,"compact-revision":18986}
{"level":"info","ts":"2026-09-07T09:22:14.94424Z","caller":"traceutil/trace.go:171","msg":"trace[773744546] linearizableReadLoop","detail":"{readStateIndex:26199; appliedIndex:26198; }","duration":"223.694667ms","start":"2026-09-07T09:22:14.720518Z","end":"2026-09-07T09:22:14.944213Z","steps":["trace[773744546] 'read index received'  (duration: 223.533842ms)","trace[773744546] 'applied index is now lower than readState.Index'  (duration: 159.405µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T09:22:14.944415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.889642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-07T09:22:14.944461Z","caller":"traceutil/trace.go:171","msg":"trace[989418573] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:25339; }","duration":"224.001615ms","start":"2026-09-07T09:22:14.720445Z","end":"2026-09-07T09:22:14.944447Z","steps":["trace[989418573] 'agreement among raft nodes before linearized reading'  (duration: 223.903652ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:22:14.944345Z","caller":"traceutil/trace.go:171","msg":"trace[1694022820] transaction","detail":"{read_only:false; response_revision:25339; number_of_response:1; }","duration":"241.924972ms","start":"2026-09-07T09:22:14.702381Z","end":"2026-09-07T09:22:14.944306Z","steps":["trace[1694022820] 'process raft request'  (duration: 241.583163ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:22:14.953149Z","caller":"traceutil/trace.go:171","msg":"trace[320066067] transaction","detail":"{read_only:false; response_revision:25340; number_of_response:1; }","duration":"188.375736ms","start":"2026-09-07T09:22:14.764717Z","end":"2026-09-07T09:22:14.953093Z","steps":["trace[320066067] 'process raft request'  (duration: 188.081378ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T09:22:14.953203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.011931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-07T09:22:14.953313Z","caller":"traceutil/trace.go:171","msg":"trace[1294601626] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25340; }","duration":"160.121374ms","start":"2026-09-07T09:22:14.793118Z","end":"2026-09-07T09:22:14.95324Z","steps":["trace[1294601626] 'agreement among raft nodes before linearized reading'  (duration: 159.854087ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:23:33.916252Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000069b4.wal"}
{"level":"info","ts":"2026-09-07T09:23:45.7063Z","caller":"traceutil/trace.go:171","msg":"trace[1069156553] transaction","detail":"{read_only:false; response_revision:26290; number_of_response:1; }","duration":"114.93063ms","start":"2026-09-07T09:23:45.59134Z","end":"2026-09-07T09:23:45.70627Z","steps":["trace[1069156553] 'process raft request'  (duration: 114.765246ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T09:24:09.897107Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23431}
{"level":"info","ts":"2026-09-07T09:24:10.016571Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23431,"took":"115.333122ms","hash":2910525704,"current-db-size-bytes":52178944,"current-db-size":"52 MB","current-db-size-in-use-bytes":43597824,"current-db-size-in-use":"44 MB"}
{"level":"info","ts":"2026-09-07T09:24:10.017129Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2910525704,"revision":23431,"compact-revision":21278}
{"level":"info","ts":"2026-09-07T09:29:09.918615Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26481}
{"level":"info","ts":"2026-09-07T09:29:10.062576Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26481,"took":"141.064926ms","hash":533283625,"current-db-size-bytes":52178944,"current-db-size":"52 MB","current-db-size-in-use-bytes":31236096,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-07T09:29:10.062642Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":533283625,"revision":26481,"compact-revision":23431}
{"level":"info","ts":"2026-09-07T09:29:53.350772Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c665390cd9eacc14","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-07T09:29:53.35753Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-09-07T09:29:53.357661Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}