{"level":"warn","ts":"2026-07-14T16:54:11.580206Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-14T16:54:11.580294Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.250:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.250:2380","--initial-cluster=instance=https://199.19.213.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.250: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-07-14T16:54:11.580356Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-14T16:54:11.580367Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.250:2380"]}
{"level":"info","ts":"2026-07-14T16:54:11.580386Z","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-07-14T16:54:11.581497Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"]}
{"level":"info","ts":"2026-07-14T16:54:11.581579Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.250:2380"],"listen-peer-urls":["https://199.19.213.250:2380"],"advertise-client-urls":["https://199.19.213.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.250: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-07-14T16:54:11.587833Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.060686ms"}
{"level":"info","ts":"2026-07-14T16:54:11.597229Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1918dd9317ae83a2","cluster-id":"1b9b645507bfe47a"}
{"level":"info","ts":"2026-07-14T16:54:11.597352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=()"}
{"level":"info","ts":"2026-07-14T16:54:11.597387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became follower at term 0"}
{"level":"info","ts":"2026-07-14T16:54:11.597407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1918dd9317ae83a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-07-14T16:54:11.597505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became follower at term 1"}
{"level":"info","ts":"2026-07-14T16:54:11.59757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=(1808438874216498082)"}
{"level":"warn","ts":"2026-07-14T16:54:11.604498Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-07-14T16:54:11.606124Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-07-14T16:54:11.60741Z","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-07-14T16:54:11.610599Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1918dd9317ae83a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-07-14T16:54:11.611863Z","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-07-14T16:54:11.611917Z","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-07-14T16:54:11.611928Z","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-07-14T16:54:11.611797Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1918dd9317ae83a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-07-14T16:54:11.61493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 switched to configuration voters=(1808438874216498082)"}
{"level":"info","ts":"2026-07-14T16:54:11.618803Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1b9b645507bfe47a","local-member-id":"1918dd9317ae83a2","added-peer-id":"1918dd9317ae83a2","added-peer-peer-urls":["https://199.19.213.250:2380"]}
{"level":"info","ts":"2026-07-14T16:54:11.62095Z","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-07-14T16:54:11.621251Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1918dd9317ae83a2","initial-advertise-peer-urls":["https://199.19.213.250:2380"],"listen-peer-urls":["https://199.19.213.250:2380"],"advertise-client-urls":["https://199.19.213.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-07-14T16:54:11.621283Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-07-14T16:54:11.621432Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.250:2380"}
{"level":"info","ts":"2026-07-14T16:54:11.621468Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.250:2380"}
{"level":"info","ts":"2026-07-14T16:54:11.897907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 is starting a new election at term 1"}
{"level":"info","ts":"2026-07-14T16:54:11.898017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became pre-candidate at term 1"}
{"level":"info","ts":"2026-07-14T16:54:11.898065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 received MsgPreVoteResp from 1918dd9317ae83a2 at term 1"}
{"level":"info","ts":"2026-07-14T16:54:11.898092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became candidate at term 2"}
{"level":"info","ts":"2026-07-14T16:54:11.898103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 received MsgVoteResp from 1918dd9317ae83a2 at term 2"}
{"level":"info","ts":"2026-07-14T16:54:11.898119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1918dd9317ae83a2 became leader at term 2"}
{"level":"info","ts":"2026-07-14T16:54:11.898133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1918dd9317ae83a2 elected leader 1918dd9317ae83a2 at term 2"}
{"level":"info","ts":"2026-07-14T16:54:11.899408Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-14T16:54:11.90034Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1918dd9317ae83a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.250:2379]}","request-path":"/0/members/1918dd9317ae83a2/attributes","cluster-id":"1b9b645507bfe47a","publish-timeout":"7s"}
{"level":"info","ts":"2026-07-14T16:54:11.900482Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-14T16:54:11.900538Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-14T16:54:11.900708Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1b9b645507bfe47a","local-member-id":"1918dd9317ae83a2","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-14T16:54:11.900828Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-14T16:54:11.90086Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-14T16:54:11.901187Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-07-14T16:54:11.901218Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-07-14T16:54:11.90376Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-07-14T16:54:11.903824Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.250:2379"}
{"level":"info","ts":"2026-07-14T16:54:37.274848Z","caller":"traceutil/trace.go:171","msg":"trace[1081283116] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"273.721956ms","start":"2026-07-14T16:54:37.001095Z","end":"2026-07-14T16:54:37.274817Z","steps":["trace[1081283116] 'process raft request'  (duration: 272.520278ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:54:44.219137Z","caller":"traceutil/trace.go:171","msg":"trace[126257446] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"200.343477ms","start":"2026-07-14T16:54:44.018766Z","end":"2026-07-14T16:54:44.21911Z","steps":["trace[126257446] 'process raft request'  (duration: 200.208346ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:54:58.654588Z","caller":"traceutil/trace.go:171","msg":"trace[722271169] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"378.23289ms","start":"2026-07-14T16:54:58.276336Z","end":"2026-07-14T16:54:58.654569Z","steps":["trace[722271169] 'read index received'  (duration: 378.139186ms)","trace[722271169] 'applied index is now lower than readState.Index'  (duration: 92.894µs)"],"step_count":2}
{"level":"info","ts":"2026-07-14T16:54:58.654669Z","caller":"traceutil/trace.go:171","msg":"trace[778928398] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"786.507587ms","start":"2026-07-14T16:54:57.86812Z","end":"2026-07-14T16:54:58.654628Z","steps":["trace[778928398] 'process raft request'  (duration: 786.327689ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:54:58.654821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.461691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-07-14T16:54:58.654878Z","caller":"traceutil/trace.go:171","msg":"trace[1575056934] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"378.565615ms","start":"2026-07-14T16:54:58.276301Z","end":"2026-07-14T16:54:58.654867Z","steps":["trace[1575056934] 'agreement among raft nodes before linearized reading'  (duration: 378.385137ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:54:58.654905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:54:58.276286Z","time spent":"378.612428ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-07-14T16:54:58.655324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:54:57.868097Z","time spent":"786.655204ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:489 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-07-14T16:54:59.142705Z","caller":"traceutil/trace.go:171","msg":"trace[870935974] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"115.326243ms","start":"2026-07-14T16:54:59.027341Z","end":"2026-07-14T16:54:59.142667Z","steps":["trace[870935974] 'process raft request'  (duration: 115.170754ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:55:05.032031Z","caller":"traceutil/trace.go:171","msg":"trace[934841011] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"327.76155ms","start":"2026-07-14T16:55:04.704237Z","end":"2026-07-14T16:55:05.031999Z","steps":["trace[934841011] 'process raft request'  (duration: 327.578082ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:55:05.031987Z","caller":"traceutil/trace.go:171","msg":"trace[2099589335] linearizableReadLoop","detail":"{readStateIndex:689; appliedIndex:688; }","duration":"171.712771ms","start":"2026-07-14T16:55:04.860249Z","end":"2026-07-14T16:55:05.031962Z","steps":["trace[2099589335] 'read index received'  (duration: 171.47288ms)","trace[2099589335] 'applied index is now lower than readState.Index'  (duration: 238.941µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T16:55:05.032209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:04.704222Z","time spent":"327.895416ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:650 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-07-14T16:55:05.032331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.039535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-d4jvm\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-07-14T16:55:05.032422Z","caller":"traceutil/trace.go:171","msg":"trace[277690836] range","detail":"{range_begin:/registry/pods/kube-system/cilium-d4jvm; range_end:; response_count:1; response_revision:664; }","duration":"172.194102ms","start":"2026-07-14T16:55:04.860207Z","end":"2026-07-14T16:55:05.032401Z","steps":["trace[277690836] 'agreement among raft nodes before linearized reading'  (duration: 171.91787ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:05.662467Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9485319006520185461,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-07-14T16:55:05.762945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:05.03694Z","time spent":"726.001965ms","remote":"127.0.0.1:60112","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-07-14T16:55:06.565531Z","caller":"traceutil/trace.go:171","msg":"trace[565057819] linearizableReadLoop","detail":"{readStateIndex:691; appliedIndex:689; }","duration":"1.404089234s","start":"2026-07-14T16:55:05.161413Z","end":"2026-07-14T16:55:06.565502Z","steps":["trace[565057819] 'read index received'  (duration: 601.498981ms)","trace[565057819] 'applied index is now lower than readState.Index'  (duration: 802.588803ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T16:55:06.565611Z","caller":"traceutil/trace.go:171","msg":"trace[1789616860] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"1.518944785s","start":"2026-07-14T16:55:05.046637Z","end":"2026-07-14T16:55:06.565582Z","steps":["trace[1789616860] 'process raft request'  (duration: 1.518701145s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:06.565765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.404342615s","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-07-14T16:55:06.565791Z","caller":"traceutil/trace.go:171","msg":"trace[2066920213] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:665; }","duration":"1.404424079s","start":"2026-07-14T16:55:05.161361Z","end":"2026-07-14T16:55:06.565785Z","steps":["trace[2066920213] 'agreement among raft nodes before linearized reading'  (duration: 1.404294434s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:06.565818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:05.161342Z","time spent":"1.40447165s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-07-14T16:55:06.566317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:05.046592Z","time spent":"1.519233298s","remote":"127.0.0.1:60256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-d4jvm\" mod_revision:538 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-d4jvm\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-d4jvm\" > >"}
{"level":"warn","ts":"2026-07-14T16:55:06.704148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"968.010054ms","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-07-14T16:55:06.704228Z","caller":"traceutil/trace.go:171","msg":"trace[1953483128] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"940.150152ms","start":"2026-07-14T16:55:05.764063Z","end":"2026-07-14T16:55:06.704213Z","steps":["trace[1953483128] 'process raft request'  (duration: 852.759629ms)","trace[1953483128] 'compare'  (duration: 87.004686ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T16:55:06.704261Z","caller":"traceutil/trace.go:171","msg":"trace[788250675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:666; }","duration":"968.166161ms","start":"2026-07-14T16:55:05.736072Z","end":"2026-07-14T16:55:06.704238Z","steps":["trace[788250675] 'agreement among raft nodes before linearized reading'  (duration: 967.891739ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:06.704152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"968.621291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-07-14T16:55:06.70447Z","caller":"traceutil/trace.go:171","msg":"trace[1883889531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:666; }","duration":"969.016228ms","start":"2026-07-14T16:55:05.735446Z","end":"2026-07-14T16:55:06.704462Z","steps":["trace[1883889531] 'agreement among raft nodes before linearized reading'  (duration: 968.538307ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:06.704529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:05.735423Z","time spent":"969.07148ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-07-14T16:55:06.704535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.117236003s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-07-14T16:55:06.704349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:05.764044Z","time spent":"940.258487ms","remote":"127.0.0.1:60112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.19.213.250\" mod_revision:542 > success:<request_put:<key:\"/registry/masterleases/199.19.213.250\" value_size:67 lease:261946969665409654 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.250\" > >"}
{"level":"warn","ts":"2026-07-14T16:55:06.704533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:05.736049Z","time spent":"968.472934ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-07-14T16:55:06.704623Z","caller":"traceutil/trace.go:171","msg":"trace[1588142941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:666; }","duration":"1.117361359s","start":"2026-07-14T16:55:05.587234Z","end":"2026-07-14T16:55:06.704596Z","steps":["trace[1588142941] 'agreement among raft nodes before linearized reading'  (duration: 1.117207613s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:06.704742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:05.587215Z","time spent":"1.117517646s","remote":"127.0.0.1:60096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-07-14T16:55:06.70516Z","caller":"traceutil/trace.go:171","msg":"trace[1299099266] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:691; }","duration":"138.246049ms","start":"2026-07-14T16:55:06.565701Z","end":"2026-07-14T16:55:06.703947Z","steps":["trace[1299099266] 'read index received'  (duration: 51.131069ms)","trace[1299099266] 'applied index is now lower than readState.Index'  (duration: 87.114129ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T16:55:06.729461Z","caller":"traceutil/trace.go:171","msg":"trace[2012856407] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"158.228456ms","start":"2026-07-14T16:55:06.571209Z","end":"2026-07-14T16:55:06.729438Z","steps":["trace[2012856407] 'process raft request'  (duration: 158.08195ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:07.841121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.919973ms","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-07-14T16:55:07.841185Z","caller":"traceutil/trace.go:171","msg":"trace[1769275702] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:669; }","duration":"805.025528ms","start":"2026-07-14T16:55:07.036144Z","end":"2026-07-14T16:55:07.841169Z","steps":["trace[1769275702] 'range keys from in-memory index tree'  (duration: 804.682412ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:07.841213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:07.036123Z","time spent":"805.08308ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-07-14T16:55:08.517743Z","caller":"traceutil/trace.go:171","msg":"trace[582780787] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"672.369125ms","start":"2026-07-14T16:55:07.845342Z","end":"2026-07-14T16:55:08.517711Z","steps":["trace[582780787] 'process raft request'  (duration: 672.176937ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:08.518013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:07.845326Z","time spent":"672.595094ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:664 > 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-07-14T16:55:10.025805Z","caller":"traceutil/trace.go:171","msg":"trace[1902655170] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"134.900684ms","start":"2026-07-14T16:55:09.890886Z","end":"2026-07-14T16:55:10.025787Z","steps":["trace[1902655170] 'process raft request'  (duration: 134.456736ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:55:11.548418Z","caller":"traceutil/trace.go:171","msg":"trace[1187194803] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"472.886195ms","start":"2026-07-14T16:55:11.075506Z","end":"2026-07-14T16:55:11.548393Z","steps":["trace[1187194803] 'process raft request'  (duration: 472.730429ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:11.548605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:11.075484Z","time spent":"473.044682ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" value_size:8170 >> failure:<>"}
{"level":"info","ts":"2026-07-14T16:55:11.553731Z","caller":"traceutil/trace.go:171","msg":"trace[214891212] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"277.585973ms","start":"2026-07-14T16:55:11.276125Z","end":"2026-07-14T16:55:11.553711Z","steps":["trace[214891212] 'process raft request'  (duration: 277.035391ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:13.204559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.413834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"}
{"level":"info","ts":"2026-07-14T16:55:13.20464Z","caller":"traceutil/trace.go:171","msg":"trace[397173314] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:734; }","duration":"131.5465ms","start":"2026-07-14T16:55:13.073073Z","end":"2026-07-14T16:55:13.204619Z","steps":["trace[397173314] 'range keys from in-memory index tree'  (duration: 131.245288ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:55:21.078426Z","caller":"traceutil/trace.go:171","msg":"trace[190260194] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:837; }","duration":"273.594854ms","start":"2026-07-14T16:55:20.804764Z","end":"2026-07-14T16:55:21.078359Z","steps":["trace[190260194] 'read index received'  (duration: 273.416518ms)","trace[190260194] 'applied index is now lower than readState.Index'  (duration: 177.046µs)"],"step_count":2}
{"level":"info","ts":"2026-07-14T16:55:21.078601Z","caller":"traceutil/trace.go:171","msg":"trace[673612336] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"281.055831ms","start":"2026-07-14T16:55:20.79753Z","end":"2026-07-14T16:55:21.078586Z","steps":["trace[673612336] 'process raft request'  (duration: 280.669767ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:21.078856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.074821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-07-14T16:55:21.078912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.465559ms","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-07-14T16:55:21.078931Z","caller":"traceutil/trace.go:171","msg":"trace[1617504098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:808; }","duration":"274.170125ms","start":"2026-07-14T16:55:20.804742Z","end":"2026-07-14T16:55:21.078912Z","steps":["trace[1617504098] 'agreement among raft nodes before linearized reading'  (duration: 274.01771ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:55:21.078986Z","caller":"traceutil/trace.go:171","msg":"trace[416346125] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:808; }","duration":"129.588853ms","start":"2026-07-14T16:55:20.949381Z","end":"2026-07-14T16:55:21.07897Z","steps":["trace[416346125] 'agreement among raft nodes before linearized reading'  (duration: 129.434268ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:21.079117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.849313ms","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-07-14T16:55:21.0792Z","caller":"traceutil/trace.go:171","msg":"trace[209196348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:808; }","duration":"274.278319ms","start":"2026-07-14T16:55:20.804871Z","end":"2026-07-14T16:55:21.079149Z","steps":["trace[209196348] 'agreement among raft nodes before linearized reading'  (duration: 273.75662ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:24.623975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.035963541s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T16:55:24.624205Z","caller":"traceutil/trace.go:171","msg":"trace[382865643] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:825; }","duration":"1.036278862s","start":"2026-07-14T16:55:23.587896Z","end":"2026-07-14T16:55:24.624175Z","steps":["trace[382865643] 'range keys from in-memory index tree'  (duration: 1.035857678s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:24.624449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:23.587866Z","time spent":"1.036435017s","remote":"127.0.0.1:60096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-07-14T16:55:24.62484Z","caller":"traceutil/trace.go:171","msg":"trace[1173142797] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"644.563241ms","start":"2026-07-14T16:55:23.980243Z","end":"2026-07-14T16:55:24.624806Z","steps":["trace[1173142797] 'process raft request'  (duration: 644.334953ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:24.625449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:23.980215Z","time spent":"644.861692ms","remote":"127.0.0.1:60316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:655 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2707 >> failure:<request_range:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" > >"}
{"level":"info","ts":"2026-07-14T16:55:24.79134Z","caller":"traceutil/trace.go:171","msg":"trace[1369135212] linearizableReadLoop","detail":"{readStateIndex:858; appliedIndex:856; }","duration":"209.165069ms","start":"2026-07-14T16:55:24.582151Z","end":"2026-07-14T16:55:24.791316Z","steps":["trace[1369135212] 'read index received'  (duration: 42.262721ms)","trace[1369135212] 'applied index is now lower than readState.Index'  (duration: 166.901308ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T16:55:24.791659Z","caller":"traceutil/trace.go:171","msg":"trace[1733935447] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"333.517775ms","start":"2026-07-14T16:55:24.458129Z","end":"2026-07-14T16:55:24.791647Z","steps":["trace[1733935447] 'process raft request'  (duration: 327.917336ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:24.791772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:24.458106Z","time spent":"333.593558ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:747 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-07-14T16:55:24.792058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.914975ms","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-07-14T16:55:24.792106Z","caller":"traceutil/trace.go:171","msg":"trace[1267691201] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:827; }","duration":"209.965057ms","start":"2026-07-14T16:55:24.582131Z","end":"2026-07-14T16:55:24.792096Z","steps":["trace[1267691201] 'agreement among raft nodes before linearized reading'  (duration: 209.815922ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:24.792209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.39973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T16:55:24.792614Z","caller":"traceutil/trace.go:171","msg":"trace[91739935] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:827; }","duration":"166.870877ms","start":"2026-07-14T16:55:24.625703Z","end":"2026-07-14T16:55:24.792574Z","steps":["trace[91739935] 'agreement among raft nodes before linearized reading'  (duration: 166.357988ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:56.327253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.055684529s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-14T16:55:56.327396Z","caller":"traceutil/trace.go:171","msg":"trace[1862235553] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1229; }","duration":"1.055883024s","start":"2026-07-14T16:55:55.271489Z","end":"2026-07-14T16:55:56.327372Z","steps":["trace[1862235553] 'count revisions from in-memory index tree'  (duration: 1.055538504s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:56.327462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:55.271469Z","time spent":"1.055976317s","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":37,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "}
{"level":"warn","ts":"2026-07-14T16:55:56.327518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024000277s","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-07-14T16:55:56.3276Z","caller":"traceutil/trace.go:171","msg":"trace[811773630] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1229; }","duration":"1.024120679s","start":"2026-07-14T16:55:55.303462Z","end":"2026-07-14T16:55:56.327583Z","steps":["trace[811773630] 'range keys from in-memory index tree'  (duration: 1.023856032s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:56.327648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:55.303449Z","time spent":"1.024190472s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-07-14T16:55:56.327913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028969618s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-07-14T16:55:56.327909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026161695s","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-07-14T16:55:56.327951Z","caller":"traceutil/trace.go:171","msg":"trace[1350894439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1229; }","duration":"1.02904714s","start":"2026-07-14T16:55:55.298895Z","end":"2026-07-14T16:55:56.327942Z","steps":["trace[1350894439] 'range keys from in-memory index tree'  (duration: 1.028825165s)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:55:56.327977Z","caller":"traceutil/trace.go:171","msg":"trace[629077842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1229; }","duration":"1.026282048s","start":"2026-07-14T16:55:55.301681Z","end":"2026-07-14T16:55:56.327963Z","steps":["trace[629077842] 'range keys from in-memory index tree'  (duration: 1.026023801s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:56.328012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:55.301661Z","time spent":"1.026345349s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-07-14T16:55:56.32798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:55.298875Z","time spent":"1.029099162s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-07-14T16:55:56.328235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.234822ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9485319006520186616 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1160 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-14T16:55:56.328307Z","caller":"traceutil/trace.go:171","msg":"trace[1133720509] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"696.941996ms","start":"2026-07-14T16:55:55.631353Z","end":"2026-07-14T16:55:56.328295Z","steps":["trace[1133720509] 'process raft request'  (duration: 249.436587ms)","trace[1133720509] 'compare'  (duration: 446.579044ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T16:55:56.328363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:55.631328Z","time spent":"697.009067ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1160 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-07-14T16:55:56.328536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031010172s","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-07-14T16:55:56.328591Z","caller":"traceutil/trace.go:171","msg":"trace[1320087972] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1229; }","duration":"1.031133095s","start":"2026-07-14T16:55:55.297446Z","end":"2026-07-14T16:55:56.328579Z","steps":["trace[1320087972] 'range keys from in-memory index tree'  (duration: 1.030144068s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:55:56.328634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:55:55.297425Z","time spent":"1.031196546s","remote":"127.0.0.1:60340","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":"info","ts":"2026-07-14T16:55:56.435419Z","caller":"traceutil/trace.go:171","msg":"trace[1503758225] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"103.623835ms","start":"2026-07-14T16:55:56.331769Z","end":"2026-07-14T16:55:56.435393Z","steps":["trace[1503758225] 'process raft request'  (duration: 103.237205ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:55:56.439229Z","caller":"traceutil/trace.go:171","msg":"trace[930795790] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"105.419381ms","start":"2026-07-14T16:55:56.333776Z","end":"2026-07-14T16:55:56.439196Z","steps":["trace[930795790] 'process raft request'  (duration: 105.36167ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:55:56.439439Z","caller":"traceutil/trace.go:171","msg":"trace[757431100] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"105.893393ms","start":"2026-07-14T16:55:56.333527Z","end":"2026-07-14T16:55:56.439421Z","steps":["trace[757431100] 'process raft request'  (duration: 105.555535ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:55:56.439426Z","caller":"traceutil/trace.go:171","msg":"trace[494733645] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"106.621613ms","start":"2026-07-14T16:55:56.33277Z","end":"2026-07-14T16:55:56.439391Z","steps":["trace[494733645] 'process raft request'  (duration: 106.139571ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:43.126732Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9485319006520187861,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-07-14T16:56:43.627665Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9485319006520187861,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-07-14T16:56:43.875251Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.46955053s","expected-duration":"1s"}
{"level":"info","ts":"2026-07-14T16:56:43.875653Z","caller":"traceutil/trace.go:171","msg":"trace[531783319] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"1.47004639s","start":"2026-07-14T16:56:42.405587Z","end":"2026-07-14T16:56:43.875634Z","steps":["trace[531783319] 'process raft request'  (duration: 1.469914878s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:43.875768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:42.405569Z","time spent":"1.470140171s","remote":"127.0.0.1:60256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9335,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" mod_revision:1835 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" value_size:9278 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" > >"}
{"level":"warn","ts":"2026-07-14T16:56:44.415896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.186321ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9485319006520187863 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1869 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-14T16:56:44.416217Z","caller":"traceutil/trace.go:171","msg":"trace[1091074112] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"535.061203ms","start":"2026-07-14T16:56:43.881143Z","end":"2026-07-14T16:56:44.416204Z","steps":["trace[1091074112] 'process raft request'  (duration: 535.006392ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:44.416274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:43.881124Z","time spent":"535.125024ms","remote":"127.0.0.1:60238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":961,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" mod_revision:1859 > success:<request_put:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" value_size:892 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" > >"}
{"level":"info","ts":"2026-07-14T16:56:44.41641Z","caller":"traceutil/trace.go:171","msg":"trace[207959069] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"535.690365ms","start":"2026-07-14T16:56:43.880678Z","end":"2026-07-14T16:56:44.416368Z","steps":["trace[207959069] 'process raft request'  (duration: 535.39315ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:44.416562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:43.880641Z","time spent":"535.846188ms","remote":"127.0.0.1:60342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-sc7nr\" mod_revision:1863 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-sc7nr\" value_size:1392 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-replicas-sc7nr\" > >"}
{"level":"info","ts":"2026-07-14T16:56:44.416566Z","caller":"traceutil/trace.go:171","msg":"trace[1335438225] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"535.392829ms","start":"2026-07-14T16:56:43.881128Z","end":"2026-07-14T16:56:44.416521Z","steps":["trace[1335438225] 'process raft request'  (duration: 534.978611ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:44.416389Z","caller":"traceutil/trace.go:171","msg":"trace[1365633779] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"535.657255ms","start":"2026-07-14T16:56:43.880581Z","end":"2026-07-14T16:56:44.416238Z","steps":["trace[1365633779] 'process raft request'  (duration: 535.414519ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:44.41666Z","caller":"traceutil/trace.go:171","msg":"trace[718436797] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1940; }","duration":"1.790560235s","start":"2026-07-14T16:56:42.62608Z","end":"2026-07-14T16:56:44.41664Z","steps":["trace[718436797] 'read index received'  (duration: 1.249435681s)","trace[718436797] 'applied index is now lower than readState.Index'  (duration: 541.122594ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T16:56:44.416725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:43.88056Z","time spent":"536.141783ms","remote":"127.0.0.1:60238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy-replicas\" mod_revision:1862 > success:<request_put:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy-replicas\" value_size:816 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy-replicas\" > >"}
{"level":"warn","ts":"2026-07-14T16:56:44.416858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:43.881119Z","time spent":"535.592012ms","remote":"127.0.0.1:60342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1513,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-vcpqr\" mod_revision:1858 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-vcpqr\" value_size:1442 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-haproxy-vcpqr\" > >"}
{"level":"warn","ts":"2026-07-14T16:56:44.416867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.718921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T16:56:44.416936Z","caller":"traceutil/trace.go:171","msg":"trace[1190357416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1888; }","duration":"829.859144ms","start":"2026-07-14T16:56:43.58706Z","end":"2026-07-14T16:56:44.41692Z","steps":["trace[1190357416] 'agreement among raft nodes before linearized reading'  (duration: 829.751802ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:44.416971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.204987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"warn","ts":"2026-07-14T16:56:44.416987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:43.587041Z","time spent":"829.938215ms","remote":"127.0.0.1:60096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-07-14T16:56:44.417212Z","caller":"traceutil/trace.go:171","msg":"trace[1532482354] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1888; }","duration":"337.472991ms","start":"2026-07-14T16:56:44.079727Z","end":"2026-07-14T16:56:44.4172Z","steps":["trace[1532482354] 'agreement among raft nodes before linearized reading'  (duration: 337.137915ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:44.417223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.727364074s","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-07-14T16:56:44.417216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.603344894s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b8a689ee-4079-4b37-a2aa-1b5ad031256f\" ","response":"range_response_count:1 size:3627"}
{"level":"warn","ts":"2026-07-14T16:56:44.41727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.223980395s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-07-14T16:56:44.417279Z","caller":"traceutil/trace.go:171","msg":"trace[328764929] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b8a689ee-4079-4b37-a2aa-1b5ad031256f; range_end:; response_count:1; response_revision:1888; }","duration":"1.603449876s","start":"2026-07-14T16:56:42.81382Z","end":"2026-07-14T16:56:44.41727Z","steps":["trace[328764929] 'agreement among raft nodes before linearized reading'  (duration: 1.60310649s)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:44.417292Z","caller":"traceutil/trace.go:171","msg":"trace[969445640] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1888; }","duration":"1.224030897s","start":"2026-07-14T16:56:43.193254Z","end":"2026-07-14T16:56:44.417285Z","steps":["trace[969445640] 'agreement among raft nodes before linearized reading'  (duration: 1.223978106s)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:44.417284Z","caller":"traceutil/trace.go:171","msg":"trace[458913587] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1888; }","duration":"1.727439555s","start":"2026-07-14T16:56:42.689829Z","end":"2026-07-14T16:56:44.417269Z","steps":["trace[458913587] 'agreement among raft nodes before linearized reading'  (duration: 1.72713788s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:44.417314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:43.193228Z","time spent":"1.224081927s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-07-14T16:56:44.417322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:42.81379Z","time spent":"1.603524498s","remote":"127.0.0.1:60256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b8a689ee-4079-4b37-a2aa-1b5ad031256f\" "}
{"level":"warn","ts":"2026-07-14T16:56:44.417332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:42.689819Z","time spent":"1.727501406s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-07-14T16:56:44.417395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.769713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T16:56:44.417437Z","caller":"traceutil/trace.go:171","msg":"trace[23594769] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1888; }","duration":"410.851675ms","start":"2026-07-14T16:56:44.006575Z","end":"2026-07-14T16:56:44.417427Z","steps":["trace[23594769] 'agreement among raft nodes before linearized reading'  (duration: 410.782194ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:44.41738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.79085283s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"}
{"level":"warn","ts":"2026-07-14T16:56:44.417473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:44.006562Z","time spent":"410.902106ms","remote":"127.0.0.1:45812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "}
{"level":"warn","ts":"2026-07-14T16:56:44.417507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.735802331s","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-07-14T16:56:44.417518Z","caller":"traceutil/trace.go:171","msg":"trace[474191266] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1888; }","duration":"1.791449471s","start":"2026-07-14T16:56:42.626025Z","end":"2026-07-14T16:56:44.417475Z","steps":["trace[474191266] 'agreement among raft nodes before linearized reading'  (duration: 1.790697537s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:44.417538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.181199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:522"}
{"level":"warn","ts":"2026-07-14T16:56:44.417575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.731385868s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-07-14T16:56:44.417573Z","caller":"traceutil/trace.go:171","msg":"trace[907510929] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:1888; }","duration":"323.23053ms","start":"2026-07-14T16:56:44.09433Z","end":"2026-07-14T16:56:44.41756Z","steps":["trace[907510929] 'agreement among raft nodes before linearized reading'  (duration: 323.144708ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:44.417599Z","caller":"traceutil/trace.go:171","msg":"trace[1007492588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1888; }","duration":"1.731409018s","start":"2026-07-14T16:56:42.686184Z","end":"2026-07-14T16:56:44.417593Z","steps":["trace[1007492588] 'agreement among raft nodes before linearized reading'  (duration: 1.731360877s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:44.417603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:44.09432Z","time spent":"323.27612ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":544,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "}
{"level":"warn","ts":"2026-07-14T16:56:44.417624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:42.686131Z","time spent":"1.73148786s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-07-14T16:56:44.417638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.29513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-14T16:56:44.417532Z","caller":"traceutil/trace.go:171","msg":"trace[740103442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1888; }","duration":"1.735845641s","start":"2026-07-14T16:56:42.68168Z","end":"2026-07-14T16:56:44.417526Z","steps":["trace[740103442] 'agreement among raft nodes before linearized reading'  (duration: 1.73579674s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:44.416941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.750713136s","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-07-14T16:56:44.417682Z","caller":"traceutil/trace.go:171","msg":"trace[605211334] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1888; }","duration":"457.370891ms","start":"2026-07-14T16:56:43.960297Z","end":"2026-07-14T16:56:44.417668Z","steps":["trace[605211334] 'agreement among raft nodes before linearized reading'  (duration: 457.31097ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:44.417703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:42.681667Z","time spent":"1.736031254s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-07-14T16:56:44.41772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:43.960272Z","time spent":"457.439162ms","remote":"127.0.0.1:45594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-07-14T16:56:44.417456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.479310657s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"}
{"level":"info","ts":"2026-07-14T16:56:44.417747Z","caller":"traceutil/trace.go:171","msg":"trace[230845350] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1888; }","duration":"1.751543391s","start":"2026-07-14T16:56:42.666174Z","end":"2026-07-14T16:56:44.417718Z","steps":["trace[230845350] 'agreement among raft nodes before linearized reading'  (duration: 1.750591914s)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:44.417788Z","caller":"traceutil/trace.go:171","msg":"trace[2019959787] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1888; }","duration":"1.479674843s","start":"2026-07-14T16:56:42.938099Z","end":"2026-07-14T16:56:44.417774Z","steps":["trace[2019959787] 'agreement among raft nodes before linearized reading'  (duration: 1.479309337s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:44.417791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:42.666153Z","time spent":"1.751627092s","remote":"127.0.0.1:60340","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-07-14T16:56:44.417817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:42.626003Z","time spent":"1.791793457s","remote":"127.0.0.1:41158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4613,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-07-14T16:56:44.417841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:42.938086Z","time spent":"1.479745304s","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":681,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-14T16:56:44.417246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:44.079712Z","time spent":"337.526433ms","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":666,"request content":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-07-14T16:56:44.417417Z","caller":"traceutil/trace.go:171","msg":"trace[632333648] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"1.319279791s","start":"2026-07-14T16:56:43.097717Z","end":"2026-07-14T16:56:44.416469Z","steps":["trace[632333648] 'process raft request'  (duration: 843.882628ms)","trace[632333648] 'compare'  (duration: 473.976507ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T16:56:44.419212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:43.097676Z","time spent":"1.321453772s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1869 > 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":"warn","ts":"2026-07-14T16:56:46.660136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.770722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-07-14T16:56:46.661601Z","caller":"traceutil/trace.go:171","msg":"trace[1527057588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1909; }","duration":"172.233798ms","start":"2026-07-14T16:56:46.489322Z","end":"2026-07-14T16:56:46.661556Z","steps":["trace[1527057588] 'range keys from in-memory index tree'  (duration: 170.545317ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:46.660372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.747651ms","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-07-14T16:56:46.661819Z","caller":"traceutil/trace.go:171","msg":"trace[419634088] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1909; }","duration":"172.228007ms","start":"2026-07-14T16:56:46.489559Z","end":"2026-07-14T16:56:46.661787Z","steps":["trace[419634088] 'range keys from in-memory index tree'  (duration: 170.621349ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:46.660474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.891053ms","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-07-14T16:56:46.662085Z","caller":"traceutil/trace.go:171","msg":"trace[1402371107] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1909; }","duration":"172.483312ms","start":"2026-07-14T16:56:46.489573Z","end":"2026-07-14T16:56:46.662056Z","steps":["trace[1402371107] 'range keys from in-memory index tree'  (duration: 170.763912ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:46.660543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.955725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-07-14T16:56:46.662239Z","caller":"traceutil/trace.go:171","msg":"trace[1107687424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1909; }","duration":"172.669296ms","start":"2026-07-14T16:56:46.489558Z","end":"2026-07-14T16:56:46.662227Z","steps":["trace[1107687424] 'range keys from in-memory index tree'  (duration: 170.831453ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:46.660614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.357352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-07-14T16:56:46.662413Z","caller":"traceutil/trace.go:171","msg":"trace[1766758323] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1909; }","duration":"163.156563ms","start":"2026-07-14T16:56:46.499222Z","end":"2026-07-14T16:56:46.662378Z","steps":["trace[1766758323] 'range keys from in-memory index tree'  (duration: 161.227609ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:46.660684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.663535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"}
{"level":"info","ts":"2026-07-14T16:56:46.662637Z","caller":"traceutil/trace.go:171","msg":"trace[720870669] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1909; }","duration":"159.62581ms","start":"2026-07-14T16:56:46.502991Z","end":"2026-07-14T16:56:46.662616Z","steps":["trace[720870669] 'range keys from in-memory index tree'  (duration: 157.47736ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:46.661211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.517053ms","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-07-14T16:56:46.662768Z","caller":"traceutil/trace.go:171","msg":"trace[1424335999] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1909; }","duration":"174.108243ms","start":"2026-07-14T16:56:46.48864Z","end":"2026-07-14T16:56:46.662748Z","steps":["trace[1424335999] 'range keys from in-memory index tree'  (duration: 172.34328ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:46.661377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.37789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:522"}
{"level":"info","ts":"2026-07-14T16:56:46.662919Z","caller":"traceutil/trace.go:171","msg":"trace[10807078] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:1909; }","duration":"179.986599ms","start":"2026-07-14T16:56:46.482923Z","end":"2026-07-14T16:56:46.66291Z","steps":["trace[10807078] 'range keys from in-memory index tree'  (duration: 178.180416ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:50.888701Z","caller":"traceutil/trace.go:171","msg":"trace[1046035621] linearizableReadLoop","detail":"{readStateIndex:2019; appliedIndex:2018; }","duration":"356.397319ms","start":"2026-07-14T16:56:50.532278Z","end":"2026-07-14T16:56:50.888675Z","steps":["trace[1046035621] 'read index received'  (duration: 356.275157ms)","trace[1046035621] 'applied index is now lower than readState.Index'  (duration: 121.012µs)"],"step_count":2}
{"level":"info","ts":"2026-07-14T16:56:50.888823Z","caller":"traceutil/trace.go:171","msg":"trace[850835370] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"424.598996ms","start":"2026-07-14T16:56:50.464193Z","end":"2026-07-14T16:56:50.888792Z","steps":["trace[850835370] 'process raft request'  (duration: 424.203439ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:50.888929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.635003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"}
{"level":"info","ts":"2026-07-14T16:56:50.888979Z","caller":"traceutil/trace.go:171","msg":"trace[2089444652] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1958; }","duration":"356.731364ms","start":"2026-07-14T16:56:50.532233Z","end":"2026-07-14T16:56:50.888965Z","steps":["trace[2089444652] 'agreement among raft nodes before linearized reading'  (duration: 356.556631ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:50.888991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:50.464173Z","time spent":"424.731709ms","remote":"127.0.0.1:60256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11248,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" mod_revision:1944 > success:<request_put:<key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" value_size:11195 >> failure:<request_range:<key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" > >"}
{"level":"warn","ts":"2026-07-14T16:56:50.889022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:50.532214Z","time spent":"356.798416ms","remote":"127.0.0.1:60234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1875,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-07-14T16:56:50.900596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.521438ms","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-07-14T16:56:50.900638Z","caller":"traceutil/trace.go:171","msg":"trace[296062813] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"364.317039ms","start":"2026-07-14T16:56:50.536308Z","end":"2026-07-14T16:56:50.900625Z","steps":["trace[296062813] 'process raft request'  (duration: 363.996664ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:50.900661Z","caller":"traceutil/trace.go:171","msg":"trace[1548521903] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1959; }","duration":"196.6412ms","start":"2026-07-14T16:56:50.704004Z","end":"2026-07-14T16:56:50.900645Z","steps":["trace[1548521903] 'agreement among raft nodes before linearized reading'  (duration: 196.447177ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:50.900672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.490984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-07-14T16:56:50.900728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:50.536288Z","time spent":"364.38347ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1812 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-07-14T16:56:50.900729Z","caller":"traceutil/trace.go:171","msg":"trace[1020876015] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1959; }","duration":"198.579255ms","start":"2026-07-14T16:56:50.702137Z","end":"2026-07-14T16:56:50.900717Z","steps":["trace[1020876015] 'agreement among raft nodes before linearized reading'  (duration: 198.429732ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:50.900861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.818417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:523"}
{"level":"info","ts":"2026-07-14T16:56:50.900885Z","caller":"traceutil/trace.go:171","msg":"trace[1978208911] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:1959; }","duration":"212.872878ms","start":"2026-07-14T16:56:50.688007Z","end":"2026-07-14T16:56:50.900879Z","steps":["trace[1978208911] 'agreement among raft nodes before linearized reading'  (duration: 212.809636ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:50.901001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.046534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-07-14T16:56:50.900998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.943006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-07-14T16:56:50.901044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.825545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-07-14T16:56:50.901061Z","caller":"traceutil/trace.go:171","msg":"trace[1398717861] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1959; }","duration":"201.026227ms","start":"2026-07-14T16:56:50.700016Z","end":"2026-07-14T16:56:50.901043Z","steps":["trace[1398717861] 'agreement among raft nodes before linearized reading'  (duration: 200.843394ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:50.901074Z","caller":"traceutil/trace.go:171","msg":"trace[762411748] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1959; }","duration":"169.951988ms","start":"2026-07-14T16:56:50.731114Z","end":"2026-07-14T16:56:50.901066Z","steps":["trace[762411748] 'agreement among raft nodes before linearized reading'  (duration: 169.875586ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:50.901057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.940336ms","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-07-14T16:56:50.901024Z","caller":"traceutil/trace.go:171","msg":"trace[1983476422] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1959; }","duration":"316.089234ms","start":"2026-07-14T16:56:50.584929Z","end":"2026-07-14T16:56:50.901018Z","steps":["trace[1983476422] 'agreement among raft nodes before linearized reading'  (duration: 316.053293ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:50.901207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.691949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"}
{"level":"warn","ts":"2026-07-14T16:56:50.901204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:50.584918Z","time spent":"316.276017ms","remote":"127.0.0.1:60096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-07-14T16:56:50.901233Z","caller":"traceutil/trace.go:171","msg":"trace[804259797] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1959; }","duration":"180.74071ms","start":"2026-07-14T16:56:50.720486Z","end":"2026-07-14T16:56:50.901227Z","steps":["trace[804259797] 'agreement among raft nodes before linearized reading'  (duration: 180.677137ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:50.90126Z","caller":"traceutil/trace.go:171","msg":"trace[1701062323] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1959; }","duration":"201.12646ms","start":"2026-07-14T16:56:50.700042Z","end":"2026-07-14T16:56:50.901168Z","steps":["trace[1701062323] 'agreement among raft nodes before linearized reading'  (duration: 200.788244ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:50.901506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.587049ms","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-07-14T16:56:50.901584Z","caller":"traceutil/trace.go:171","msg":"trace[776592656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1959; }","duration":"205.688322ms","start":"2026-07-14T16:56:50.695884Z","end":"2026-07-14T16:56:50.901572Z","steps":["trace[776592656] 'agreement among raft nodes before linearized reading'  (duration: 205.535959ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:51.06884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.525961ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9485319006520188024 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/percona-xtradb-pxc-6hhff\" mod_revision:1851 > success:<request_put:<key:\"/registry/endpointslices/openstack/percona-xtradb-pxc-6hhff\" value_size:1616 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/percona-xtradb-pxc-6hhff\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-14T16:56:51.069106Z","caller":"traceutil/trace.go:171","msg":"trace[761958734] linearizableReadLoop","detail":"{readStateIndex:2024; appliedIndex:2020; }","duration":"168.68747ms","start":"2026-07-14T16:56:50.900401Z","end":"2026-07-14T16:56:51.069089Z","steps":["trace[761958734] 'read index received'  (duration: 62.834363ms)","trace[761958734] 'applied index is now lower than readState.Index'  (duration: 105.852157ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T16:56:51.069087Z","caller":"traceutil/trace.go:171","msg":"trace[897257428] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"173.044596ms","start":"2026-07-14T16:56:50.895972Z","end":"2026-07-14T16:56:51.069016Z","steps":["trace[897257428] 'process raft request'  (duration: 67.246971ms)","trace[897257428] 'compare'  (duration: 104.856599ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T16:56:51.069095Z","caller":"traceutil/trace.go:171","msg":"trace[1601350970] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"173.042816ms","start":"2026-07-14T16:56:50.896025Z","end":"2026-07-14T16:56:51.069067Z","steps":["trace[1601350970] 'process raft request'  (duration: 172.913084ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:51.069407Z","caller":"traceutil/trace.go:171","msg":"trace[1357704824] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"172.432056ms","start":"2026-07-14T16:56:50.896962Z","end":"2026-07-14T16:56:51.069394Z","steps":["trace[1357704824] 'process raft request'  (duration: 172.033538ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:51.069575Z","caller":"traceutil/trace.go:171","msg":"trace[499050963] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"172.419076ms","start":"2026-07-14T16:56:50.897142Z","end":"2026-07-14T16:56:51.069561Z","steps":["trace[499050963] 'process raft request'  (duration: 171.897686ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:51.069667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.957249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-b8a689ee-4079-4b37-a2aa-1b5ad031256f\" ","response":"range_response_count:1 size:1303"}
{"level":"info","ts":"2026-07-14T16:56:51.069752Z","caller":"traceutil/trace.go:171","msg":"trace[371025149] range","detail":"{range_begin:/registry/persistentvolumes/pvc-b8a689ee-4079-4b37-a2aa-1b5ad031256f; range_end:; response_count:1; response_revision:1963; }","duration":"176.100291ms","start":"2026-07-14T16:56:50.89363Z","end":"2026-07-14T16:56:51.06973Z","steps":["trace[371025149] 'agreement among raft nodes before linearized reading'  (duration: 175.859447ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:51.100651Z","caller":"traceutil/trace.go:171","msg":"trace[1594894924] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"195.224417ms","start":"2026-07-14T16:56:50.905408Z","end":"2026-07-14T16:56:51.100633Z","steps":["trace[1594894924] 'process raft request'  (duration: 195.095304ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:51.10092Z","caller":"traceutil/trace.go:171","msg":"trace[1832032279] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"195.399279ms","start":"2026-07-14T16:56:50.905501Z","end":"2026-07-14T16:56:51.1009Z","steps":["trace[1832032279] 'process raft request'  (duration: 195.101304ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:51.101614Z","caller":"traceutil/trace.go:171","msg":"trace[632803617] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"196.074031ms","start":"2026-07-14T16:56:50.905523Z","end":"2026-07-14T16:56:51.101597Z","steps":["trace[632803617] 'process raft request'  (duration: 195.299508ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:51.101995Z","caller":"traceutil/trace.go:171","msg":"trace[1378424621] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"196.00003ms","start":"2026-07-14T16:56:50.905983Z","end":"2026-07-14T16:56:51.101983Z","steps":["trace[1378424621] 'process raft request'  (duration: 195.542682ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:51.102256Z","caller":"traceutil/trace.go:171","msg":"trace[615752284] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"196.01316ms","start":"2026-07-14T16:56:50.90623Z","end":"2026-07-14T16:56:51.102243Z","steps":["trace[615752284] 'process raft request'  (duration: 195.713195ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:51.102433Z","caller":"traceutil/trace.go:171","msg":"trace[1741224021] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"196.134272ms","start":"2026-07-14T16:56:50.906281Z","end":"2026-07-14T16:56:51.102415Z","steps":["trace[1741224021] 'process raft request'  (duration: 195.923899ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:51.102606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.109909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:552"}
{"level":"warn","ts":"2026-07-14T16:56:51.102657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.250021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"}
{"level":"info","ts":"2026-07-14T16:56:51.102679Z","caller":"traceutil/trace.go:171","msg":"trace[1642788002] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1969; }","duration":"197.20598ms","start":"2026-07-14T16:56:50.905454Z","end":"2026-07-14T16:56:51.10266Z","steps":["trace[1642788002] 'agreement among raft nodes before linearized reading'  (duration: 196.991447ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:51.102693Z","caller":"traceutil/trace.go:171","msg":"trace[942477326] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1969; }","duration":"197.323053ms","start":"2026-07-14T16:56:50.905358Z","end":"2026-07-14T16:56:51.102681Z","steps":["trace[942477326] 'agreement among raft nodes before linearized reading'  (duration: 197.16883ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:51.102989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.5452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T16:56:51.103048Z","caller":"traceutil/trace.go:171","msg":"trace[770732150] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1969; }","duration":"200.941127ms","start":"2026-07-14T16:56:50.902092Z","end":"2026-07-14T16:56:51.103033Z","steps":["trace[770732150] 'agreement among raft nodes before linearized reading'  (duration: 200.284845ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:51.35201Z","caller":"traceutil/trace.go:171","msg":"trace[920363203] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1974; }","duration":"119.265749ms","start":"2026-07-14T16:56:51.232716Z","end":"2026-07-14T16:56:51.351982Z","steps":["trace[920363203] 'process raft request'  (duration: 110.315101ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:51.352032Z","caller":"traceutil/trace.go:171","msg":"trace[1075359110] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"116.291436ms","start":"2026-07-14T16:56:51.235716Z","end":"2026-07-14T16:56:51.352007Z","steps":["trace[1075359110] 'process raft request'  (duration: 115.440462ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:52.761023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.782752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T16:56:52.761084Z","caller":"traceutil/trace.go:171","msg":"trace[744744500] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1982; }","duration":"173.885155ms","start":"2026-07-14T16:56:52.587185Z","end":"2026-07-14T16:56:52.76107Z","steps":["trace[744744500] 'range keys from in-memory index tree'  (duration: 173.61508ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:52.761378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.825741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"}
{"level":"info","ts":"2026-07-14T16:56:52.761456Z","caller":"traceutil/trace.go:171","msg":"trace[2044307078] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1982; }","duration":"291.953703ms","start":"2026-07-14T16:56:52.469483Z","end":"2026-07-14T16:56:52.761437Z","steps":["trace[2044307078] 'range keys from in-memory index tree'  (duration: 291.664237ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:53.618147Z","caller":"traceutil/trace.go:171","msg":"trace[1366258347] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"509.475243ms","start":"2026-07-14T16:56:53.108647Z","end":"2026-07-14T16:56:53.618122Z","steps":["trace[1366258347] 'process raft request'  (duration: 509.32366ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:53.618291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:53.10863Z","time spent":"509.583815ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1965 > 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-07-14T16:56:53.660333Z","caller":"traceutil/trace.go:171","msg":"trace[1784091976] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"551.112187ms","start":"2026-07-14T16:56:53.109185Z","end":"2026-07-14T16:56:53.660297Z","steps":["trace[1784091976] 'process raft request'  (duration: 550.569598ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:53.660491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:53.109173Z","time spent":"551.232469ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1964 > 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\" > >"}
{"level":"info","ts":"2026-07-14T16:56:53.660597Z","caller":"traceutil/trace.go:171","msg":"trace[1086694596] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"548.866209ms","start":"2026-07-14T16:56:53.11171Z","end":"2026-07-14T16:56:53.660576Z","steps":["trace[1086694596] 'process raft request'  (duration: 548.578923ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:53.660696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:53.111698Z","time spent":"548.95212ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1968 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-07-14T16:56:53.660876Z","caller":"traceutil/trace.go:171","msg":"trace[736959065] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"549.053372ms","start":"2026-07-14T16:56:53.11178Z","end":"2026-07-14T16:56:53.660833Z","steps":["trace[736959065] 'process raft request'  (duration: 548.691465ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:53.661046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:53.111771Z","time spent":"549.185264ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":507,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1969 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-14T16:56:53.661191Z","caller":"traceutil/trace.go:171","msg":"trace[75737401] linearizableReadLoop","detail":"{readStateIndex:2050; appliedIndex:2044; }","duration":"400.533626ms","start":"2026-07-14T16:56:53.260633Z","end":"2026-07-14T16:56:53.661167Z","steps":["trace[75737401] 'read index received'  (duration: 357.263572ms)","trace[75737401] 'applied index is now lower than readState.Index'  (duration: 43.267974ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T16:56:53.661468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.824451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"warn","ts":"2026-07-14T16:56:53.661502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.628707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"}
{"level":"info","ts":"2026-07-14T16:56:53.66152Z","caller":"traceutil/trace.go:171","msg":"trace[1870228205] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1989; }","duration":"400.914482ms","start":"2026-07-14T16:56:53.26059Z","end":"2026-07-14T16:56:53.661505Z","steps":["trace[1870228205] 'agreement among raft nodes before linearized reading'  (duration: 400.769139ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:53.661547Z","caller":"traceutil/trace.go:171","msg":"trace[1214812590] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1989; }","duration":"400.689608ms","start":"2026-07-14T16:56:53.260844Z","end":"2026-07-14T16:56:53.661534Z","steps":["trace[1214812590] 'agreement among raft nodes before linearized reading'  (duration: 400.578916ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:53.661592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:53.260837Z","time spent":"400.744129ms","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":681,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-14T16:56:53.661553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:53.26057Z","time spent":"400.974813ms","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":666,"request content":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-14T16:56:53.661755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.166336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-14T16:56:53.661803Z","caller":"traceutil/trace.go:171","msg":"trace[2128056044] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1989; }","duration":"266.255787ms","start":"2026-07-14T16:56:53.395532Z","end":"2026-07-14T16:56:53.661788Z","steps":["trace[2128056044] 'agreement among raft nodes before linearized reading'  (duration: 266.120145ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:56:53.661444Z","caller":"traceutil/trace.go:171","msg":"trace[426377058] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"549.545121ms","start":"2026-07-14T16:56:53.11184Z","end":"2026-07-14T16:56:53.661385Z","steps":["trace[426377058] 'process raft request'  (duration: 548.742357ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:53.665132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:53.111827Z","time spent":"553.174433ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1966 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-07-14T16:56:53.66072Z","caller":"traceutil/trace.go:171","msg":"trace[1670491453] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"548.89729ms","start":"2026-07-14T16:56:53.11169Z","end":"2026-07-14T16:56:53.660587Z","steps":["trace[1670491453] 'process raft request'  (duration: 548.489812ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:56:53.665922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:56:53.111668Z","time spent":"554.174901ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1967 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-07-14T16:57:12.038589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.703728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"}
{"level":"info","ts":"2026-07-14T16:57:12.038829Z","caller":"traceutil/trace.go:171","msg":"trace[649192977] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2125; }","duration":"191.964932ms","start":"2026-07-14T16:57:11.846836Z","end":"2026-07-14T16:57:12.038801Z","steps":["trace[649192977] 'range keys from in-memory index tree'  (duration: 191.420602ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:12.038589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.383001ms","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-07-14T16:57:12.039011Z","caller":"traceutil/trace.go:171","msg":"trace[569550355] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2125; }","duration":"216.830157ms","start":"2026-07-14T16:57:11.822149Z","end":"2026-07-14T16:57:12.038979Z","steps":["trace[569550355] 'count revisions from in-memory index tree'  (duration: 216.30654ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:12.039106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.213531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-07-14T16:57:12.039156Z","caller":"traceutil/trace.go:171","msg":"trace[1927609990] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2125; }","duration":"188.265062ms","start":"2026-07-14T16:57:11.850863Z","end":"2026-07-14T16:57:12.039129Z","steps":["trace[1927609990] 'range keys from in-memory index tree'  (duration: 188.046298ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:12.038904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.867837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"}
{"level":"info","ts":"2026-07-14T16:57:12.039782Z","caller":"traceutil/trace.go:171","msg":"trace[493404322] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2125; }","duration":"148.815062ms","start":"2026-07-14T16:57:11.89095Z","end":"2026-07-14T16:57:12.039765Z","steps":["trace[493404322] 'range keys from in-memory index tree'  (duration: 147.465751ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:18.274763Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9485319006520188536,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-07-14T16:57:19.210544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.734353ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9485319006520188537 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2143 > 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-07-14T16:57:19.211354Z","caller":"traceutil/trace.go:171","msg":"trace[1324197894] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"1.437403399s","start":"2026-07-14T16:57:17.773925Z","end":"2026-07-14T16:57:19.211329Z","steps":["trace[1324197894] 'process raft request'  (duration: 580.761012ms)","trace[1324197894] 'compare'  (duration: 854.720498ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T16:57:19.211453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:17.773902Z","time spent":"1.43750752s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2143 > 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-07-14T16:57:19.211531Z","caller":"traceutil/trace.go:171","msg":"trace[240206776] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"665.230802ms","start":"2026-07-14T16:57:18.546271Z","end":"2026-07-14T16:57:19.211502Z","steps":["trace[240206776] 'process raft request'  (duration: 664.492031ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.211699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:18.546248Z","time spent":"665.348254ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2155 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-07-14T16:57:19.211719Z","caller":"traceutil/trace.go:171","msg":"trace[1100847249] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"1.437498341s","start":"2026-07-14T16:57:17.774199Z","end":"2026-07-14T16:57:19.211698Z","steps":["trace[1100847249] 'process raft request'  (duration: 1.436472635s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.21183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:17.774173Z","time spent":"1.437599752s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2144 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-14T16:57:19.211884Z","caller":"traceutil/trace.go:171","msg":"trace[902474203] linearizableReadLoop","detail":"{readStateIndex:2233; appliedIndex:2231; }","duration":"1.437347099s","start":"2026-07-14T16:57:17.774522Z","end":"2026-07-14T16:57:19.211869Z","steps":["trace[902474203] 'read index received'  (duration: 580.156843ms)","trace[902474203] 'applied index is now lower than readState.Index'  (duration: 857.188936ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T16:57:19.212114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.437587822s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-07-14T16:57:19.212133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.435829545s","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-07-14T16:57:19.212162Z","caller":"traceutil/trace.go:171","msg":"trace[435181195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2162; }","duration":"1.437682344s","start":"2026-07-14T16:57:17.774466Z","end":"2026-07-14T16:57:19.212148Z","steps":["trace[435181195] 'agreement among raft nodes before linearized reading'  (duration: 1.437524142s)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:57:19.21221Z","caller":"traceutil/trace.go:171","msg":"trace[775961631] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2162; }","duration":"1.435947696s","start":"2026-07-14T16:57:17.776246Z","end":"2026-07-14T16:57:19.212194Z","steps":["trace[775961631] 'agreement among raft nodes before linearized reading'  (duration: 1.435792123s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.212247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:17.776236Z","time spent":"1.436002337s","remote":"127.0.0.1:60340","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-07-14T16:57:19.21226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.111442555s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-07-14T16:57:19.212296Z","caller":"traceutil/trace.go:171","msg":"trace[950611789] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2162; }","duration":"1.111526166s","start":"2026-07-14T16:57:18.100761Z","end":"2026-07-14T16:57:19.212287Z","steps":["trace[950611789] 'agreement among raft nodes before linearized reading'  (duration: 1.111383604s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.21232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:18.10074Z","time spent":"1.111574167s","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":666,"request content":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-14T16:57:19.212482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.425484153s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-07-14T16:57:19.212539Z","caller":"traceutil/trace.go:171","msg":"trace[1765443646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2162; }","duration":"1.425567775s","start":"2026-07-14T16:57:17.786959Z","end":"2026-07-14T16:57:19.212527Z","steps":["trace[1765443646] 'agreement among raft nodes before linearized reading'  (duration: 1.425441673s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.21259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.313002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-07-14T16:57:19.212585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:17.786949Z","time spent":"1.425626105s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-07-14T16:57:19.21266Z","caller":"traceutil/trace.go:171","msg":"trace[1153311193] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2162; }","duration":"987.429024ms","start":"2026-07-14T16:57:18.22522Z","end":"2026-07-14T16:57:19.212649Z","steps":["trace[1153311193] 'agreement among raft nodes before linearized reading'  (duration: 987.343203ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.212699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:18.225192Z","time spent":"987.496245ms","remote":"127.0.0.1:45904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "}
{"level":"warn","ts":"2026-07-14T16:57:19.212839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.088416788s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T16:57:19.212864Z","caller":"traceutil/trace.go:171","msg":"trace[1815617084] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2162; }","duration":"1.08848138s","start":"2026-07-14T16:57:18.124376Z","end":"2026-07-14T16:57:19.212858Z","steps":["trace[1815617084] 'agreement among raft nodes before linearized reading'  (duration: 1.088441709s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.212884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:18.124355Z","time spent":"1.08852367s","remote":"127.0.0.1:60354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"warn","ts":"2026-07-14T16:57:19.21289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.427139009s","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-07-14T16:57:19.212937Z","caller":"traceutil/trace.go:171","msg":"trace[1004537435] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2162; }","duration":"1.427233561s","start":"2026-07-14T16:57:17.785692Z","end":"2026-07-14T16:57:19.212926Z","steps":["trace[1004537435] 'agreement among raft nodes before linearized reading'  (duration: 1.427108039s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.21298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:17.785679Z","time spent":"1.427293001s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-07-14T16:57:19.212496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.299251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-07-14T16:57:19.213185Z","caller":"traceutil/trace.go:171","msg":"trace[654278851] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2162; }","duration":"283.023601ms","start":"2026-07-14T16:57:18.930146Z","end":"2026-07-14T16:57:19.213169Z","steps":["trace[654278851] 'agreement among raft nodes before linearized reading'  (duration: 282.29018ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.213221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.121030243s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"}
{"level":"info","ts":"2026-07-14T16:57:19.213253Z","caller":"traceutil/trace.go:171","msg":"trace[2085832882] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2162; }","duration":"1.121083523s","start":"2026-07-14T16:57:18.092162Z","end":"2026-07-14T16:57:19.213245Z","steps":["trace[2085832882] 'agreement among raft nodes before linearized reading'  (duration: 1.121006682s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.213277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:18.09215Z","time spent":"1.121121914s","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":681,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-14T16:57:19.212541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.044324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T16:57:19.21335Z","caller":"traceutil/trace.go:171","msg":"trace[580678137] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2162; }","duration":"622.891696ms","start":"2026-07-14T16:57:18.590448Z","end":"2026-07-14T16:57:19.213339Z","steps":["trace[580678137] 'agreement among raft nodes before linearized reading'  (duration: 622.068473ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.2134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:18.590427Z","time spent":"622.956317ms","remote":"127.0.0.1:60096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-07-14T16:57:19.21503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.129973022s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"}
{"level":"warn","ts":"2026-07-14T16:57:19.2122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:17.774457Z","time spent":"1.437735135s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-07-14T16:57:19.216095Z","caller":"traceutil/trace.go:171","msg":"trace[140902479] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2162; }","duration":"1.132620553s","start":"2026-07-14T16:57:18.082488Z","end":"2026-07-14T16:57:19.215109Z","steps":["trace[140902479] 'agreement among raft nodes before linearized reading'  (duration: 1.129730649s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.216359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:18.082469Z","time spent":"1.13371836s","remote":"127.0.0.1:41158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4613,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-07-14T16:57:19.719254Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9485319006520188544,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-07-14T16:57:19.732789Z","caller":"traceutil/trace.go:171","msg":"trace[1606462047] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"514.119142ms","start":"2026-07-14T16:57:19.21865Z","end":"2026-07-14T16:57:19.732769Z","steps":["trace[1606462047] 'process raft request'  (duration: 513.815006ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:57:19.732869Z","caller":"traceutil/trace.go:171","msg":"trace[1228621040] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"513.665805ms","start":"2026-07-14T16:57:19.219187Z","end":"2026-07-14T16:57:19.732853Z","steps":["trace[1228621040] 'process raft request'  (duration: 513.37316ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:57:19.732876Z","caller":"traceutil/trace.go:171","msg":"trace[714668859] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"517.835249ms","start":"2026-07-14T16:57:19.215023Z","end":"2026-07-14T16:57:19.732858Z","steps":["trace[714668859] 'process raft request'  (duration: 515.672666ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:57:19.732872Z","caller":"traceutil/trace.go:171","msg":"trace[1404162884] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"514.202843ms","start":"2026-07-14T16:57:19.218641Z","end":"2026-07-14T16:57:19.732844Z","steps":["trace[1404162884] 'process raft request'  (duration: 513.737165ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.732916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:19.218641Z","time spent":"514.207773ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2146 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-07-14T16:57:19.732944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:19.219175Z","time spent":"513.731806ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2145 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-07-14T16:57:19.73297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:19.215011Z","time spent":"517.91366ms","remote":"127.0.0.1:60160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":819,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/openstack/percona-xtradb-pxc-0.18c2366bd34291c0\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/percona-xtradb-pxc-0.18c2366bd34291c0\" value_size:737 lease:261946969665412732 >> failure:<>"}
{"level":"warn","ts":"2026-07-14T16:57:19.73301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:19.21862Z","time spent":"514.312424ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:2075 > 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-07-14T16:57:19.733029Z","caller":"traceutil/trace.go:171","msg":"trace[1408123033] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"514.327585ms","start":"2026-07-14T16:57:19.218694Z","end":"2026-07-14T16:57:19.733021Z","steps":["trace[1408123033] 'process raft request'  (duration: 513.819486ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.733073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:19.218689Z","time spent":"514.360845ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2148 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-07-14T16:57:19.733106Z","caller":"traceutil/trace.go:171","msg":"trace[1237530816] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"513.153398ms","start":"2026-07-14T16:57:19.219929Z","end":"2026-07-14T16:57:19.733082Z","steps":["trace[1237530816] 'process raft request'  (duration: 512.67514ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.733227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:19.219906Z","time spent":"513.244859ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2147 > 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":"warn","ts":"2026-07-14T16:57:19.733336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.815512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:551"}
{"level":"info","ts":"2026-07-14T16:57:19.73268Z","caller":"traceutil/trace.go:171","msg":"trace[613465687] linearizableReadLoop","detail":"{readStateIndex:2241; appliedIndex:2235; }","duration":"514.136731ms","start":"2026-07-14T16:57:19.218513Z","end":"2026-07-14T16:57:19.73265Z","steps":["trace[613465687] 'read index received'  (duration: 512.160802ms)","trace[613465687] 'applied index is now lower than readState.Index'  (duration: 1.974729ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T16:57:19.733382Z","caller":"traceutil/trace.go:171","msg":"trace[164813705] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2168; }","duration":"514.873143ms","start":"2026-07-14T16:57:19.218493Z","end":"2026-07-14T16:57:19.733366Z","steps":["trace[164813705] 'agreement among raft nodes before linearized reading'  (duration: 514.730251ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.733575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:19.218483Z","time spent":"515.071396ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":573,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-14T16:57:19.735786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.157169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:566"}
{"level":"info","ts":"2026-07-14T16:57:19.735866Z","caller":"traceutil/trace.go:171","msg":"trace[2017641606] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2168; }","duration":"517.24741ms","start":"2026-07-14T16:57:19.218599Z","end":"2026-07-14T16:57:19.735846Z","steps":["trace[2017641606] 'agreement among raft nodes before linearized reading'  (duration: 516.311415ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:57:19.736097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:57:19.218594Z","time spent":"517.456654ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":588,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-07-14T16:58:10.280109Z","caller":"traceutil/trace.go:171","msg":"trace[1214733075] transaction","detail":"{read_only:false; response_revision:2570; number_of_response:1; }","duration":"114.811512ms","start":"2026-07-14T16:58:10.16527Z","end":"2026-07-14T16:58:10.280081Z","steps":["trace[1214733075] 'process raft request'  (duration: 114.601489ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:16.088147Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9485319006520189716,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-07-14T16:58:16.588333Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9485319006520189716,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-07-14T16:58:16.78433Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.315704862s","expected-duration":"1s"}
{"level":"info","ts":"2026-07-14T16:58:16.784736Z","caller":"traceutil/trace.go:171","msg":"trace[1187987628] transaction","detail":"{read_only:false; response_revision:2648; number_of_response:1; }","duration":"1.316207188s","start":"2026-07-14T16:58:15.468511Z","end":"2026-07-14T16:58:16.784718Z","steps":["trace[1187987628] 'process raft request'  (duration: 1.316044186s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:16.784883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:15.468497Z","time spent":"1.316297179s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2629 > 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-07-14T16:58:17.007046Z","caller":"traceutil/trace.go:171","msg":"trace[651718399] transaction","detail":"{read_only:false; response_revision:2649; number_of_response:1; }","duration":"1.535084507s","start":"2026-07-14T16:58:15.471943Z","end":"2026-07-14T16:58:17.007028Z","steps":["trace[651718399] 'process raft request'  (duration: 1.529598335s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:17.00721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:15.471936Z","time spent":"1.535216548s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2631 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-14T16:58:17.007488Z","caller":"traceutil/trace.go:171","msg":"trace[386055824] linearizableReadLoop","detail":"{readStateIndex:2749; appliedIndex:2746; }","duration":"1.419960855s","start":"2026-07-14T16:58:15.587488Z","end":"2026-07-14T16:58:17.007449Z","steps":["trace[386055824] 'read index received'  (duration: 1.197105555s)","trace[386055824] 'applied index is now lower than readState.Index'  (duration: 222.84679ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T16:58:17.007633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.420141108s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T16:58:17.007694Z","caller":"traceutil/trace.go:171","msg":"trace[955927934] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2650; }","duration":"1.420229109s","start":"2026-07-14T16:58:15.587456Z","end":"2026-07-14T16:58:17.007685Z","steps":["trace[955927934] 'agreement among raft nodes before linearized reading'  (duration: 1.420144748s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:17.007737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:15.587428Z","time spent":"1.42030265s","remote":"127.0.0.1:60096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-07-14T16:58:17.007519Z","caller":"traceutil/trace.go:171","msg":"trace[352872996] transaction","detail":"{read_only:false; response_revision:2650; number_of_response:1; }","duration":"765.797304ms","start":"2026-07-14T16:58:16.241711Z","end":"2026-07-14T16:58:17.007508Z","steps":["trace[352872996] 'process raft request'  (duration: 765.281887ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:17.008049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:16.241683Z","time spent":"766.33187ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2554 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-07-14T16:58:17.008376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"964.965843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-07-14T16:58:17.00842Z","caller":"traceutil/trace.go:171","msg":"trace[712499163] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2650; }","duration":"965.030084ms","start":"2026-07-14T16:58:16.043375Z","end":"2026-07-14T16:58:17.008405Z","steps":["trace[712499163] 'agreement among raft nodes before linearized reading'  (duration: 964.954043ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:17.008463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:16.043354Z","time spent":"965.089015ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-07-14T16:58:17.008278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.679712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"warn","ts":"2026-07-14T16:58:17.008497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.671569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-07-14T16:58:17.008625Z","caller":"traceutil/trace.go:171","msg":"trace[1131937161] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2650; }","duration":"231.038916ms","start":"2026-07-14T16:58:16.777544Z","end":"2026-07-14T16:58:17.008583Z","steps":["trace[1131937161] 'agreement among raft nodes before linearized reading'  (duration: 230.592481ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:17.00865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.924165ms","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-07-14T16:58:17.008618Z","caller":"traceutil/trace.go:171","msg":"trace[1121920569] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2650; }","duration":"661.838792ms","start":"2026-07-14T16:58:16.346761Z","end":"2026-07-14T16:58:17.0086Z","steps":["trace[1121920569] 'agreement among raft nodes before linearized reading'  (duration: 661.586638ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:58:17.008696Z","caller":"traceutil/trace.go:171","msg":"trace[797664127] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2650; }","duration":"966.114269ms","start":"2026-07-14T16:58:16.042569Z","end":"2026-07-14T16:58:17.008683Z","steps":["trace[797664127] 'agreement among raft nodes before linearized reading'  (duration: 966.019748ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:17.008711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.171728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-07-14T16:58:17.008726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:16.042542Z","time spent":"966.177769ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-07-14T16:58:17.008738Z","caller":"traceutil/trace.go:171","msg":"trace[2099957054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2650; }","duration":"972.242608ms","start":"2026-07-14T16:58:16.036488Z","end":"2026-07-14T16:58:17.008731Z","steps":["trace[2099957054] 'agreement among raft nodes before linearized reading'  (duration: 972.172617ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:17.008761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:16.036465Z","time spent":"972.29155ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-07-14T16:58:17.008284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.984935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"warn","ts":"2026-07-14T16:58:17.008717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:16.34675Z","time spent":"661.950233ms","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":666,"request content":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-07-14T16:58:17.008856Z","caller":"traceutil/trace.go:171","msg":"trace[1261491831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2650; }","duration":"972.592104ms","start":"2026-07-14T16:58:16.03623Z","end":"2026-07-14T16:58:17.008822Z","steps":["trace[1261491831] 'agreement among raft nodes before linearized reading'  (duration: 971.883214ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:17.0089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:16.036209Z","time spent":"972.680294ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-07-14T16:58:17.008307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.461949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"}
{"level":"info","ts":"2026-07-14T16:58:17.009052Z","caller":"traceutil/trace.go:171","msg":"trace[1923908751] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2650; }","duration":"666.249549ms","start":"2026-07-14T16:58:16.342777Z","end":"2026-07-14T16:58:17.009027Z","steps":["trace[1923908751] 'agreement among raft nodes before linearized reading'  (duration: 665.355308ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:17.009131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:16.342757Z","time spent":"666.34806ms","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":681,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-07-14T16:58:39.323214Z","caller":"traceutil/trace.go:171","msg":"trace[1612846699] transaction","detail":"{read_only:false; response_revision:2808; number_of_response:1; }","duration":"112.565631ms","start":"2026-07-14T16:58:39.210623Z","end":"2026-07-14T16:58:39.323189Z","steps":["trace[1612846699] 'process raft request'  (duration: 112.48476ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:58:39.323253Z","caller":"traceutil/trace.go:171","msg":"trace[329660616] transaction","detail":"{read_only:false; response_revision:2807; number_of_response:1; }","duration":"112.955005ms","start":"2026-07-14T16:58:39.210259Z","end":"2026-07-14T16:58:39.323214Z","steps":["trace[329660616] 'process raft request'  (duration: 112.659031ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:58:39.323402Z","caller":"traceutil/trace.go:171","msg":"trace[1416662769] transaction","detail":"{read_only:false; response_revision:2809; number_of_response:1; }","duration":"112.623651ms","start":"2026-07-14T16:58:39.210767Z","end":"2026-07-14T16:58:39.323391Z","steps":["trace[1416662769] 'process raft request'  (duration: 112.375788ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:58:45.077502Z","caller":"traceutil/trace.go:171","msg":"trace[422992203] transaction","detail":"{read_only:false; response_revision:2843; number_of_response:1; }","duration":"141.183048ms","start":"2026-07-14T16:58:44.936266Z","end":"2026-07-14T16:58:45.077449Z","steps":["trace[422992203] 'process raft request'  (duration: 140.842464ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:58:45.605929Z","caller":"traceutil/trace.go:171","msg":"trace[217505237] linearizableReadLoop","detail":"{readStateIndex:2956; appliedIndex:2955; }","duration":"318.637569ms","start":"2026-07-14T16:58:45.287259Z","end":"2026-07-14T16:58:45.605897Z","steps":["trace[217505237] 'read index received'  (duration: 311.980465ms)","trace[217505237] 'applied index is now lower than readState.Index'  (duration: 6.655904ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T16:58:45.605962Z","caller":"traceutil/trace.go:171","msg":"trace[1637009742] transaction","detail":"{read_only:false; response_revision:2845; number_of_response:1; }","duration":"376.927918ms","start":"2026-07-14T16:58:45.229015Z","end":"2026-07-14T16:58:45.605943Z","steps":["trace[1637009742] 'process raft request'  (duration: 370.199364ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:45.606146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:45.228998Z","time spent":"377.08534ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2832 > 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\" > >"}
{"level":"warn","ts":"2026-07-14T16:58:45.606162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.892622ms","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-07-14T16:58:45.606213Z","caller":"traceutil/trace.go:171","msg":"trace[1727966382] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2845; }","duration":"318.995733ms","start":"2026-07-14T16:58:45.287206Z","end":"2026-07-14T16:58:45.606202Z","steps":["trace[1727966382] 'agreement among raft nodes before linearized reading'  (duration: 318.81265ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:45.606252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:45.28718Z","time spent":"319.062604ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-07-14T16:58:45.607915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.778508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-07-14T16:58:45.607924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.196389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1296"}
{"level":"info","ts":"2026-07-14T16:58:45.607975Z","caller":"traceutil/trace.go:171","msg":"trace[950910214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2846; }","duration":"262.839019ms","start":"2026-07-14T16:58:45.345126Z","end":"2026-07-14T16:58:45.607966Z","steps":["trace[950910214] 'agreement among raft nodes before linearized reading'  (duration: 262.707107ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:58:45.60801Z","caller":"traceutil/trace.go:171","msg":"trace[1551597615] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2846; }","duration":"150.31696ms","start":"2026-07-14T16:58:45.457673Z","end":"2026-07-14T16:58:45.60799Z","steps":["trace[1551597615] 'agreement among raft nodes before linearized reading'  (duration: 150.124978ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:45.607931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.384721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:523"}
{"level":"warn","ts":"2026-07-14T16:58:45.608049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.322952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"}
{"level":"info","ts":"2026-07-14T16:58:45.6081Z","caller":"traceutil/trace.go:171","msg":"trace[52986286] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2846; }","duration":"261.573594ms","start":"2026-07-14T16:58:45.346505Z","end":"2026-07-14T16:58:45.608078Z","steps":["trace[52986286] 'agreement among raft nodes before linearized reading'  (duration: 261.3085ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:58:45.608161Z","caller":"traceutil/trace.go:171","msg":"trace[1020633465] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2846; }","duration":"234.442275ms","start":"2026-07-14T16:58:45.373685Z","end":"2026-07-14T16:58:45.608127Z","steps":["trace[1020633465] 'agreement among raft nodes before linearized reading'  (duration: 234.267662ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:45.608304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.223145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-14T16:58:45.60835Z","caller":"traceutil/trace.go:171","msg":"trace[784078112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2846; }","duration":"263.308226ms","start":"2026-07-14T16:58:45.345031Z","end":"2026-07-14T16:58:45.608339Z","steps":["trace[784078112] 'agreement among raft nodes before linearized reading'  (duration: 263.172704ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:45.60857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.49378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"}
{"level":"info","ts":"2026-07-14T16:58:45.608607Z","caller":"traceutil/trace.go:171","msg":"trace[601457059] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2846; }","duration":"224.562741ms","start":"2026-07-14T16:58:45.384034Z","end":"2026-07-14T16:58:45.608596Z","steps":["trace[601457059] 'agreement among raft nodes before linearized reading'  (duration: 223.708229ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:46.113645Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9485319006520190282,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-07-14T16:58:46.29536Z","caller":"traceutil/trace.go:171","msg":"trace[379492163] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"683.008204ms","start":"2026-07-14T16:58:45.612328Z","end":"2026-07-14T16:58:46.295336Z","steps":["trace[379492163] 'process raft request'  (duration: 682.830791ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:46.295502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:45.612307Z","time spent":"683.123905ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2836 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-14T16:58:46.928181Z","caller":"traceutil/trace.go:171","msg":"trace[475067652] transaction","detail":"{read_only:false; response_revision:2848; number_of_response:1; }","duration":"1.315679082s","start":"2026-07-14T16:58:45.612474Z","end":"2026-07-14T16:58:46.928153Z","steps":["trace[475067652] 'process raft request'  (duration: 1.280739415s)","trace[475067652] 'compare'  (duration: 34.422401ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T16:58:46.928318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:45.612464Z","time spent":"1.315785763s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2834 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-07-14T16:58:46.928427Z","caller":"traceutil/trace.go:171","msg":"trace[1611245352] transaction","detail":"{read_only:false; response_revision:2849; number_of_response:1; }","duration":"1.315735053s","start":"2026-07-14T16:58:45.61266Z","end":"2026-07-14T16:58:46.928395Z","steps":["trace[1611245352] 'process raft request'  (duration: 1.31544467s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:46.928579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:45.612648Z","time spent":"1.315860554s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2833 > 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-07-14T16:58:46.928893Z","caller":"traceutil/trace.go:171","msg":"trace[963926666] transaction","detail":"{read_only:false; response_revision:2850; number_of_response:1; }","duration":"1.31549589s","start":"2026-07-14T16:58:45.613368Z","end":"2026-07-14T16:58:46.928863Z","steps":["trace[963926666] 'process raft request'  (duration: 1.314952343s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:46.929046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315722623s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:552"}
{"level":"info","ts":"2026-07-14T16:58:46.929088Z","caller":"traceutil/trace.go:171","msg":"trace[569597934] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2851; }","duration":"1.315787023s","start":"2026-07-14T16:58:45.613288Z","end":"2026-07-14T16:58:46.929075Z","steps":["trace[569597934] 'agreement among raft nodes before linearized reading'  (duration: 1.315657852s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:46.929129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:45.61328Z","time spent":"1.315841224s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":574,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-07-14T16:58:46.929172Z","caller":"traceutil/trace.go:171","msg":"trace[1087523225] transaction","detail":"{read_only:false; response_revision:2851; number_of_response:1; }","duration":"1.314048721s","start":"2026-07-14T16:58:45.615109Z","end":"2026-07-14T16:58:46.929157Z","steps":["trace[1087523225] 'process raft request'  (duration: 1.313651427s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:46.929261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:45.615099Z","time spent":"1.314118952s","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" mod_revision:2837 > success:<request_put:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" value_size:562 >> failure:<request_range:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-14T16:58:46.928914Z","caller":"traceutil/trace.go:171","msg":"trace[1562704602] linearizableReadLoop","detail":"{readStateIndex:2962; appliedIndex:2957; }","duration":"1.315577871s","start":"2026-07-14T16:58:45.613313Z","end":"2026-07-14T16:58:46.928891Z","steps":["trace[1562704602] 'read index received'  (duration: 681.829909ms)","trace[1562704602] 'applied index is now lower than readState.Index'  (duration: 633.746332ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T16:58:46.929327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:45.61336Z","time spent":"1.315612751s","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2835 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-07-14T16:58:46.92943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.306367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-07-14T16:58:46.929447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315668551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1249"}
{"level":"info","ts":"2026-07-14T16:58:46.929464Z","caller":"traceutil/trace.go:171","msg":"trace[1921454402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2851; }","duration":"341.376128ms","start":"2026-07-14T16:58:46.588079Z","end":"2026-07-14T16:58:46.929455Z","steps":["trace[1921454402] 'agreement among raft nodes before linearized reading'  (duration: 341.318617ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T16:58:46.929486Z","caller":"traceutil/trace.go:171","msg":"trace[902713096] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2851; }","duration":"1.315777032s","start":"2026-07-14T16:58:45.613696Z","end":"2026-07-14T16:58:46.929473Z","steps":["trace[902713096] 'agreement among raft nodes before linearized reading'  (duration: 1.315673821s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:46.929496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:46.588058Z","time spent":"341.432398ms","remote":"127.0.0.1:60096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-07-14T16:58:46.929516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:45.613676Z","time spent":"1.315832884s","remote":"127.0.0.1:60272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":1271,"request content":"key:\"/registry/services/specs/auth-system/keycloak\" "}
{"level":"warn","ts":"2026-07-14T16:58:46.929526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.148095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T16:58:46.929564Z","caller":"traceutil/trace.go:171","msg":"trace[772427455] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2851; }","duration":"277.226835ms","start":"2026-07-14T16:58:46.652328Z","end":"2026-07-14T16:58:46.929554Z","steps":["trace[772427455] 'agreement among raft nodes before linearized reading'  (duration: 277.166624ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:46.929659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.965119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T16:58:46.929714Z","caller":"traceutil/trace.go:171","msg":"trace[384795470] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:2851; }","duration":"903.99515ms","start":"2026-07-14T16:58:46.025683Z","end":"2026-07-14T16:58:46.929679Z","steps":["trace[384795470] 'agreement among raft nodes before linearized reading'  (duration: 903.948379ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:46.929707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.004213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11497"}
{"level":"warn","ts":"2026-07-14T16:58:46.929745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:46.025626Z","time spent":"904.110391ms","remote":"127.0.0.1:45950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"info","ts":"2026-07-14T16:58:46.929774Z","caller":"traceutil/trace.go:171","msg":"trace[1944355812] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2851; }","duration":"821.118565ms","start":"2026-07-14T16:58:46.108639Z","end":"2026-07-14T16:58:46.929758Z","steps":["trace[1944355812] 'agreement among raft nodes before linearized reading'  (duration: 820.883722ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:46.929816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:46.10862Z","time spent":"821.187455ms","remote":"127.0.0.1:60256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":11519,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-07-14T16:58:46.930291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.57892ms","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-07-14T16:58:46.930345Z","caller":"traceutil/trace.go:171","msg":"trace[133157432] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2851; }","duration":"590.276069ms","start":"2026-07-14T16:58:46.340057Z","end":"2026-07-14T16:58:46.930333Z","steps":["trace[133157432] 'agreement among raft nodes before linearized reading'  (duration: 589.585699ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T16:58:46.930406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T16:58:46.340037Z","time spent":"590.332259ms","remote":"127.0.0.1:45650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "}
{"level":"info","ts":"2026-07-14T16:59:43.521954Z","caller":"traceutil/trace.go:171","msg":"trace[1198182440] transaction","detail":"{read_only:false; response_revision:3324; number_of_response:1; }","duration":"134.045877ms","start":"2026-07-14T16:59:43.387874Z","end":"2026-07-14T16:59:43.52192Z","steps":["trace[1198182440] 'process raft request'  (duration: 133.902282ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:00:59.717417Z","caller":"traceutil/trace.go:171","msg":"trace[2010401077] transaction","detail":"{read_only:false; response_revision:4249; number_of_response:1; }","duration":"112.449327ms","start":"2026-07-14T17:00:59.604948Z","end":"2026-07-14T17:00:59.717397Z","steps":["trace[2010401077] 'process raft request'  (duration: 112.245852ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:00.203626Z","caller":"traceutil/trace.go:171","msg":"trace[670853901] transaction","detail":"{read_only:false; response_revision:4262; number_of_response:1; }","duration":"103.081693ms","start":"2026-07-14T17:01:00.100498Z","end":"2026-07-14T17:01:00.20358Z","steps":["trace[670853901] 'process raft request'  (duration: 102.886678ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:01.890155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.339141ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9485319006520193804 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/deployments/monitoring/kube-prometheus-stack-operator\" mod_revision:4101 > success:<request_put:<key:\"/registry/deployments/monitoring/kube-prometheus-stack-operator\" value_size:5359 >> failure:<request_range:<key:\"/registry/deployments/monitoring/kube-prometheus-stack-operator\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-14T17:01:01.890282Z","caller":"traceutil/trace.go:171","msg":"trace[1864258754] linearizableReadLoop","detail":"{readStateIndex:4503; appliedIndex:4501; }","duration":"275.469122ms","start":"2026-07-14T17:01:01.614794Z","end":"2026-07-14T17:01:01.890263Z","steps":["trace[1864258754] 'read index received'  (duration: 6.529804ms)","trace[1864258754] 'applied index is now lower than readState.Index'  (duration: 268.937738ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T17:01:01.890353Z","caller":"traceutil/trace.go:171","msg":"trace[1771815717] transaction","detail":"{read_only:false; response_revision:4316; number_of_response:1; }","duration":"279.072822ms","start":"2026-07-14T17:01:01.611268Z","end":"2026-07-14T17:01:01.890341Z","steps":["trace[1771815717] 'process raft request'  (duration: 161.457864ms)","trace[1771815717] 'compare'  (duration: 117.151376ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T17:01:01.890598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.79983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a0789e91-909c-490e-89ce-9bf5ba5294df\" ","response":"range_response_count:1 size:2708"}
{"level":"info","ts":"2026-07-14T17:01:01.890636Z","caller":"traceutil/trace.go:171","msg":"trace[991187703] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a0789e91-909c-490e-89ce-9bf5ba5294df; range_end:; response_count:1; response_revision:4316; }","duration":"275.860072ms","start":"2026-07-14T17:01:01.614766Z","end":"2026-07-14T17:01:01.890626Z","steps":["trace[991187703] 'agreement among raft nodes before linearized reading'  (duration: 275.730529ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:01.894446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.871447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a0789e91-909c-490e-89ce-9bf5ba5294df\" ","response":"range_response_count:1 size:2708"}
{"level":"info","ts":"2026-07-14T17:01:01.894484Z","caller":"traceutil/trace.go:171","msg":"trace[1933315603] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a0789e91-909c-490e-89ce-9bf5ba5294df; range_end:; response_count:1; response_revision:4316; }","duration":"270.946739ms","start":"2026-07-14T17:01:01.623527Z","end":"2026-07-14T17:01:01.894474Z","steps":["trace[1933315603] 'agreement among raft nodes before linearized reading'  (duration: 270.817806ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:01.894557Z","caller":"traceutil/trace.go:171","msg":"trace[1909890754] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4316; }","duration":"272.838955ms","start":"2026-07-14T17:01:01.621674Z","end":"2026-07-14T17:01:01.894513Z","steps":["trace[1909890754] 'process raft request'  (duration: 272.554748ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:01.894947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.214115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:46605"}
{"level":"info","ts":"2026-07-14T17:01:01.895015Z","caller":"traceutil/trace.go:171","msg":"trace[312856539] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4316; }","duration":"267.327988ms","start":"2026-07-14T17:01:01.627675Z","end":"2026-07-14T17:01:01.895003Z","steps":["trace[312856539] 'agreement among raft nodes before linearized reading'  (duration: 267.010641ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:01.895981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.583652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:46 size:2109536"}
{"level":"info","ts":"2026-07-14T17:01:01.89602Z","caller":"traceutil/trace.go:171","msg":"trace[549278107] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:46; response_revision:4316; }","duration":"164.651874ms","start":"2026-07-14T17:01:01.731359Z","end":"2026-07-14T17:01:01.896011Z","steps":["trace[549278107] 'agreement among raft nodes before linearized reading'  (duration: 163.508225ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:09.06432Z","caller":"traceutil/trace.go:171","msg":"trace[876439729] linearizableReadLoop","detail":"{readStateIndex:4671; appliedIndex:4670; }","duration":"128.106964ms","start":"2026-07-14T17:01:08.936195Z","end":"2026-07-14T17:01:09.064302Z","steps":["trace[876439729] 'read index received'  (duration: 37.557327ms)","trace[876439729] 'applied index is now lower than readState.Index'  (duration: 90.549007ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T17:01:09.064689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.468584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"}
{"level":"info","ts":"2026-07-14T17:01:09.064757Z","caller":"traceutil/trace.go:171","msg":"trace[340262782] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4480; }","duration":"128.588677ms","start":"2026-07-14T17:01:08.936155Z","end":"2026-07-14T17:01:09.064744Z","steps":["trace[340262782] 'agreement among raft nodes before linearized reading'  (duration: 128.356131ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:09.064982Z","caller":"traceutil/trace.go:171","msg":"trace[1307406264] transaction","detail":"{read_only:false; response_revision:4480; number_of_response:1; }","duration":"128.875164ms","start":"2026-07-14T17:01:08.936097Z","end":"2026-07-14T17:01:09.064972Z","steps":["trace[1307406264] 'process raft request'  (duration: 37.711491ms)","trace[1307406264] 'compare'  (duration: 90.414424ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T17:01:09.370249Z","caller":"traceutil/trace.go:171","msg":"trace[959329761] linearizableReadLoop","detail":"{readStateIndex:4690; appliedIndex:4689; }","duration":"101.137823ms","start":"2026-07-14T17:01:09.269084Z","end":"2026-07-14T17:01:09.370221Z","steps":["trace[959329761] 'read index received'  (duration: 101.02158ms)","trace[959329761] 'applied index is now lower than readState.Index'  (duration: 114.783µs)"],"step_count":2}
{"level":"info","ts":"2026-07-14T17:01:09.370327Z","caller":"traceutil/trace.go:171","msg":"trace[1319097558] transaction","detail":"{read_only:false; response_revision:4498; number_of_response:1; }","duration":"104.612699ms","start":"2026-07-14T17:01:09.265689Z","end":"2026-07-14T17:01:09.370301Z","steps":["trace[1319097558] 'process raft request'  (duration: 104.343902ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:09.370461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.67928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-p97zh-tls\" ","response":"range_response_count:1 size:2518"}
{"level":"info","ts":"2026-07-14T17:01:09.370601Z","caller":"traceutil/trace.go:171","msg":"trace[1828307409] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-p97zh-tls; range_end:; response_count:1; response_revision:4498; }","duration":"104.850564ms","start":"2026-07-14T17:01:09.265737Z","end":"2026-07-14T17:01:09.370587Z","steps":["trace[1828307409] 'agreement among raft nodes before linearized reading'  (duration: 104.615898ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:09.370587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.489849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"}
{"level":"info","ts":"2026-07-14T17:01:09.370671Z","caller":"traceutil/trace.go:171","msg":"trace[2145511776] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4498; }","duration":"107.602161ms","start":"2026-07-14T17:01:09.26305Z","end":"2026-07-14T17:01:09.370652Z","steps":["trace[2145511776] 'agreement among raft nodes before linearized reading'  (duration: 107.319725ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:09.399933Z","caller":"traceutil/trace.go:171","msg":"trace[183009532] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4498; }","duration":"117.175214ms","start":"2026-07-14T17:01:09.282729Z","end":"2026-07-14T17:01:09.399904Z","steps":["trace[183009532] 'process raft request'  (duration: 117.063681ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:09.400049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.405208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"}
{"level":"info","ts":"2026-07-14T17:01:09.400107Z","caller":"traceutil/trace.go:171","msg":"trace[949087731] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4498; }","duration":"126.49134ms","start":"2026-07-14T17:01:09.273602Z","end":"2026-07-14T17:01:09.400093Z","steps":["trace[949087731] 'agreement among raft nodes before linearized reading'  (duration: 126.307115ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:10.065697Z","caller":"traceutil/trace.go:171","msg":"trace[493871952] transaction","detail":"{read_only:false; response_revision:4507; number_of_response:1; }","duration":"114.457672ms","start":"2026-07-14T17:01:09.951216Z","end":"2026-07-14T17:01:10.065674Z","steps":["trace[493871952] 'process raft request'  (duration: 114.318229ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:11.26691Z","caller":"traceutil/trace.go:171","msg":"trace[445318601] transaction","detail":"{read_only:false; response_revision:4518; number_of_response:1; }","duration":"178.827058ms","start":"2026-07-14T17:01:11.088059Z","end":"2026-07-14T17:01:11.266886Z","steps":["trace[445318601] 'process raft request'  (duration: 178.673525ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:13.443186Z","caller":"traceutil/trace.go:171","msg":"trace[323228189] transaction","detail":"{read_only:false; response_revision:4586; number_of_response:1; }","duration":"168.377561ms","start":"2026-07-14T17:01:13.274782Z","end":"2026-07-14T17:01:13.443159Z","steps":["trace[323228189] 'process raft request'  (duration: 168.220477ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:14.169464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.168095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-p97zh-tls\" ","response":"range_response_count:1 size:2184"}
{"level":"warn","ts":"2026-07-14T17:01:14.16949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.211198ms","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-07-14T17:01:14.170852Z","caller":"traceutil/trace.go:171","msg":"trace[959281118] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-p97zh-tls; range_end:; response_count:1; response_revision:4586; }","duration":"532.564218ms","start":"2026-07-14T17:01:13.638212Z","end":"2026-07-14T17:01:14.170776Z","steps":["trace[959281118] 'range keys from in-memory index tree'  (duration: 530.96857ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:14.17091Z","caller":"traceutil/trace.go:171","msg":"trace[2041961557] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4586; }","duration":"488.658372ms","start":"2026-07-14T17:01:13.682221Z","end":"2026-07-14T17:01:14.170879Z","steps":["trace[2041961557] 'range keys from in-memory index tree'  (duration: 487.047553ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:14.17095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:13.638192Z","time spent":"532.706421ms","remote":"127.0.0.1:54604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":2206,"request content":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-p97zh-tls\" "}
{"level":"warn","ts":"2026-07-14T17:01:14.170989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:13.68221Z","time spent":"488.756494ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-07-14T17:01:14.16955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.255687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9fe4903a-10c0-4eeb-8971-6d77ee4807bc\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-07-14T17:01:14.171173Z","caller":"traceutil/trace.go:171","msg":"trace[580134766] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9fe4903a-10c0-4eeb-8971-6d77ee4807bc; range_end:; response_count:1; response_revision:4586; }","duration":"473.944008ms","start":"2026-07-14T17:01:13.697206Z","end":"2026-07-14T17:01:14.17115Z","steps":["trace[580134766] 'range keys from in-memory index tree'  (duration: 472.086724ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:14.17123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:13.697196Z","time spent":"474.01879ms","remote":"127.0.0.1:60256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9fe4903a-10c0-4eeb-8971-6d77ee4807bc\" "}
{"level":"warn","ts":"2026-07-14T17:01:14.169726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.124115ms","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-07-14T17:01:14.171594Z","caller":"traceutil/trace.go:171","msg":"trace[973644214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4586; }","duration":"488.914389ms","start":"2026-07-14T17:01:13.682576Z","end":"2026-07-14T17:01:14.171491Z","steps":["trace[973644214] 'range keys from in-memory index tree'  (duration: 487.030983ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:14.169794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.66579ms","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-07-14T17:01:14.171653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:13.682569Z","time spent":"489.069363ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-07-14T17:01:14.171662Z","caller":"traceutil/trace.go:171","msg":"trace[272664542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4586; }","duration":"514.562046ms","start":"2026-07-14T17:01:13.657079Z","end":"2026-07-14T17:01:14.171641Z","steps":["trace[272664542] 'range keys from in-memory index tree'  (duration: 512.551627ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:14.171714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:13.657059Z","time spent":"514.639227ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-07-14T17:01:16.308591Z","caller":"traceutil/trace.go:171","msg":"trace[302981811] linearizableReadLoop","detail":"{readStateIndex:4800; appliedIndex:4799; }","duration":"125.572462ms","start":"2026-07-14T17:01:16.182999Z","end":"2026-07-14T17:01:16.308572Z","steps":["trace[302981811] 'read index received'  (duration: 125.392988ms)","trace[302981811] 'applied index is now lower than readState.Index'  (duration: 178.734µs)"],"step_count":2}
{"level":"info","ts":"2026-07-14T17:01:16.308651Z","caller":"traceutil/trace.go:171","msg":"trace[33610967] transaction","detail":"{read_only:false; response_revision:4603; number_of_response:1; }","duration":"132.052548ms","start":"2026-07-14T17:01:16.176562Z","end":"2026-07-14T17:01:16.308615Z","steps":["trace[33610967] 'process raft request'  (duration: 131.854293ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:16.308796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.791169ms","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-07-14T17:01:16.308834Z","caller":"traceutil/trace.go:171","msg":"trace[1620035069] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4603; }","duration":"125.875351ms","start":"2026-07-14T17:01:16.182948Z","end":"2026-07-14T17:01:16.308823Z","steps":["trace[1620035069] 'agreement among raft nodes before linearized reading'  (duration: 125.727416ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:16.317113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.920504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-07-14T17:01:16.317144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.681154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9fe4903a-10c0-4eeb-8971-6d77ee4807bc\" ","response":"range_response_count:1 size:3952"}
{"level":"info","ts":"2026-07-14T17:01:16.317169Z","caller":"traceutil/trace.go:171","msg":"trace[699638599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4604; }","duration":"131.995868ms","start":"2026-07-14T17:01:16.185161Z","end":"2026-07-14T17:01:16.317156Z","steps":["trace[699638599] 'agreement among raft nodes before linearized reading'  (duration: 131.860873ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:16.317177Z","caller":"traceutil/trace.go:171","msg":"trace[1509119075] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9fe4903a-10c0-4eeb-8971-6d77ee4807bc; range_end:; response_count:1; response_revision:4604; }","duration":"101.743906ms","start":"2026-07-14T17:01:16.215424Z","end":"2026-07-14T17:01:16.317168Z","steps":["trace[1509119075] 'agreement among raft nodes before linearized reading'  (duration: 101.602922ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:16.317273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.321885ms","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-07-14T17:01:16.317312Z","caller":"traceutil/trace.go:171","msg":"trace[1775897389] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4604; }","duration":"132.384256ms","start":"2026-07-14T17:01:16.184917Z","end":"2026-07-14T17:01:16.317301Z","steps":["trace[1775897389] 'agreement among raft nodes before linearized reading'  (duration: 132.256723ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:16.317338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.053092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-14T17:01:16.317358Z","caller":"traceutil/trace.go:171","msg":"trace[1943071744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4604; }","duration":"133.101603ms","start":"2026-07-14T17:01:16.18425Z","end":"2026-07-14T17:01:16.317352Z","steps":["trace[1943071744] 'agreement among raft nodes before linearized reading'  (duration: 133.045162ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:16.803376Z","caller":"traceutil/trace.go:171","msg":"trace[556569250] linearizableReadLoop","detail":"{readStateIndex:4808; appliedIndex:4807; }","duration":"127.698674ms","start":"2026-07-14T17:01:16.675652Z","end":"2026-07-14T17:01:16.80335Z","steps":["trace[556569250] 'read index received'  (duration: 112.934773ms)","trace[556569250] 'applied index is now lower than readState.Index'  (duration: 14.762631ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T17:01:16.8035Z","caller":"traceutil/trace.go:171","msg":"trace[1946822397] transaction","detail":"{read_only:false; response_revision:4611; number_of_response:1; }","duration":"169.683114ms","start":"2026-07-14T17:01:16.633804Z","end":"2026-07-14T17:01:16.803487Z","steps":["trace[1946822397] 'process raft request'  (duration: 154.864181ms)","trace[1946822397] 'compare'  (duration: 14.574917ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T17:01:16.803678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.007061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"}
{"level":"info","ts":"2026-07-14T17:01:16.803761Z","caller":"traceutil/trace.go:171","msg":"trace[803246897] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4611; }","duration":"128.137284ms","start":"2026-07-14T17:01:16.675601Z","end":"2026-07-14T17:01:16.803739Z","steps":["trace[803246897] 'agreement among raft nodes before linearized reading'  (duration: 127.94626ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:21.60858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.986686ms","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-07-14T17:01:21.608654Z","caller":"traceutil/trace.go:171","msg":"trace[1253728542] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4690; }","duration":"246.078928ms","start":"2026-07-14T17:01:21.362558Z","end":"2026-07-14T17:01:21.608636Z","steps":["trace[1253728542] 'count revisions from in-memory index tree'  (duration: 245.877033ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:21.609021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.677095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:524"}
{"level":"info","ts":"2026-07-14T17:01:21.6091Z","caller":"traceutil/trace.go:171","msg":"trace[651044349] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4690; }","duration":"103.804378ms","start":"2026-07-14T17:01:21.505276Z","end":"2026-07-14T17:01:21.609081Z","steps":["trace[651044349] 'range keys from in-memory index tree'  (duration: 103.439598ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:21.609212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.562972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T17:01:21.609301Z","caller":"traceutil/trace.go:171","msg":"trace[1910545489] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:4690; }","duration":"656.703075ms","start":"2026-07-14T17:01:20.952575Z","end":"2026-07-14T17:01:21.609278Z","steps":["trace[1910545489] 'count revisions from in-memory index tree'  (duration: 656.414538ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:21.609365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:20.952554Z","time spent":"656.799107ms","remote":"127.0.0.1:33170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true "}
{"level":"info","ts":"2026-07-14T17:01:25.74278Z","caller":"traceutil/trace.go:171","msg":"trace[1755380825] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"108.622511ms","start":"2026-07-14T17:01:25.634134Z","end":"2026-07-14T17:01:25.742757Z","steps":["trace[1755380825] 'process raft request'  (duration: 108.479238ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:29.411927Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9485319006520195005,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-07-14T17:01:29.912817Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9485319006520195005,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-07-14T17:01:30.252485Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.400410679s","expected-duration":"1s"}
{"level":"info","ts":"2026-07-14T17:01:30.252944Z","caller":"traceutil/trace.go:171","msg":"trace[1404395212] linearizableReadLoop","detail":"{readStateIndex:4994; appliedIndex:4993; }","duration":"1.342098816s","start":"2026-07-14T17:01:28.910823Z","end":"2026-07-14T17:01:30.252922Z","steps":["trace[1404395212] 'read index received'  (duration: 1.341949413s)","trace[1404395212] 'applied index is now lower than readState.Index'  (duration: 148.543µs)"],"step_count":2}
{"level":"info","ts":"2026-07-14T17:01:30.253052Z","caller":"traceutil/trace.go:171","msg":"trace[1059288159] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"1.419376564s","start":"2026-07-14T17:01:28.833656Z","end":"2026-07-14T17:01:30.253033Z","steps":["trace[1059288159] 'process raft request'  (duration: 1.419104068s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.253169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:28.833641Z","time spent":"1.419453717s","remote":"127.0.0.1:60256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10794,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" mod_revision:4666 > success:<request_put:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" value_size:10735 >> failure:<request_range:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" > >"}
{"level":"warn","ts":"2026-07-14T17:01:30.253285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.342449185s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-07-14T17:01:30.253348Z","caller":"traceutil/trace.go:171","msg":"trace[2109079213] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4790; }","duration":"1.342544266s","start":"2026-07-14T17:01:28.910785Z","end":"2026-07-14T17:01:30.253329Z","steps":["trace[2109079213] 'agreement among raft nodes before linearized reading'  (duration: 1.3422611s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.253397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:28.910769Z","time spent":"1.342618498s","remote":"127.0.0.1:60234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-07-14T17:01:30.65237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.753614ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9485319006520195007 > lease_revoke:<id:03a29f618ce5b5f4>","response":"size:27"}
{"level":"info","ts":"2026-07-14T17:01:30.652487Z","caller":"traceutil/trace.go:171","msg":"trace[1451781042] linearizableReadLoop","detail":"{readStateIndex:4995; appliedIndex:4994; }","duration":"399.45942ms","start":"2026-07-14T17:01:30.253007Z","end":"2026-07-14T17:01:30.652466Z","steps":["trace[1451781042] 'read index received'  (duration: 121.730716ms)","trace[1451781042] 'applied index is now lower than readState.Index'  (duration: 277.726814ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T17:01:30.652562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.629566ms","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-07-14T17:01:30.652719Z","caller":"traceutil/trace.go:171","msg":"trace[1653982010] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4790; }","duration":"741.831031ms","start":"2026-07-14T17:01:29.910853Z","end":"2026-07-14T17:01:30.652684Z","steps":["trace[1653982010] 'agreement among raft nodes before linearized reading'  (duration: 741.617056ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.65277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:29.910832Z","time spent":"741.923833ms","remote":"127.0.0.1:41094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-07-14T17:01:30.65277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.065050258s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-07-14T17:01:30.652939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15143967s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-14T17:01:30.653025Z","caller":"traceutil/trace.go:171","msg":"trace[494953836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4790; }","duration":"1.065379915s","start":"2026-07-14T17:01:29.587631Z","end":"2026-07-14T17:01:30.653011Z","steps":["trace[494953836] 'agreement among raft nodes before linearized reading'  (duration: 1.065053648s)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:30.653088Z","caller":"traceutil/trace.go:171","msg":"trace[796907577] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:4790; }","duration":"1.151632995s","start":"2026-07-14T17:01:29.501392Z","end":"2026-07-14T17:01:30.653025Z","steps":["trace[796907577] 'agreement among raft nodes before linearized reading'  (duration: 1.151318157s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.653504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:29.587616Z","time spent":"1.065871287s","remote":"127.0.0.1:60094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-07-14T17:01:30.653566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:29.501372Z","time spent":"1.152172576s","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":69,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "}
{"level":"warn","ts":"2026-07-14T17:01:30.652845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.716183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T17:01:30.653683Z","caller":"traceutil/trace.go:171","msg":"trace[640425041] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:4790; }","duration":"607.577012ms","start":"2026-07-14T17:01:30.046084Z","end":"2026-07-14T17:01:30.653661Z","steps":["trace[640425041] 'agreement among raft nodes before linearized reading'  (duration: 606.554209ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.653167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.657477341s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T17:01:30.653774Z","caller":"traceutil/trace.go:171","msg":"trace[899350790] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4790; }","duration":"1.658114536s","start":"2026-07-14T17:01:28.995645Z","end":"2026-07-14T17:01:30.653759Z","steps":["trace[899350790] 'agreement among raft nodes before linearized reading'  (duration: 1.657457311s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.653793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:30.046027Z","time spent":"607.745555ms","remote":"127.0.0.1:41042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true "}
{"level":"warn","ts":"2026-07-14T17:01:30.653182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.707596135s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-07-14T17:01:30.653891Z","caller":"traceutil/trace.go:171","msg":"trace[1050902215] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4790; }","duration":"1.708331822s","start":"2026-07-14T17:01:28.945546Z","end":"2026-07-14T17:01:30.653878Z","steps":["trace[1050902215] 'agreement among raft nodes before linearized reading'  (duration: 1.707389911s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.653849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:28.995633Z","time spent":"1.658202268s","remote":"127.0.0.1:60096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-07-14T17:01:30.653286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.584300861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2319"}
{"level":"info","ts":"2026-07-14T17:01:30.654121Z","caller":"traceutil/trace.go:171","msg":"trace[324996001] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:4790; }","duration":"1.585166632s","start":"2026-07-14T17:01:29.068936Z","end":"2026-07-14T17:01:30.654103Z","steps":["trace[324996001] 'agreement among raft nodes before linearized reading'  (duration: 1.58373156s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.654172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:29.06892Z","time spent":"1.585237013s","remote":"127.0.0.1:54604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":1,"response size":2341,"request content":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" "}
{"level":"warn","ts":"2026-07-14T17:01:30.653359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.415574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:524"}
{"level":"info","ts":"2026-07-14T17:01:30.654308Z","caller":"traceutil/trace.go:171","msg":"trace[1079477259] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4790; }","duration":"899.401456ms","start":"2026-07-14T17:01:29.754895Z","end":"2026-07-14T17:01:30.654297Z","steps":["trace[1079477259] 'agreement among raft nodes before linearized reading'  (duration: 897.651387ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.654344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:29.754878Z","time spent":"899.456707ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":546,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "}
{"level":"warn","ts":"2026-07-14T17:01:30.653974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:28.945536Z","time spent":"1.708406053s","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":682,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-14T17:01:30.653167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.710669345s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"}
{"level":"info","ts":"2026-07-14T17:01:30.654574Z","caller":"traceutil/trace.go:171","msg":"trace[670688125] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4790; }","duration":"1.712072088s","start":"2026-07-14T17:01:28.942481Z","end":"2026-07-14T17:01:30.654553Z","steps":["trace[670688125] 'agreement among raft nodes before linearized reading'  (duration: 1.710538652s)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.654631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:28.942389Z","time spent":"1.712225182s","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":667,"request content":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-07-14T17:01:30.659863Z","caller":"traceutil/trace.go:171","msg":"trace[1020494844] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"398.713502ms","start":"2026-07-14T17:01:30.261133Z","end":"2026-07-14T17:01:30.659847Z","steps":["trace[1020494844] 'process raft request'  (duration: 398.473497ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:30.660054Z","caller":"traceutil/trace.go:171","msg":"trace[228467695] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"397.382911ms","start":"2026-07-14T17:01:30.262649Z","end":"2026-07-14T17:01:30.660032Z","steps":["trace[228467695] 'process raft request'  (duration: 397.174577ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.660704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:30.261115Z","time spent":"398.790624ms","remote":"127.0.0.1:60342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-4gqsf\" mod_revision:4528 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-4gqsf\" value_size:1434 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-4gqsf\" > >"}
{"level":"warn","ts":"2026-07-14T17:01:30.660853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:30.262618Z","time spent":"398.105879ms","remote":"127.0.0.1:60342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-gvf4s\" mod_revision:4534 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-gvf4s\" value_size:1363 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-gvf4s\" > >"}
{"level":"warn","ts":"2026-07-14T17:01:30.660936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.161907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9fe4903a-10c0-4eeb-8971-6d77ee4807bc\" ","response":"range_response_count:1 size:1322"}
{"level":"warn","ts":"2026-07-14T17:01:30.660102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.53529ms","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-07-14T17:01:30.660997Z","caller":"traceutil/trace.go:171","msg":"trace[271217236] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9fe4903a-10c0-4eeb-8971-6d77ee4807bc; range_end:; response_count:1; response_revision:4795; }","duration":"404.235699ms","start":"2026-07-14T17:01:30.256748Z","end":"2026-07-14T17:01:30.660984Z","steps":["trace[271217236] 'agreement among raft nodes before linearized reading'  (duration: 403.449081ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:30.661084Z","caller":"traceutil/trace.go:171","msg":"trace[310279932] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4795; }","duration":"174.521132ms","start":"2026-07-14T17:01:30.486533Z","end":"2026-07-14T17:01:30.661054Z","steps":["trace[310279932] 'agreement among raft nodes before linearized reading'  (duration: 173.503539ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.661107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:30.256735Z","time spent":"404.348002ms","remote":"127.0.0.1:60220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1344,"request content":"key:\"/registry/persistentvolumes/pvc-9fe4903a-10c0-4eeb-8971-6d77ee4807bc\" "}
{"level":"warn","ts":"2026-07-14T17:01:30.660131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.284677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-07-14T17:01:30.661217Z","caller":"traceutil/trace.go:171","msg":"trace[1815899483] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4795; }","duration":"161.433304ms","start":"2026-07-14T17:01:30.499765Z","end":"2026-07-14T17:01:30.661198Z","steps":["trace[1815899483] 'agreement among raft nodes before linearized reading'  (duration: 160.211505ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.660184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.53829ms","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-07-14T17:01:30.661347Z","caller":"traceutil/trace.go:171","msg":"trace[1590125617] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4795; }","duration":"177.710007ms","start":"2026-07-14T17:01:30.483628Z","end":"2026-07-14T17:01:30.661338Z","steps":["trace[1590125617] 'agreement among raft nodes before linearized reading'  (duration: 176.494808ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.660235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.039067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-07-14T17:01:30.661417Z","caller":"traceutil/trace.go:171","msg":"trace[1554856719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4795; }","duration":"180.228053ms","start":"2026-07-14T17:01:30.48118Z","end":"2026-07-14T17:01:30.661408Z","steps":["trace[1554856719] 'agreement among raft nodes before linearized reading'  (duration: 178.954594ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:30.6603Z","caller":"traceutil/trace.go:171","msg":"trace[1317708108] transaction","detail":"{read_only:false; response_revision:4795; number_of_response:1; }","duration":"304.911566ms","start":"2026-07-14T17:01:30.355376Z","end":"2026-07-14T17:01:30.660287Z","steps":["trace[1317708108] 'process raft request'  (duration: 304.474995ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.660314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.340069ms","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-07-14T17:01:30.661655Z","caller":"traceutil/trace.go:171","msg":"trace[1672235010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4795; }","duration":"178.676328ms","start":"2026-07-14T17:01:30.482939Z","end":"2026-07-14T17:01:30.661616Z","steps":["trace[1672235010] 'agreement among raft nodes before linearized reading'  (duration: 177.319548ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:30.660361Z","caller":"traceutil/trace.go:171","msg":"trace[1626213246] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"399.125033ms","start":"2026-07-14T17:01:30.261223Z","end":"2026-07-14T17:01:30.660348Z","steps":["trace[1626213246] 'process raft request'  (duration: 398.512568ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.661772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:30.261218Z","time spent":"400.517254ms","remote":"127.0.0.1:60238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" mod_revision:4530 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" value_size:881 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" > >"}
{"level":"info","ts":"2026-07-14T17:01:30.660586Z","caller":"traceutil/trace.go:171","msg":"trace[168875977] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"398.864837ms","start":"2026-07-14T17:01:30.261711Z","end":"2026-07-14T17:01:30.660576Z","steps":["trace[168875977] 'process raft request'  (duration: 398.078108ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.661961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:30.261701Z","time spent":"400.236537ms","remote":"127.0.0.1:60238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" mod_revision:4533 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" > >"}
{"level":"warn","ts":"2026-07-14T17:01:30.661535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:30.355351Z","time spent":"306.120964ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:4776 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-07-14T17:01:30.832496Z","caller":"traceutil/trace.go:171","msg":"trace[328486020] linearizableReadLoop","detail":"{readStateIndex:5006; appliedIndex:5001; }","duration":"125.012501ms","start":"2026-07-14T17:01:30.70744Z","end":"2026-07-14T17:01:30.832453Z","steps":["trace[328486020] 'read index received'  (duration: 124.568641ms)","trace[328486020] 'applied index is now lower than readState.Index'  (duration: 442.89µs)"],"step_count":2}
{"level":"info","ts":"2026-07-14T17:01:30.832885Z","caller":"traceutil/trace.go:171","msg":"trace[372811617] transaction","detail":"{read_only:false; response_revision:4798; number_of_response:1; }","duration":"166.207053ms","start":"2026-07-14T17:01:30.666648Z","end":"2026-07-14T17:01:30.832855Z","steps":["trace[372811617] 'process raft request'  (duration: 165.60228ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:30.832893Z","caller":"traceutil/trace.go:171","msg":"trace[625609740] transaction","detail":"{read_only:false; response_revision:4801; number_of_response:1; }","duration":"166.071119ms","start":"2026-07-14T17:01:30.666797Z","end":"2026-07-14T17:01:30.832868Z","steps":["trace[625609740] 'process raft request'  (duration: 165.611429ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:30.832901Z","caller":"traceutil/trace.go:171","msg":"trace[538174810] transaction","detail":"{read_only:false; response_revision:4800; number_of_response:1; }","duration":"166.07051ms","start":"2026-07-14T17:01:30.666772Z","end":"2026-07-14T17:01:30.832843Z","steps":["trace[538174810] 'process raft request'  (duration: 165.587609ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.833066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.601607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:4788"}
{"level":"info","ts":"2026-07-14T17:01:30.833152Z","caller":"traceutil/trace.go:171","msg":"trace[646822593] transaction","detail":"{read_only:false; response_revision:4797; number_of_response:1; }","duration":"166.629273ms","start":"2026-07-14T17:01:30.666509Z","end":"2026-07-14T17:01:30.833138Z","steps":["trace[646822593] 'process raft request'  (duration: 165.533068ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:30.833267Z","caller":"traceutil/trace.go:171","msg":"trace[1371427737] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"166.506709ms","start":"2026-07-14T17:01:30.666752Z","end":"2026-07-14T17:01:30.833259Z","steps":["trace[1371427737] 'process raft request'  (duration: 165.555328ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:30.833304Z","caller":"traceutil/trace.go:171","msg":"trace[648943976] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:4801; }","duration":"168.870044ms","start":"2026-07-14T17:01:30.66441Z","end":"2026-07-14T17:01:30.833281Z","steps":["trace[648943976] 'agreement among raft nodes before linearized reading'  (duration: 168.480225ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.83357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.006657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T17:01:30.833626Z","caller":"traceutil/trace.go:171","msg":"trace[499136703] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4801; }","duration":"169.092839ms","start":"2026-07-14T17:01:30.664517Z","end":"2026-07-14T17:01:30.83361Z","steps":["trace[499136703] 'agreement among raft nodes before linearized reading'  (duration: 168.996627ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:30.84446Z","caller":"traceutil/trace.go:171","msg":"trace[1157926065] transaction","detail":"{read_only:false; response_revision:4802; number_of_response:1; }","duration":"130.978256ms","start":"2026-07-14T17:01:30.713464Z","end":"2026-07-14T17:01:30.844442Z","steps":["trace[1157926065] 'process raft request'  (duration: 130.523866ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:30.844583Z","caller":"traceutil/trace.go:171","msg":"trace[1528050075] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"130.912395ms","start":"2026-07-14T17:01:30.713647Z","end":"2026-07-14T17:01:30.844559Z","steps":["trace[1528050075] 'process raft request'  (duration: 130.555547ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:30.845094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.276836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-p97zh.18c236a1447870a2\" ","response":"range_response_count:1 size:906"}
{"level":"info","ts":"2026-07-14T17:01:30.845178Z","caller":"traceutil/trace.go:171","msg":"trace[808341121] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-p97zh.18c236a1447870a2; range_end:; response_count:1; response_revision:4803; }","duration":"111.407709ms","start":"2026-07-14T17:01:30.733752Z","end":"2026-07-14T17:01:30.845159Z","steps":["trace[808341121] 'agreement among raft nodes before linearized reading'  (duration: 111.185513ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:01:31.378672Z","caller":"traceutil/trace.go:171","msg":"trace[1761597342] transaction","detail":"{read_only:false; response_revision:4807; number_of_response:1; }","duration":"360.153838ms","start":"2026-07-14T17:01:31.018497Z","end":"2026-07-14T17:01:31.378651Z","steps":["trace[1761597342] 'process raft request'  (duration: 360.013505ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:01:31.378804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:01:31.01846Z","time spent":"360.275061ms","remote":"127.0.0.1:60514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16430,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" mod_revision:4761 > success:<request_put:<key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" value_size:16370 >> failure:<request_range:<key:\"/registry/statefulsets/openstack/percona-xtradb-pxc\" > >"}
{"level":"info","ts":"2026-07-14T17:01:31.584512Z","caller":"traceutil/trace.go:171","msg":"trace[484001558] transaction","detail":"{read_only:false; response_revision:4808; number_of_response:1; }","duration":"123.841995ms","start":"2026-07-14T17:01:31.460638Z","end":"2026-07-14T17:01:31.58448Z","steps":["trace[484001558] 'process raft request'  (duration: 79.433783ms)","trace[484001558] 'compare'  (duration: 44.236449ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T17:01:59.687355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.171648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-14T17:01:59.687416Z","caller":"traceutil/trace.go:171","msg":"trace[1420167478] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:5045; }","duration":"103.281011ms","start":"2026-07-14T17:01:59.58412Z","end":"2026-07-14T17:01:59.687401Z","steps":["trace[1420167478] 'count revisions from in-memory index tree'  (duration: 103.067096ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:02:03.679876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.821042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-07-14T17:02:03.679966Z","caller":"traceutil/trace.go:171","msg":"trace[2049420987] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5161; }","duration":"343.954796ms","start":"2026-07-14T17:02:03.33599Z","end":"2026-07-14T17:02:03.679945Z","steps":["trace[2049420987] 'range keys from in-memory index tree'  (duration: 343.667029ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:02:03.680012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:02:03.335978Z","time spent":"344.021487ms","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":682,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-14T17:02:03.680201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.557118ms","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-07-14T17:02:03.680282Z","caller":"traceutil/trace.go:171","msg":"trace[2137338654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5161; }","duration":"354.683281ms","start":"2026-07-14T17:02:03.325577Z","end":"2026-07-14T17:02:03.680261Z","steps":["trace[2137338654] 'range keys from in-memory index tree'  (duration: 354.373994ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:02:03.680324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:02:03.325559Z","time spent":"354.756492ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-07-14T17:02:03.680525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.814483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"}
{"level":"info","ts":"2026-07-14T17:02:03.680574Z","caller":"traceutil/trace.go:171","msg":"trace[957858208] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5161; }","duration":"344.888705ms","start":"2026-07-14T17:02:03.335674Z","end":"2026-07-14T17:02:03.680562Z","steps":["trace[957858208] 'range keys from in-memory index tree'  (duration: 344.67082ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:02:03.680605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:02:03.335658Z","time spent":"344.940086ms","remote":"127.0.0.1:60188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":667,"request content":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-14T17:02:03.680522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.356528ms","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-07-14T17:02:03.681154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.933273ms","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-07-14T17:02:03.681189Z","caller":"traceutil/trace.go:171","msg":"trace[1834979852] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5161; }","duration":"422.011925ms","start":"2026-07-14T17:02:03.259167Z","end":"2026-07-14T17:02:03.681179Z","steps":["trace[1834979852] 'range keys from in-memory index tree'  (duration: 421.738319ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:02:03.681216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:02:03.259146Z","time spent":"422.063747ms","remote":"127.0.0.1:60340","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":"info","ts":"2026-07-14T17:02:03.680834Z","caller":"traceutil/trace.go:171","msg":"trace[514389471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5161; }","duration":"358.678114ms","start":"2026-07-14T17:02:03.322132Z","end":"2026-07-14T17:02:03.68081Z","steps":["trace[514389471] 'range keys from in-memory index tree'  (duration: 358.125043ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:02:03.681296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:02:03.32208Z","time spent":"359.197985ms","remote":"127.0.0.1:60340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-07-14T17:02:12.955706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.788136ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9485319006520196175 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" mod_revision:0 > success:<request_put:<key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" value_size:7315 >> failure:<>>","response":"size:5"}
{"level":"info","ts":"2026-07-14T17:02:12.955803Z","caller":"traceutil/trace.go:171","msg":"trace[1842266085] linearizableReadLoop","detail":"{readStateIndex:5450; appliedIndex:5449; }","duration":"157.91496ms","start":"2026-07-14T17:02:12.797872Z","end":"2026-07-14T17:02:12.955787Z","steps":["trace[1842266085] 'read index received'  (duration: 45.231µs)","trace[1842266085] 'applied index is now lower than readState.Index'  (duration: 157.868759ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T17:02:12.955957Z","caller":"traceutil/trace.go:171","msg":"trace[1574289936] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5226; }","duration":"329.232444ms","start":"2026-07-14T17:02:12.626714Z","end":"2026-07-14T17:02:12.955947Z","steps":["trace[1574289936] 'process raft request'  (duration: 51.136552ms)","trace[1574289936] 'compare'  (duration: 277.734585ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T17:02:12.956032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:02:12.626695Z","time spent":"329.298645ms","remote":"127.0.0.1:60514","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" mod_revision:0 > success:<request_put:<key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" value_size:7315 >> failure:<>"}
{"level":"warn","ts":"2026-07-14T17:02:12.956111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.214845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-14T17:02:12.956196Z","caller":"traceutil/trace.go:171","msg":"trace[1790344548] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:5226; }","duration":"158.355049ms","start":"2026-07-14T17:02:12.797819Z","end":"2026-07-14T17:02:12.956174Z","steps":["trace[1790344548] 'agreement among raft nodes before linearized reading'  (duration: 158.147354ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:02:12.964556Z","caller":"traceutil/trace.go:171","msg":"trace[819593307] transaction","detail":"{read_only:false; response_revision:5227; number_of_response:1; }","duration":"144.83795ms","start":"2026-07-14T17:02:12.819682Z","end":"2026-07-14T17:02:12.96452Z","steps":["trace[819593307] 'process raft request'  (duration: 144.646956ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:02:13.162829Z","caller":"traceutil/trace.go:171","msg":"trace[163225727] linearizableReadLoop","detail":"{readStateIndex:5453; appliedIndex:5452; }","duration":"129.193772ms","start":"2026-07-14T17:02:13.033583Z","end":"2026-07-14T17:02:13.162777Z","steps":["trace[163225727] 'read index received'  (duration: 48.296352ms)","trace[163225727] 'applied index is now lower than readState.Index'  (duration: 80.89567ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T17:02:13.162977Z","caller":"traceutil/trace.go:171","msg":"trace[1164759662] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"188.615064ms","start":"2026-07-14T17:02:12.974346Z","end":"2026-07-14T17:02:13.162961Z","steps":["trace[1164759662] 'process raft request'  (duration: 107.621021ms)","trace[1164759662] 'compare'  (duration: 80.635116ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-14T17:02:13.163235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.643792ms","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-07-14T17:02:13.163276Z","caller":"traceutil/trace.go:171","msg":"trace[83115721] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5229; }","duration":"129.736913ms","start":"2026-07-14T17:02:13.033529Z","end":"2026-07-14T17:02:13.163266Z","steps":["trace[83115721] 'agreement among raft nodes before linearized reading'  (duration: 129.58693ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-14T17:02:13.163332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.496786ms","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-07-14T17:02:13.163465Z","caller":"traceutil/trace.go:171","msg":"trace[468671405] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5229; }","duration":"125.67218ms","start":"2026-07-14T17:02:13.037771Z","end":"2026-07-14T17:02:13.163444Z","steps":["trace[468671405] 'agreement among raft nodes before linearized reading'  (duration: 125.332893ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:02:26.724431Z","caller":"traceutil/trace.go:171","msg":"trace[1134559879] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"134.703848ms","start":"2026-07-14T17:02:26.589684Z","end":"2026-07-14T17:02:26.724388Z","steps":["trace[1134559879] 'process raft request'  (duration: 134.411943ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:02:27.401985Z","caller":"traceutil/trace.go:171","msg":"trace[476164409] transaction","detail":"{read_only:false; response_revision:5350; number_of_response:1; }","duration":"138.172693ms","start":"2026-07-14T17:02:27.263783Z","end":"2026-07-14T17:02:27.401955Z","steps":["trace[476164409] 'process raft request'  (duration: 113.299777ms)","trace[476164409] 'compare'  (duration: 24.59483ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T17:04:12.082621Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3021}
{"level":"info","ts":"2026-07-14T17:04:12.176452Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3021,"took":"92.602741ms","hash":3684628356,"current-db-size-bytes":56807424,"current-db-size":"57 MB","current-db-size-in-use-bytes":30789632,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-14T17:04:12.176522Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3684628356,"revision":3021,"compact-revision":-1}
{"level":"info","ts":"2026-07-14T17:05:12.663308Z","caller":"traceutil/trace.go:171","msg":"trace[55594020] transaction","detail":"{read_only:false; number_of_response:0; response_revision:6724; }","duration":"169.930246ms","start":"2026-07-14T17:05:12.493351Z","end":"2026-07-14T17:05:12.663281Z","steps":["trace[55594020] 'process raft request'  (duration: 169.818315ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:05:33.0975Z","caller":"traceutil/trace.go:171","msg":"trace[1443680011] transaction","detail":"{read_only:false; response_revision:6915; number_of_response:1; }","duration":"141.00312ms","start":"2026-07-14T17:05:32.956469Z","end":"2026-07-14T17:05:33.097472Z","steps":["trace[1443680011] 'process raft request'  (duration: 140.898338ms)"],"step_count":1}
{"level":"info","ts":"2026-07-14T17:05:33.097592Z","caller":"traceutil/trace.go:171","msg":"trace[945251491] transaction","detail":"{read_only:false; response_revision:6914; number_of_response:1; }","duration":"141.565239ms","start":"2026-07-14T17:05:32.95597Z","end":"2026-07-14T17:05:33.097535Z","steps":["trace[945251491] 'process raft request'  (duration: 86.765219ms)","trace[945251491] 'compare'  (duration: 54.043818ms)"],"step_count":2}
{"level":"info","ts":"2026-07-14T17:05:33.458102Z","caller":"traceutil/trace.go:171","msg":"trace[644215104] transaction","detail":"{read_only:false; response_revision:6917; number_of_response:1; }","duration":"143.138233ms","start":"2026-07-14T17:05:33.314935Z","end":"2026-07-14T17:05:33.458073Z","steps":["trace[644215104] 'process raft request'  (duration: 80.906016ms)","trace[644215104] 'compare'  (duration: 62.077085ms)"],"step_count":2}