{"level":"warn","ts":"2026-10-16T00:01:38.369418Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-16T00:01:38.369491Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.149:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.149:2380","--initial-cluster=instance=https://162.253.55.149:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.149:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.149: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-10-16T00:01:38.369547Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-16T00:01:38.369554Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.149:2380"]}
{"level":"info","ts":"2026-10-16T00:01:38.369569Z","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-10-16T00:01:38.370119Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.149:2379"]}
{"level":"info","ts":"2026-10-16T00:01:38.370189Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.149:2380"],"listen-peer-urls":["https://162.253.55.149:2380"],"advertise-client-urls":["https://162.253.55.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.149: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-10-16T00:01:38.374845Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.470439ms"}
{"level":"info","ts":"2026-10-16T00:01:38.38723Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab61124f07c17f20","cluster-id":"c5f62e84ad801ad2"}
{"level":"info","ts":"2026-10-16T00:01:38.387294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-16T00:01:38.387312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became follower at term 0"}
{"level":"info","ts":"2026-10-16T00:01:38.387319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab61124f07c17f20 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-16T00:01:38.387325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became follower at term 1"}
{"level":"info","ts":"2026-10-16T00:01:38.387353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=(12349171783868448544)"}
{"level":"warn","ts":"2026-10-16T00:01:38.392822Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-16T00:01:38.394015Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-16T00:01:38.396761Z","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-10-16T00:01:38.398864Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab61124f07c17f20","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-16T00:01:38.401747Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab61124f07c17f20","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-16T00:01:38.401917Z","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-10-16T00:01:38.40204Z","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-10-16T00:01:38.402077Z","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-10-16T00:01:38.402789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 switched to configuration voters=(12349171783868448544)"}
{"level":"info","ts":"2026-10-16T00:01:38.402829Z","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-10-16T00:01:38.403032Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c5f62e84ad801ad2","local-member-id":"ab61124f07c17f20","added-peer-id":"ab61124f07c17f20","added-peer-peer-urls":["https://162.253.55.149:2380"]}
{"level":"info","ts":"2026-10-16T00:01:38.403068Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab61124f07c17f20","initial-advertise-peer-urls":["https://162.253.55.149:2380"],"listen-peer-urls":["https://162.253.55.149:2380"],"advertise-client-urls":["https://162.253.55.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-16T00:01:38.403106Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-16T00:01:38.403124Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.149:2380"}
{"level":"info","ts":"2026-10-16T00:01:38.40318Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.149:2380"}
{"level":"info","ts":"2026-10-16T00:01:38.588177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-16T00:01:38.588256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-16T00:01:38.588276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 received MsgPreVoteResp from ab61124f07c17f20 at term 1"}
{"level":"info","ts":"2026-10-16T00:01:38.588291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became candidate at term 2"}
{"level":"info","ts":"2026-10-16T00:01:38.588298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 received MsgVoteResp from ab61124f07c17f20 at term 2"}
{"level":"info","ts":"2026-10-16T00:01:38.588308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab61124f07c17f20 became leader at term 2"}
{"level":"info","ts":"2026-10-16T00:01:38.588318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab61124f07c17f20 elected leader ab61124f07c17f20 at term 2"}
{"level":"info","ts":"2026-10-16T00:01:38.590036Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab61124f07c17f20","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.149:2379]}","request-path":"/0/members/ab61124f07c17f20/attributes","cluster-id":"c5f62e84ad801ad2","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-16T00:01:38.59019Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-16T00:01:38.590265Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-16T00:01:38.590536Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-16T00:01:38.590552Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-16T00:01:38.592597Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-16T00:01:38.592756Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-16T00:01:38.594439Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.149:2379"}
{"level":"info","ts":"2026-10-16T00:01:38.599337Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c5f62e84ad801ad2","local-member-id":"ab61124f07c17f20","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-16T00:01:38.59942Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-16T00:01:38.599438Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-16T00:01:40.929669Z","caller":"traceutil/trace.go:171","msg":"trace[193377127] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"134.549602ms","start":"2026-10-16T00:01:40.79509Z","end":"2026-10-16T00:01:40.929639Z","steps":["trace[193377127] 'process raft request'  (duration: 134.211115ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:01:40.929729Z","caller":"traceutil/trace.go:171","msg":"trace[784234939] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"151.78421ms","start":"2026-10-16T00:01:40.77793Z","end":"2026-10-16T00:01:40.929714Z","steps":["trace[784234939] 'process raft request'  (duration: 97.57979ms)","trace[784234939] 'compare'  (duration: 53.635327ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:02:23.748353Z","caller":"traceutil/trace.go:171","msg":"trace[433035471] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"125.689315ms","start":"2026-10-16T00:02:23.622615Z","end":"2026-10-16T00:02:23.748304Z","steps":["trace[433035471] 'process raft request'  (duration: 125.509901ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:02:30.235697Z","caller":"traceutil/trace.go:171","msg":"trace[1440996490] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"145.276481ms","start":"2026-10-16T00:02:30.090394Z","end":"2026-10-16T00:02:30.23567Z","steps":["trace[1440996490] 'process raft request'  (duration: 145.084957ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:02:30.399532Z","caller":"traceutil/trace.go:171","msg":"trace[543988445] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:633; }","duration":"202.197517ms","start":"2026-10-16T00:02:30.197308Z","end":"2026-10-16T00:02:30.399506Z","steps":["trace[543988445] 'read index received'  (duration: 38.085154ms)","trace[543988445] 'applied index is now lower than readState.Index'  (duration: 164.111253ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:02:30.399736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.401711ms","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-10-16T00:02:30.399783Z","caller":"traceutil/trace.go:171","msg":"trace[94986483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:608; }","duration":"202.505884ms","start":"2026-10-16T00:02:30.197267Z","end":"2026-10-16T00:02:30.399773Z","steps":["trace[94986483] 'agreement among raft nodes before linearized reading'  (duration: 202.353021ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:02:30.400047Z","caller":"traceutil/trace.go:171","msg":"trace[1695398126] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"242.850171ms","start":"2026-10-16T00:02:30.157187Z","end":"2026-10-16T00:02:30.400037Z","steps":["trace[1695398126] 'process raft request'  (duration: 240.924614ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:02:31.025304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.984057ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498946972866603 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:592 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-16T00:02:31.025514Z","caller":"traceutil/trace.go:171","msg":"trace[480332282] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:635; }","duration":"287.945009ms","start":"2026-10-16T00:02:30.737553Z","end":"2026-10-16T00:02:31.025498Z","steps":["trace[480332282] 'read index received'  (duration: 35.913472ms)","trace[480332282] 'applied index is now lower than readState.Index'  (duration: 252.030417ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:02:31.025594Z","caller":"traceutil/trace.go:171","msg":"trace[838559936] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"547.327818ms","start":"2026-10-16T00:02:30.478258Z","end":"2026-10-16T00:02:31.025586Z","steps":["trace[838559936] 'process raft request'  (duration: 547.168195ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:02:31.025645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:02:30.478226Z","time spent":"547.39097ms","remote":"127.0.0.1:41662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-10-16T00:02:31.025679Z","caller":"traceutil/trace.go:171","msg":"trace[1984663245] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"603.606954ms","start":"2026-10-16T00:02:30.422035Z","end":"2026-10-16T00:02:31.025642Z","steps":["trace[1984663245] 'process raft request'  (duration: 351.296271ms)","trace[1984663245] 'compare'  (duration: 250.705902ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:02:31.02576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:02:30.422004Z","time spent":"603.714216ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:592 > 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-10-16T00:02:31.025867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.321117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T00:02:31.025901Z","caller":"traceutil/trace.go:171","msg":"trace[213665513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"288.396108ms","start":"2026-10-16T00:02:30.737496Z","end":"2026-10-16T00:02:31.025892Z","steps":["trace[213665513] 'agreement among raft nodes before linearized reading'  (duration: 288.325537ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:02:31.026096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.861399ms","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-10-16T00:02:31.026135Z","caller":"traceutil/trace.go:171","msg":"trace[696761270] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:610; }","duration":"188.972162ms","start":"2026-10-16T00:02:30.837152Z","end":"2026-10-16T00:02:31.026124Z","steps":["trace[696761270] 'agreement among raft nodes before linearized reading'  (duration: 188.85465ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:02:32.379461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.762252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.149\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-10-16T00:02:32.379547Z","caller":"traceutil/trace.go:171","msg":"trace[1833603699] range","detail":"{range_begin:/registry/masterleases/162.253.55.149; range_end:; response_count:1; response_revision:632; }","duration":"104.878814ms","start":"2026-10-16T00:02:32.274648Z","end":"2026-10-16T00:02:32.379527Z","steps":["trace[1833603699] 'range keys from in-memory index tree'  (duration: 104.586589ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:02:45.420791Z","caller":"traceutil/trace.go:171","msg":"trace[803885072] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"166.762577ms","start":"2026-10-16T00:02:45.254003Z","end":"2026-10-16T00:02:45.420765Z","steps":["trace[803885072] 'process raft request'  (duration: 166.623404ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:03:24.866705Z","caller":"traceutil/trace.go:171","msg":"trace[289145498] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"102.453534ms","start":"2026-10-16T00:03:24.764227Z","end":"2026-10-16T00:03:24.866681Z","steps":["trace[289145498] 'read index received'  (duration: 102.21455ms)","trace[289145498] 'applied index is now lower than readState.Index'  (duration: 237.914µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:03:24.866917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.664668ms","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-10-16T00:03:24.866869Z","caller":"traceutil/trace.go:171","msg":"trace[1928616908] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"105.641581ms","start":"2026-10-16T00:03:24.761091Z","end":"2026-10-16T00:03:24.866733Z","steps":["trace[1928616908] 'process raft request'  (duration: 105.415657ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:03:24.866967Z","caller":"traceutil/trace.go:171","msg":"trace[785593214] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1253; }","duration":"102.725589ms","start":"2026-10-16T00:03:24.764224Z","end":"2026-10-16T00:03:24.86695Z","steps":["trace[785593214] 'agreement among raft nodes before linearized reading'  (duration: 102.554456ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:03:37.500972Z","caller":"traceutil/trace.go:171","msg":"trace[457007524] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"148.189261ms","start":"2026-10-16T00:03:37.352718Z","end":"2026-10-16T00:03:37.500907Z","steps":["trace[457007524] 'process raft request'  (duration: 114.157665ms)","trace[457007524] 'compare'  (duration: 33.778202ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:03:37.500985Z","caller":"traceutil/trace.go:171","msg":"trace[1775361375] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"146.010012ms","start":"2026-10-16T00:03:37.354946Z","end":"2026-10-16T00:03:37.500956Z","steps":["trace[1775361375] 'process raft request'  (duration: 145.86123ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:04:04.507688Z","caller":"traceutil/trace.go:171","msg":"trace[1032916466] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"103.953705ms","start":"2026-10-16T00:04:04.403708Z","end":"2026-10-16T00:04:04.507662Z","steps":["trace[1032916466] 'process raft request'  (duration: 103.755432ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:04:04.507748Z","caller":"traceutil/trace.go:171","msg":"trace[62812184] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"100.579105ms","start":"2026-10-16T00:04:04.407149Z","end":"2026-10-16T00:04:04.507728Z","steps":["trace[62812184] 'process raft request'  (duration: 100.443113ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:07.295765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.407395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-10-16T00:04:07.295914Z","caller":"traceutil/trace.go:171","msg":"trace[872630682] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1854; }","duration":"325.597208ms","start":"2026-10-16T00:04:06.970289Z","end":"2026-10-16T00:04:07.295887Z","steps":["trace[872630682] 'range keys from in-memory index tree'  (duration: 325.220572ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:07.295962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:06.970265Z","time spent":"325.68548ms","remote":"127.0.0.1:40082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-10-16T00:04:07.322557Z","caller":"traceutil/trace.go:171","msg":"trace[1664690392] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1930; }","duration":"108.264908ms","start":"2026-10-16T00:04:07.214274Z","end":"2026-10-16T00:04:07.322539Z","steps":["trace[1664690392] 'read index received'  (duration: 108.145506ms)","trace[1664690392] 'applied index is now lower than readState.Index'  (duration: 116.652µs)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:04:07.322631Z","caller":"traceutil/trace.go:171","msg":"trace[1040591976] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"224.878973ms","start":"2026-10-16T00:04:07.097717Z","end":"2026-10-16T00:04:07.322596Z","steps":["trace[1040591976] 'process raft request'  (duration: 224.69412ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:07.322728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.459772ms","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-10-16T00:04:07.322759Z","caller":"traceutil/trace.go:171","msg":"trace[173131987] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1855; }","duration":"108.532243ms","start":"2026-10-16T00:04:07.214217Z","end":"2026-10-16T00:04:07.322749Z","steps":["trace[173131987] 'agreement among raft nodes before linearized reading'  (duration: 108.40029ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:04:07.7463Z","caller":"traceutil/trace.go:171","msg":"trace[299851847] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1932; }","duration":"141.279816ms","start":"2026-10-16T00:04:07.604983Z","end":"2026-10-16T00:04:07.746263Z","steps":["trace[299851847] 'read index received'  (duration: 87.430362ms)","trace[299851847] 'applied index is now lower than readState.Index'  (duration: 53.843664ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:04:07.746425Z","caller":"traceutil/trace.go:171","msg":"trace[1386243373] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"105.084583ms","start":"2026-10-16T00:04:07.641313Z","end":"2026-10-16T00:04:07.746398Z","steps":["trace[1386243373] 'process raft request'  (duration: 104.789168ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:07.760966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.953504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-92fd9424-a4df-4577-ae7f-ae30f8153519\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-10-16T00:04:07.761073Z","caller":"traceutil/trace.go:171","msg":"trace[627539628] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-92fd9424-a4df-4577-ae7f-ae30f8153519; range_end:; response_count:1; response_revision:1857; }","duration":"156.056596ms","start":"2026-10-16T00:04:07.604971Z","end":"2026-10-16T00:04:07.761027Z","steps":["trace[627539628] 'agreement among raft nodes before linearized reading'  (duration: 141.379019ms)","trace[627539628] 'range keys from in-memory index tree'  (duration: 14.401702ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:04:20.732125Z","caller":"traceutil/trace.go:171","msg":"trace[201951873] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"107.891891ms","start":"2026-10-16T00:04:20.624207Z","end":"2026-10-16T00:04:20.732099Z","steps":["trace[201951873] 'process raft request'  (duration: 79.302593ms)","trace[201951873] 'compare'  (duration: 28.483187ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:04:24.575987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.871609ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498946972869398 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1982 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-16T00:04:24.57608Z","caller":"traceutil/trace.go:171","msg":"trace[1065383626] linearizableReadLoop","detail":"{readStateIndex:2074; appliedIndex:2073; }","duration":"521.198129ms","start":"2026-10-16T00:04:24.054865Z","end":"2026-10-16T00:04:24.576063Z","steps":["trace[1065383626] 'read index received'  (duration: 244.191516ms)","trace[1065383626] 'applied index is now lower than readState.Index'  (duration: 277.005063ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:04:24.576255Z","caller":"traceutil/trace.go:171","msg":"trace[38947260] transaction","detail":"{read_only:false; response_revision:1994; number_of_response:1; }","duration":"524.240704ms","start":"2026-10-16T00:04:24.051997Z","end":"2026-10-16T00:04:24.576238Z","steps":["trace[38947260] 'process raft request'  (duration: 247.047016ms)","trace[38947260] 'compare'  (duration: 276.310053ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:04:24.576311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:24.05198Z","time spent":"524.299716ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1982 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-10-16T00:04:24.576503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.6133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T00:04:24.57657Z","caller":"traceutil/trace.go:171","msg":"trace[1076813646] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1994; }","duration":"521.719204ms","start":"2026-10-16T00:04:24.054833Z","end":"2026-10-16T00:04:24.576552Z","steps":["trace[1076813646] 'agreement among raft nodes before linearized reading'  (duration: 521.5835ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:24.576608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:24.054819Z","time spent":"521.778655ms","remote":"127.0.0.1:38524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"info","ts":"2026-10-16T00:04:24.611677Z","caller":"traceutil/trace.go:171","msg":"trace[69880942] transaction","detail":"{read_only:false; response_revision:1995; number_of_response:1; }","duration":"431.927168ms","start":"2026-10-16T00:04:24.179715Z","end":"2026-10-16T00:04:24.611642Z","steps":["trace[69880942] 'process raft request'  (duration: 431.764764ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:24.611781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.519261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-16T00:04:24.611837Z","caller":"traceutil/trace.go:171","msg":"trace[1717158132] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1995; }","duration":"203.630424ms","start":"2026-10-16T00:04:24.408194Z","end":"2026-10-16T00:04:24.611824Z","steps":["trace[1717158132] 'agreement among raft nodes before linearized reading'  (duration: 203.515741ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:24.611818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.216996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T00:04:24.611893Z","caller":"traceutil/trace.go:171","msg":"trace[1436282762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1995; }","duration":"427.325019ms","start":"2026-10-16T00:04:24.184547Z","end":"2026-10-16T00:04:24.611872Z","steps":["trace[1436282762] 'agreement among raft nodes before linearized reading'  (duration: 427.190116ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:24.611925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:24.184532Z","time spent":"427.384631ms","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-16T00:04:24.611909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:24.179688Z","time spent":"432.108523ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1984 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-16T00:04:24.611955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.204132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-10-16T00:04:24.612004Z","caller":"traceutil/trace.go:171","msg":"trace[1292405546] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1995; }","duration":"203.275545ms","start":"2026-10-16T00:04:24.408712Z","end":"2026-10-16T00:04:24.611988Z","steps":["trace[1292405546] 'agreement among raft nodes before linearized reading'  (duration: 203.12191ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:24.612125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.83438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"info","ts":"2026-10-16T00:04:24.612161Z","caller":"traceutil/trace.go:171","msg":"trace[1789160977] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1995; }","duration":"486.932492ms","start":"2026-10-16T00:04:24.125218Z","end":"2026-10-16T00:04:24.612151Z","steps":["trace[1789160977] 'agreement among raft nodes before linearized reading'  (duration: 486.388477ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:24.612186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:24.125198Z","time spent":"486.981493ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-16T00:04:24.613104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.113929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-10-16T00:04:24.613157Z","caller":"traceutil/trace.go:171","msg":"trace[548547672] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1995; }","duration":"112.192842ms","start":"2026-10-16T00:04:24.500948Z","end":"2026-10-16T00:04:24.61314Z","steps":["trace[548547672] 'agreement among raft nodes before linearized reading'  (duration: 111.317437ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:47.997504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.983627ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498946972869724 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:2067 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-16T00:04:47.997668Z","caller":"traceutil/trace.go:171","msg":"trace[120861152] linearizableReadLoop","detail":"{readStateIndex:2206; appliedIndex:2204; }","duration":"459.876767ms","start":"2026-10-16T00:04:47.537763Z","end":"2026-10-16T00:04:47.99764Z","steps":["trace[120861152] 'read index received'  (duration: 26.180449ms)","trace[120861152] 'applied index is now lower than readState.Index'  (duration: 433.694138ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:04:47.998289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.498493ms","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-10-16T00:04:47.99843Z","caller":"traceutil/trace.go:171","msg":"trace[734736626] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2122; }","duration":"460.717409ms","start":"2026-10-16T00:04:47.537683Z","end":"2026-10-16T00:04:47.9984Z","steps":["trace[734736626] 'agreement among raft nodes before linearized reading'  (duration: 460.304308ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:47.998491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:47.537645Z","time spent":"460.830882ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-10-16T00:04:47.998313Z","caller":"traceutil/trace.go:171","msg":"trace[1915605227] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"460.297028ms","start":"2026-10-16T00:04:47.537693Z","end":"2026-10-16T00:04:47.99799Z","steps":["trace[1915605227] 'process raft request'  (duration: 178.638413ms)","trace[1915605227] 'compare'  (duration: 280.824923ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:04:47.99875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:47.537654Z","time spent":"460.914084ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:2067 > 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-10-16T00:04:48.013116Z","caller":"traceutil/trace.go:171","msg":"trace[998856668] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"381.297218ms","start":"2026-10-16T00:04:47.631789Z","end":"2026-10-16T00:04:48.013086Z","steps":["trace[998856668] 'process raft request'  (duration: 380.969489ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:48.013283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:47.631753Z","time spent":"381.432941ms","remote":"127.0.0.1:33230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8538,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:1932 > success:<request_put:<key:\"/registry/minions/instance\" value_size:8504 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-10-16T00:04:48.239843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.900389ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498946972869726 > lease_revoke:<id:7f20a14203a86378>","response":"size:29"}
{"level":"info","ts":"2026-10-16T00:04:48.240307Z","caller":"traceutil/trace.go:171","msg":"trace[1698489474] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"344.904725ms","start":"2026-10-16T00:04:47.895374Z","end":"2026-10-16T00:04:48.240279Z","steps":["trace[1698489474] 'process raft request'  (duration: 344.638278ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:48.240459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:47.895345Z","time spent":"345.022848ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2114 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-10-16T00:04:48.240452Z","caller":"traceutil/trace.go:171","msg":"trace[928182237] linearizableReadLoop","detail":"{readStateIndex:2209; appliedIndex:2206; }","duration":"242.718425ms","start":"2026-10-16T00:04:47.997702Z","end":"2026-10-16T00:04:48.240421Z","steps":["trace[928182237] 'read index received'  (duration: 15.043676ms)","trace[928182237] 'applied index is now lower than readState.Index'  (duration: 227.673529ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:04:48.241099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.142533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-10-16T00:04:48.241138Z","caller":"traceutil/trace.go:171","msg":"trace[289748671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2125; }","duration":"252.205045ms","start":"2026-10-16T00:04:47.98892Z","end":"2026-10-16T00:04:48.241125Z","steps":["trace[289748671] 'agreement among raft nodes before linearized reading'  (duration: 251.991159ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:48.241211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.056836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-10-16T00:04:48.241264Z","caller":"traceutil/trace.go:171","msg":"trace[193530502] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2125; }","duration":"433.154239ms","start":"2026-10-16T00:04:47.808093Z","end":"2026-10-16T00:04:48.241247Z","steps":["trace[193530502] 'agreement among raft nodes before linearized reading'  (duration: 432.910502ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:48.2413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:47.808079Z","time spent":"433.21282ms","remote":"127.0.0.1:40082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-10-16T00:04:48.24137Z","caller":"traceutil/trace.go:171","msg":"trace[891251016] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"237.092007ms","start":"2026-10-16T00:04:48.004266Z","end":"2026-10-16T00:04:48.241358Z","steps":["trace[891251016] 'process raft request'  (duration: 235.945037ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:48.241558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.582211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T00:04:48.241596Z","caller":"traceutil/trace.go:171","msg":"trace[872987136] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2125; }","duration":"302.650333ms","start":"2026-10-16T00:04:47.938935Z","end":"2026-10-16T00:04:48.241585Z","steps":["trace[872987136] 'agreement among raft nodes before linearized reading'  (duration: 302.585751ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:48.241624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:47.938922Z","time spent":"302.694213ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-10-16T00:04:48.241689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.085595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T00:04:48.241724Z","caller":"traceutil/trace.go:171","msg":"trace[1070804109] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2125; }","duration":"504.164128ms","start":"2026-10-16T00:04:47.73755Z","end":"2026-10-16T00:04:48.241714Z","steps":["trace[1070804109] 'agreement among raft nodes before linearized reading'  (duration: 504.106526ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:04:48.241749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:04:47.737528Z","time spent":"504.216059ms","remote":"127.0.0.1:33074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-16T00:04:48.242453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.867537ms","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-10-16T00:04:48.243288Z","caller":"traceutil/trace.go:171","msg":"trace[827736274] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2125; }","duration":"155.74073ms","start":"2026-10-16T00:04:48.087515Z","end":"2026-10-16T00:04:48.243256Z","steps":["trace[827736274] 'agreement among raft nodes before linearized reading'  (duration: 154.831817ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:04:48.499575Z","caller":"traceutil/trace.go:171","msg":"trace[1632190919] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"249.536264ms","start":"2026-10-16T00:04:48.249971Z","end":"2026-10-16T00:04:48.499508Z","steps":["trace[1632190919] 'process raft request'  (duration: 179.671759ms)","trace[1632190919] 'compare'  (duration: 69.497875ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:05:58.720223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.267592ms","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-10-16T00:05:58.720325Z","caller":"traceutil/trace.go:171","msg":"trace[1040593337] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2544; }","duration":"109.431046ms","start":"2026-10-16T00:05:58.610871Z","end":"2026-10-16T00:05:58.720302Z","steps":["trace[1040593337] 'range keys from in-memory index tree'  (duration: 109.054256ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:06:40.411611Z","caller":"traceutil/trace.go:171","msg":"trace[856947723] transaction","detail":"{read_only:false; response_revision:2831; number_of_response:1; }","duration":"185.894354ms","start":"2026-10-16T00:06:40.225659Z","end":"2026-10-16T00:06:40.411553Z","steps":["trace[856947723] 'process raft request'  (duration: 185.723241ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:06:45.814535Z","caller":"traceutil/trace.go:171","msg":"trace[1266535311] linearizableReadLoop","detail":"{readStateIndex:2972; appliedIndex:2971; }","duration":"163.5025ms","start":"2026-10-16T00:06:45.651006Z","end":"2026-10-16T00:06:45.814508Z","steps":["trace[1266535311] 'read index received'  (duration: 163.242155ms)","trace[1266535311] 'applied index is now lower than readState.Index'  (duration: 259.205µs)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:06:45.814575Z","caller":"traceutil/trace.go:171","msg":"trace[448779590] transaction","detail":"{read_only:false; response_revision:2861; number_of_response:1; }","duration":"188.15864ms","start":"2026-10-16T00:06:45.626379Z","end":"2026-10-16T00:06:45.814538Z","steps":["trace[448779590] 'process raft request'  (duration: 187.949086ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:06:45.814871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.012313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-16T00:06:45.814876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.845737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T00:06:45.815196Z","caller":"traceutil/trace.go:171","msg":"trace[1685637372] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:2861; }","duration":"118.362351ms","start":"2026-10-16T00:06:45.696815Z","end":"2026-10-16T00:06:45.815178Z","steps":["trace[1685637372] 'agreement among raft nodes before linearized reading'  (duration: 117.8771ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:06:45.815297Z","caller":"traceutil/trace.go:171","msg":"trace[898251218] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2861; }","duration":"164.278197ms","start":"2026-10-16T00:06:45.650988Z","end":"2026-10-16T00:06:45.815266Z","steps":["trace[898251218] 'agreement among raft nodes before linearized reading'  (duration: 163.778196ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:10:19.136774Z","caller":"traceutil/trace.go:171","msg":"trace[1719953593] linearizableReadLoop","detail":"{readStateIndex:4293; appliedIndex:4292; }","duration":"102.77574ms","start":"2026-10-16T00:10:19.033965Z","end":"2026-10-16T00:10:19.136741Z","steps":["trace[1719953593] 'read index received'  (duration: 98.54095ms)","trace[1719953593] 'applied index is now lower than readState.Index'  (duration: 4.23294ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:10:19.136809Z","caller":"traceutil/trace.go:171","msg":"trace[373245999] transaction","detail":"{read_only:false; response_revision:4129; number_of_response:1; }","duration":"103.535624ms","start":"2026-10-16T00:10:19.033248Z","end":"2026-10-16T00:10:19.136783Z","steps":["trace[373245999] 'process raft request'  (duration: 99.392706ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:10:19.137011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.938053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T00:10:19.138147Z","caller":"traceutil/trace.go:171","msg":"trace[1016468884] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4129; }","duration":"104.214017ms","start":"2026-10-16T00:10:19.033915Z","end":"2026-10-16T00:10:19.138129Z","steps":["trace[1016468884] 'agreement among raft nodes before linearized reading'  (duration: 102.954773ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:03.379667Z","caller":"traceutil/trace.go:171","msg":"trace[230279696] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"102.773472ms","start":"2026-10-16T00:11:03.276858Z","end":"2026-10-16T00:11:03.379632Z","steps":["trace[230279696] 'process raft request'  (duration: 81.654977ms)","trace[230279696] 'compare'  (duration: 20.714137ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:11:04.053109Z","caller":"traceutil/trace.go:171","msg":"trace[506669122] transaction","detail":"{read_only:false; response_revision:4798; number_of_response:1; }","duration":"292.337347ms","start":"2026-10-16T00:11:03.760747Z","end":"2026-10-16T00:11:04.053084Z","steps":["trace[506669122] 'process raft request'  (duration: 292.123813ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:04.080096Z","caller":"traceutil/trace.go:171","msg":"trace[1369893180] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"230.335258ms","start":"2026-10-16T00:11:03.849746Z","end":"2026-10-16T00:11:04.080081Z","steps":["trace[1369893180] 'process raft request'  (duration: 230.184115ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:04.080494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.505323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-patch-8hk62\" ","response":"range_response_count:1 size:4659"}
{"level":"info","ts":"2026-10-16T00:11:04.080584Z","caller":"traceutil/trace.go:171","msg":"trace[757506323] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-admission-patch-8hk62; range_end:; response_count:1; response_revision:4799; }","duration":"136.701847ms","start":"2026-10-16T00:11:03.943867Z","end":"2026-10-16T00:11:04.080569Z","steps":["trace[757506323] 'agreement among raft nodes before linearized reading'  (duration: 136.261829ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:04.080768Z","caller":"traceutil/trace.go:171","msg":"trace[1353408901] linearizableReadLoop","detail":"{readStateIndex:4989; appliedIndex:4987; }","duration":"136.117216ms","start":"2026-10-16T00:11:03.943922Z","end":"2026-10-16T00:11:04.08004Z","steps":["trace[1353408901] 'read index received'  (duration: 108.989879ms)","trace[1353408901] 'applied index is now lower than readState.Index'  (duration: 27.124217ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:11:04.081177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.496629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f97aa8f1-9162-4046-8627-d3cd69cd2216\" ","response":"range_response_count:1 size:3774"}
{"level":"info","ts":"2026-10-16T00:11:04.08124Z","caller":"traceutil/trace.go:171","msg":"trace[995129471] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f97aa8f1-9162-4046-8627-d3cd69cd2216; range_end:; response_count:1; response_revision:4799; }","duration":"115.607152ms","start":"2026-10-16T00:11:03.965612Z","end":"2026-10-16T00:11:04.081219Z","steps":["trace[995129471] 'agreement among raft nodes before linearized reading'  (duration: 115.322027ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:10.163982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.294749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"}
{"level":"info","ts":"2026-10-16T00:11:10.164046Z","caller":"traceutil/trace.go:171","msg":"trace[623429821] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4928; }","duration":"104.40577ms","start":"2026-10-16T00:11:10.059627Z","end":"2026-10-16T00:11:10.164033Z","steps":["trace[623429821] 'range keys from in-memory index tree'  (duration: 104.151336ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:10.920121Z","caller":"traceutil/trace.go:171","msg":"trace[2031448075] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"178.75944ms","start":"2026-10-16T00:11:10.741339Z","end":"2026-10-16T00:11:10.920098Z","steps":["trace[2031448075] 'process raft request'  (duration: 118.446993ms)","trace[2031448075] 'compare'  (duration: 60.147734ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:11:10.924189Z","caller":"traceutil/trace.go:171","msg":"trace[186425155] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"182.453359ms","start":"2026-10-16T00:11:10.741712Z","end":"2026-10-16T00:11:10.924165Z","steps":["trace[186425155] 'process raft request'  (duration: 182.202124ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:15.094682Z","caller":"traceutil/trace.go:171","msg":"trace[1169112067] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"131.759639ms","start":"2026-10-16T00:11:14.962899Z","end":"2026-10-16T00:11:15.094658Z","steps":["trace[1169112067] 'process raft request'  (duration: 131.708988ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:15.094764Z","caller":"traceutil/trace.go:171","msg":"trace[1704752990] transaction","detail":"{read_only:false; response_revision:4963; number_of_response:1; }","duration":"131.900902ms","start":"2026-10-16T00:11:14.962768Z","end":"2026-10-16T00:11:15.094669Z","steps":["trace[1704752990] 'process raft request'  (duration: 93.690789ms)","trace[1704752990] 'compare'  (duration: 38.02248ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:11:16.906094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.779461ms","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-10-16T00:11:16.906167Z","caller":"traceutil/trace.go:171","msg":"trace[108293186] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4982; }","duration":"444.890213ms","start":"2026-10-16T00:11:16.46126Z","end":"2026-10-16T00:11:16.90615Z","steps":["trace[108293186] 'range keys from in-memory index tree'  (duration: 444.629048ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:16.906203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:11:16.461206Z","time spent":"444.987935ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-10-16T00:11:16.906291Z","caller":"traceutil/trace.go:171","msg":"trace[797261279] linearizableReadLoop","detail":"{readStateIndex:5180; appliedIndex:5179; }","duration":"177.603735ms","start":"2026-10-16T00:11:16.728671Z","end":"2026-10-16T00:11:16.906275Z","steps":["trace[797261279] 'read index received'  (duration: 176.736618ms)","trace[797261279] 'applied index is now lower than readState.Index'  (duration: 866.257µs)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:11:16.906476Z","caller":"traceutil/trace.go:171","msg":"trace[1629641818] transaction","detail":"{read_only:false; response_revision:4983; number_of_response:1; }","duration":"377.996294ms","start":"2026-10-16T00:11:16.528467Z","end":"2026-10-16T00:11:16.906463Z","steps":["trace[1629641818] 'process raft request'  (duration: 376.952365ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:16.906582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:11:16.528451Z","time spent":"378.059385ms","remote":"127.0.0.1:59512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2724,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" mod_revision:4982 > success:<request_put:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" value_size:2649 >> failure:<request_range:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" > >"}
{"level":"warn","ts":"2026-10-16T00:11:16.906589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.91891ms","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-10-16T00:11:16.906669Z","caller":"traceutil/trace.go:171","msg":"trace[302636926] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4983; }","duration":"178.031793ms","start":"2026-10-16T00:11:16.728624Z","end":"2026-10-16T00:11:16.906656Z","steps":["trace[302636926] 'agreement among raft nodes before linearized reading'  (duration: 177.920971ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:16.906681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.537493ms","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-10-16T00:11:16.906767Z","caller":"traceutil/trace.go:171","msg":"trace[1429648288] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4982; }","duration":"409.669175ms","start":"2026-10-16T00:11:16.497075Z","end":"2026-10-16T00:11:16.906744Z","steps":["trace[1429648288] 'range keys from in-memory index tree'  (duration: 409.37026ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:16.906674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.148277ms","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":"warn","ts":"2026-10-16T00:11:16.906834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:11:16.497062Z","time spent":"409.756437ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-10-16T00:11:16.906844Z","caller":"traceutil/trace.go:171","msg":"trace[1072289370] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:4982; }","duration":"408.336601ms","start":"2026-10-16T00:11:16.498494Z","end":"2026-10-16T00:11:16.90683Z","steps":["trace[1072289370] 'count revisions from in-memory index tree'  (duration: 408.098796ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:16.906943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.841539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"}
{"level":"info","ts":"2026-10-16T00:11:16.906968Z","caller":"traceutil/trace.go:171","msg":"trace[1521275632] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4983; }","duration":"162.90681ms","start":"2026-10-16T00:11:16.744054Z","end":"2026-10-16T00:11:16.906961Z","steps":["trace[1521275632] 'agreement among raft nodes before linearized reading'  (duration: 162.817799ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:16.906992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:11:16.498483Z","time spent":"408.475263ms","remote":"127.0.0.1:38522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-10-16T00:11:16.907124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.997171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-b6cf94ff9-p8j52.18deda12bbd6105b\" ","response":"range_response_count:1 size:895"}
{"level":"info","ts":"2026-10-16T00:11:16.907219Z","caller":"traceutil/trace.go:171","msg":"trace[1984107959] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-b6cf94ff9-p8j52.18deda12bbd6105b; range_end:; response_count:1; response_revision:4983; }","duration":"163.146345ms","start":"2026-10-16T00:11:16.744054Z","end":"2026-10-16T00:11:16.9072Z","steps":["trace[1984107959] 'agreement among raft nodes before linearized reading'  (duration: 162.721967ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:17.249086Z","caller":"traceutil/trace.go:171","msg":"trace[997619753] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"131.475324ms","start":"2026-10-16T00:11:17.117558Z","end":"2026-10-16T00:11:17.249033Z","steps":["trace[997619753] 'process raft request'  (duration: 131.254509ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:17.249217Z","caller":"traceutil/trace.go:171","msg":"trace[1193699150] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"128.224462ms","start":"2026-10-16T00:11:17.120968Z","end":"2026-10-16T00:11:17.249193Z","steps":["trace[1193699150] 'process raft request'  (duration: 127.968058ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:17.249486Z","caller":"traceutil/trace.go:171","msg":"trace[797811115] transaction","detail":"{read_only:false; response_revision:5004; number_of_response:1; }","duration":"127.00961ms","start":"2026-10-16T00:11:17.122464Z","end":"2026-10-16T00:11:17.249473Z","steps":["trace[797811115] 'process raft request'  (duration: 126.624033ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:17.24949Z","caller":"traceutil/trace.go:171","msg":"trace[1775800083] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"126.594293ms","start":"2026-10-16T00:11:17.122877Z","end":"2026-10-16T00:11:17.249471Z","steps":["trace[1775800083] 'process raft request'  (duration: 126.502591ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:17.250528Z","caller":"traceutil/trace.go:171","msg":"trace[1866034692] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"127.419728ms","start":"2026-10-16T00:11:17.121948Z","end":"2026-10-16T00:11:17.249368Z","steps":["trace[1866034692] 'process raft request'  (duration: 127.054081ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:17.596946Z","caller":"traceutil/trace.go:171","msg":"trace[2146227352] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"454.333508ms","start":"2026-10-16T00:11:17.142591Z","end":"2026-10-16T00:11:17.596924Z","steps":["trace[2146227352] 'process raft request'  (duration: 454.270437ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:17.597028Z","caller":"traceutil/trace.go:171","msg":"trace[701993590] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"459.878391ms","start":"2026-10-16T00:11:17.137107Z","end":"2026-10-16T00:11:17.596986Z","steps":["trace[701993590] 'process raft request'  (duration: 459.596696ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:17.597283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:11:17.137084Z","time spent":"460.044514ms","remote":"127.0.0.1:33132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18deda130f1ebd6c\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18deda130f1ebd6c\" value_size:706 lease:9160498946972876876 >> failure:<>"}
{"level":"warn","ts":"2026-10-16T00:11:17.597315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:11:17.14258Z","time spent":"454.43134ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:4965 > 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-10-16T00:11:17.818888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.751345ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498946972876943 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-keystone.18deda1316298a65\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-keystone.18deda1316298a65\" value_size:659 lease:9160498946972876876 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-10-16T00:11:17.81921Z","caller":"traceutil/trace.go:171","msg":"trace[961572613] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"565.104485ms","start":"2026-10-16T00:11:17.254071Z","end":"2026-10-16T00:11:17.819176Z","steps":["trace[961572613] 'process raft request'  (duration: 423.005173ms)","trace[961572613] 'compare'  (duration: 141.618003ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:11:17.819229Z","caller":"traceutil/trace.go:171","msg":"trace[1113254925] linearizableReadLoop","detail":"{readStateIndex:5205; appliedIndex:5202; }","duration":"565.071993ms","start":"2026-10-16T00:11:17.254138Z","end":"2026-10-16T00:11:17.81921Z","steps":["trace[1113254925] 'read index received'  (duration: 342.693434ms)","trace[1113254925] 'applied index is now lower than readState.Index'  (duration: 222.377639ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:11:17.819317Z","caller":"traceutil/trace.go:171","msg":"trace[1579916566] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"564.749578ms","start":"2026-10-16T00:11:17.254557Z","end":"2026-10-16T00:11:17.819307Z","steps":["trace[1579916566] 'process raft request'  (duration: 564.492463ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:17.819363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:11:17.254038Z","time spent":"565.249017ms","remote":"127.0.0.1:33132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":738,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rabbitmq-keystone.18deda1316298a65\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rabbitmq-keystone.18deda1316298a65\" value_size:659 lease:9160498946972876876 >> failure:<>"}
{"level":"info","ts":"2026-10-16T00:11:17.819378Z","caller":"traceutil/trace.go:171","msg":"trace[893123522] transaction","detail":"{read_only:false; response_revision:5010; number_of_response:1; }","duration":"271.224511ms","start":"2026-10-16T00:11:17.548114Z","end":"2026-10-16T00:11:17.819339Z","steps":["trace[893123522] 'process raft request'  (duration: 271.000847ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:17.819523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.38829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-10-16T00:11:17.819558Z","caller":"traceutil/trace.go:171","msg":"trace[917167912] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:5010; }","duration":"565.460831ms","start":"2026-10-16T00:11:17.254088Z","end":"2026-10-16T00:11:17.819549Z","steps":["trace[917167912] 'agreement among raft nodes before linearized reading'  (duration: 565.326938ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:17.819582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:11:17.254074Z","time spent":"565.503042ms","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1148,"request content":"key:\"/registry/storageclasses/general\" "}
{"level":"warn","ts":"2026-10-16T00:11:17.819368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:11:17.254536Z","time spent":"564.803829ms","remote":"127.0.0.1:33148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1147,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" value_size:1081 >> failure:<>"}
{"level":"warn","ts":"2026-10-16T00:11:17.839361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.142859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T00:11:17.839454Z","caller":"traceutil/trace.go:171","msg":"trace[1639643721] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5010; }","duration":"100.274721ms","start":"2026-10-16T00:11:17.739164Z","end":"2026-10-16T00:11:17.839438Z","steps":["trace[1639643721] 'agreement among raft nodes before linearized reading'  (duration: 100.143748ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:17.839501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.298491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"}
{"level":"info","ts":"2026-10-16T00:11:17.839575Z","caller":"traceutil/trace.go:171","msg":"trace[1168173] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:5010; }","duration":"585.435184ms","start":"2026-10-16T00:11:17.254118Z","end":"2026-10-16T00:11:17.839554Z","steps":["trace[1168173] 'agreement among raft nodes before linearized reading'  (duration: 585.147179ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:11:17.839627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:11:17.2541Z","time spent":"585.515375ms","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1148,"request content":"key:\"/registry/storageclasses/general\" "}
{"level":"warn","ts":"2026-10-16T00:11:20.639611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.941129ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9160498946972877148 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5057 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-16T00:11:20.63971Z","caller":"traceutil/trace.go:171","msg":"trace[1165155356] linearizableReadLoop","detail":"{readStateIndex:5280; appliedIndex:5279; }","duration":"187.087599ms","start":"2026-10-16T00:11:20.452607Z","end":"2026-10-16T00:11:20.639695Z","steps":["trace[1165155356] 'read index received'  (duration: 30.911456ms)","trace[1165155356] 'applied index is now lower than readState.Index'  (duration: 156.175093ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:11:20.639804Z","caller":"traceutil/trace.go:171","msg":"trace[90361573] transaction","detail":"{read_only:false; response_revision:5082; number_of_response:1; }","duration":"225.314412ms","start":"2026-10-16T00:11:20.414477Z","end":"2026-10-16T00:11:20.639792Z","steps":["trace[90361573] 'process raft request'  (duration: 69.109358ms)","trace[90361573] 'compare'  (duration: 155.820736ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:11:20.639955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.274183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-16T00:11:20.640018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.800286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T00:11:20.640052Z","caller":"traceutil/trace.go:171","msg":"trace[1733350390] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:5082; }","duration":"187.474826ms","start":"2026-10-16T00:11:20.452558Z","end":"2026-10-16T00:11:20.640032Z","steps":["trace[1733350390] 'agreement among raft nodes before linearized reading'  (duration: 187.270792ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:20.640099Z","caller":"traceutil/trace.go:171","msg":"trace[1585015782] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5082; }","duration":"162.918148ms","start":"2026-10-16T00:11:20.47716Z","end":"2026-10-16T00:11:20.640078Z","steps":["trace[1585015782] 'agreement among raft nodes before linearized reading'  (duration: 162.764365ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:20.97294Z","caller":"traceutil/trace.go:171","msg":"trace[1852250906] transaction","detail":"{read_only:false; response_revision:5089; number_of_response:1; }","duration":"126.869676ms","start":"2026-10-16T00:11:20.846042Z","end":"2026-10-16T00:11:20.972911Z","steps":["trace[1852250906] 'process raft request'  (duration: 126.670833ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:27.46517Z","caller":"traceutil/trace.go:171","msg":"trace[844507180] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"139.972637ms","start":"2026-10-16T00:11:27.325177Z","end":"2026-10-16T00:11:27.465149Z","steps":["trace[844507180] 'process raft request'  (duration: 139.827415ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:27.519445Z","caller":"traceutil/trace.go:171","msg":"trace[1295061518] linearizableReadLoop","detail":"{readStateIndex:5392; appliedIndex:5390; }","duration":"107.34235ms","start":"2026-10-16T00:11:27.412085Z","end":"2026-10-16T00:11:27.519427Z","steps":["trace[1295061518] 'read index received'  (duration: 53.025028ms)","trace[1295061518] 'applied index is now lower than readState.Index'  (duration: 54.316712ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:11:27.519543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.445992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-16T00:11:27.519537Z","caller":"traceutil/trace.go:171","msg":"trace[1074008538] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"194.255129ms","start":"2026-10-16T00:11:27.32525Z","end":"2026-10-16T00:11:27.519505Z","steps":["trace[1074008538] 'process raft request'  (duration: 194.072616ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:27.519579Z","caller":"traceutil/trace.go:171","msg":"trace[1757895215] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:5190; }","duration":"107.538243ms","start":"2026-10-16T00:11:27.412031Z","end":"2026-10-16T00:11:27.51957Z","steps":["trace[1757895215] 'agreement among raft nodes before linearized reading'  (duration: 107.467862ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:31.85225Z","caller":"traceutil/trace.go:171","msg":"trace[1389848434] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"199.403973ms","start":"2026-10-16T00:11:31.652821Z","end":"2026-10-16T00:11:31.852225Z","steps":["trace[1389848434] 'process raft request'  (duration: 199.093057ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:32.210186Z","caller":"traceutil/trace.go:171","msg":"trace[1327411316] linearizableReadLoop","detail":"{readStateIndex:5424; appliedIndex:5423; }","duration":"246.150472ms","start":"2026-10-16T00:11:31.964014Z","end":"2026-10-16T00:11:32.210165Z","steps":["trace[1327411316] 'read index received'  (duration: 245.946349ms)","trace[1327411316] 'applied index is now lower than readState.Index'  (duration: 203.333µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-16T00:11:32.210402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.371927ms","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-10-16T00:11:32.21044Z","caller":"traceutil/trace.go:171","msg":"trace[1406828287] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5221; }","duration":"246.465858ms","start":"2026-10-16T00:11:31.963962Z","end":"2026-10-16T00:11:32.210428Z","steps":["trace[1406828287] 'agreement among raft nodes before linearized reading'  (duration: 246.299095ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:32.210683Z","caller":"traceutil/trace.go:171","msg":"trace[802113737] transaction","detail":"{read_only:false; response_revision:5221; number_of_response:1; }","duration":"284.020868ms","start":"2026-10-16T00:11:31.926622Z","end":"2026-10-16T00:11:32.210643Z","steps":["trace[802113737] 'process raft request'  (duration: 283.408967ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:32.33447Z","caller":"traceutil/trace.go:171","msg":"trace[1723423882] transaction","detail":"{read_only:false; response_revision:5223; number_of_response:1; }","duration":"114.506411ms","start":"2026-10-16T00:11:32.219936Z","end":"2026-10-16T00:11:32.334443Z","steps":["trace[1723423882] 'process raft request'  (duration: 97.2555ms)","trace[1723423882] 'compare'  (duration: 16.63938ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:11:32.334533Z","caller":"traceutil/trace.go:171","msg":"trace[795442150] transaction","detail":"{read_only:false; response_revision:5225; number_of_response:1; }","duration":"112.214408ms","start":"2026-10-16T00:11:32.222301Z","end":"2026-10-16T00:11:32.334516Z","steps":["trace[795442150] 'process raft request'  (duration: 112.170508ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:32.334904Z","caller":"traceutil/trace.go:171","msg":"trace[202911671] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"114.040493ms","start":"2026-10-16T00:11:32.22072Z","end":"2026-10-16T00:11:32.334761Z","steps":["trace[202911671] 'process raft request'  (duration: 113.416781ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:32.354968Z","caller":"traceutil/trace.go:171","msg":"trace[399062438] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"125.389095ms","start":"2026-10-16T00:11:32.229546Z","end":"2026-10-16T00:11:32.354935Z","steps":["trace[399062438] 'process raft request'  (duration: 125.189671ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:32.518913Z","caller":"traceutil/trace.go:171","msg":"trace[811870165] transaction","detail":"{read_only:false; response_revision:5228; number_of_response:1; }","duration":"124.423606ms","start":"2026-10-16T00:11:32.394419Z","end":"2026-10-16T00:11:32.518843Z","steps":["trace[811870165] 'process raft request'  (duration: 60.459485ms)","trace[811870165] 'compare'  (duration: 63.514093ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:11:32.519151Z","caller":"traceutil/trace.go:171","msg":"trace[1708620902] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"107.214206ms","start":"2026-10-16T00:11:32.411903Z","end":"2026-10-16T00:11:32.519118Z","steps":["trace[1708620902] 'process raft request'  (duration: 106.917451ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:11:38.892443Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2821}
{"level":"info","ts":"2026-10-16T00:11:38.966675Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2821,"took":"72.822035ms","hash":847367007,"current-db-size-bytes":51179520,"current-db-size":"51 MB","current-db-size-in-use-bytes":27316224,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-10-16T00:11:38.966833Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":847367007,"revision":2821,"compact-revision":-1}
{"level":"info","ts":"2026-10-16T00:15:44.623901Z","caller":"traceutil/trace.go:171","msg":"trace[1891573372] transaction","detail":"{read_only:false; response_revision:7050; number_of_response:1; }","duration":"164.29014ms","start":"2026-10-16T00:15:44.459585Z","end":"2026-10-16T00:15:44.623875Z","steps":["trace[1891573372] 'process raft request'  (duration: 163.842049ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:15:44.775438Z","caller":"traceutil/trace.go:171","msg":"trace[1497998237] transaction","detail":"{read_only:false; response_revision:7051; number_of_response:1; }","duration":"146.853472ms","start":"2026-10-16T00:15:44.628559Z","end":"2026-10-16T00:15:44.775413Z","steps":["trace[1497998237] 'process raft request'  (duration: 146.696449ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:15:44.832786Z","caller":"traceutil/trace.go:171","msg":"trace[732951481] linearizableReadLoop","detail":"{readStateIndex:7316; appliedIndex:7314; }","duration":"193.138748ms","start":"2026-10-16T00:15:44.639615Z","end":"2026-10-16T00:15:44.832753Z","steps":["trace[732951481] 'read index received'  (duration: 135.664636ms)","trace[732951481] 'applied index is now lower than readState.Index'  (duration: 57.473142ms)"],"step_count":2}
{"level":"info","ts":"2026-10-16T00:15:44.832879Z","caller":"traceutil/trace.go:171","msg":"trace[597294784] transaction","detail":"{read_only:false; response_revision:7052; number_of_response:1; }","duration":"204.104269ms","start":"2026-10-16T00:15:44.628767Z","end":"2026-10-16T00:15:44.832871Z","steps":["trace[597294784] 'process raft request'  (duration: 203.863793ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-16T00:15:44.833254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.62633ms","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-10-16T00:15:44.833289Z","caller":"traceutil/trace.go:171","msg":"trace[540670369] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7052; }","duration":"193.695301ms","start":"2026-10-16T00:15:44.639583Z","end":"2026-10-16T00:15:44.833278Z","steps":["trace[540670369] 'agreement among raft nodes before linearized reading'  (duration: 193.396394ms)"],"step_count":1}
{"level":"info","ts":"2026-10-16T00:16:38.902221Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5279}
{"level":"info","ts":"2026-10-16T00:16:39.0327Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5279,"took":"128.718348ms","hash":1791484407,"current-db-size-bytes":51179520,"current-db-size":"51 MB","current-db-size-in-use-bytes":18812928,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-10-16T00:16:39.032772Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1791484407,"revision":5279,"compact-revision":2821}