{"level":"warn","ts":"2026-09-07T10:45:04.119336Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T10:45:04.119417Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.169: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.169:2380","--initial-cluster=instance=https://162.253.55.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.169:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-07T10:45:04.119477Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T10:45:04.119484Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.169:2380"]} {"level":"info","ts":"2026-09-07T10:45:04.119501Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-07T10:45:04.120234Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.169:2379"]} {"level":"info","ts":"2026-09-07T10:45:04.120306Z","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.169:2380"],"listen-peer-urls":["https://162.253.55.169:2380"],"advertise-client-urls":["https://162.253.55.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.169:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-07T10:45:04.12694Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.431429ms"} {"level":"info","ts":"2026-09-07T10:45:04.133697Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b856fd30c5dc1b8","cluster-id":"9989ba7b656496c6"} {"level":"info","ts":"2026-09-07T10:45:04.133771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b856fd30c5dc1b8 switched to configuration voters=()"} {"level":"info","ts":"2026-09-07T10:45:04.133793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b856fd30c5dc1b8 became follower at term 0"} {"level":"info","ts":"2026-09-07T10:45:04.133806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b856fd30c5dc1b8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-07T10:45:04.133815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b856fd30c5dc1b8 became follower at term 1"} {"level":"info","ts":"2026-09-07T10:45:04.133858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b856fd30c5dc1b8 switched to configuration voters=(830192658555978168)"} {"level":"warn","ts":"2026-09-07T10:45:04.148236Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-07T10:45:04.154079Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-07T10:45:04.155207Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-07T10:45:04.157871Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b856fd30c5dc1b8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-07T10:45:04.158331Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b856fd30c5dc1b8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-07T10:45:04.158422Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-07T10:45:04.158474Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-07T10:45:04.15849Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-07T10:45:04.160364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b856fd30c5dc1b8 switched to configuration voters=(830192658555978168)"} {"level":"info","ts":"2026-09-07T10:45:04.160546Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9989ba7b656496c6","local-member-id":"b856fd30c5dc1b8","added-peer-id":"b856fd30c5dc1b8","added-peer-peer-urls":["https://162.253.55.169:2380"]} {"level":"info","ts":"2026-09-07T10:45:04.162353Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-07T10:45:04.163064Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b856fd30c5dc1b8","initial-advertise-peer-urls":["https://162.253.55.169:2380"],"listen-peer-urls":["https://162.253.55.169:2380"],"advertise-client-urls":["https://162.253.55.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-07T10:45:04.163123Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-07T10:45:04.163609Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.169:2380"} {"level":"info","ts":"2026-09-07T10:45:04.163647Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.169:2380"} {"level":"info","ts":"2026-09-07T10:45:05.134429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b856fd30c5dc1b8 is starting a new election at term 1"} {"level":"info","ts":"2026-09-07T10:45:05.134527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b856fd30c5dc1b8 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-07T10:45:05.134575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b856fd30c5dc1b8 received MsgPreVoteResp from b856fd30c5dc1b8 at term 1"} {"level":"info","ts":"2026-09-07T10:45:05.134603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b856fd30c5dc1b8 became candidate at term 2"} {"level":"info","ts":"2026-09-07T10:45:05.134619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b856fd30c5dc1b8 received MsgVoteResp from b856fd30c5dc1b8 at term 2"} {"level":"info","ts":"2026-09-07T10:45:05.134647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b856fd30c5dc1b8 became leader at term 2"} {"level":"info","ts":"2026-09-07T10:45:05.134665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b856fd30c5dc1b8 elected leader b856fd30c5dc1b8 at term 2"} {"level":"info","ts":"2026-09-07T10:45:05.137823Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:45:05.138281Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b856fd30c5dc1b8","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.169:2379]}","request-path":"/0/members/b856fd30c5dc1b8/attributes","cluster-id":"9989ba7b656496c6","publish-timeout":"7s"} {"level":"info","ts":"2026-09-07T10:45:05.138287Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T10:45:05.13834Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T10:45:05.138745Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-07T10:45:05.138894Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9989ba7b656496c6","local-member-id":"b856fd30c5dc1b8","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:45:05.139011Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:45:05.139084Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T10:45:05.138904Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-07T10:45:05.141784Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-07T10:45:05.14263Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.169:2379"} {"level":"warn","ts":"2026-09-07T10:45:08.074626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.840103ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-07T10:45:08.074782Z","caller":"traceutil/trace.go:171","msg":"trace[1715078003] linearizableReadLoop","detail":"{readStateIndex:81; appliedIndex:80; }","duration":"407.051842ms","start":"2026-09-07T10:45:07.667709Z","end":"2026-09-07T10:45:08.074761Z","steps":["trace[1715078003] 'read index received' (duration: 111.216001ms)","trace[1715078003] 'applied index is now lower than readState.Index' (duration: 295.834141ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:45:08.075041Z","caller":"traceutil/trace.go:171","msg":"trace[1916790357] transaction","detail":"{read_only:false; response_revision:78; number_of_response:1; }","duration":"443.900563ms","start":"2026-09-07T10:45:07.631102Z","end":"2026-09-07T10:45:08.075002Z","steps":["trace[1916790357] 'process raft request' (duration: 147.936148ms)","trace[1916790357] 'compare' (duration: 294.671126ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:45:08.075165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.440497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-07T10:45:08.075222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:45:07.631065Z","time spent":"444.091321ms","remote":"127.0.0.1:50494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":634,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T10:45:08.075308Z","caller":"traceutil/trace.go:171","msg":"trace[572638626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:78; }","duration":"407.602613ms","start":"2026-09-07T10:45:07.667659Z","end":"2026-09-07T10:45:08.075262Z","steps":["trace[572638626] 'agreement among raft nodes before linearized reading' (duration: 407.289011ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:45:08.075736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:45:07.667634Z","time spent":"407.845133ms","remote":"127.0.0.1:50150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-07T10:45:08.336282Z","caller":"traceutil/trace.go:171","msg":"trace[147855296] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"255.754335ms","start":"2026-09-07T10:45:08.080451Z","end":"2026-09-07T10:45:08.336205Z","steps":["trace[147855296] 'process raft request' (duration: 249.777245ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:45:44.952887Z","caller":"traceutil/trace.go:171","msg":"trace[1206843945] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"199.519161ms","start":"2026-09-07T10:45:44.753344Z","end":"2026-09-07T10:45:44.952863Z","steps":["trace[1206843945] 'process raft request' (duration: 199.257344ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:45:45.157382Z","caller":"traceutil/trace.go:171","msg":"trace[456904712] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"239.459476ms","start":"2026-09-07T10:45:44.917899Z","end":"2026-09-07T10:45:45.157359Z","steps":["trace[456904712] 'read index received' (duration: 35.225918ms)","trace[456904712] 'applied index is now lower than readState.Index' (duration: 204.232688ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:45:45.158289Z","caller":"traceutil/trace.go:171","msg":"trace[1068397631] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"382.740569ms","start":"2026-09-07T10:45:44.775527Z","end":"2026-09-07T10:45:45.158268Z","steps":["trace[1068397631] 'process raft request' (duration: 375.661863ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:45:45.158855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.878871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-07T10:45:45.158913Z","caller":"traceutil/trace.go:171","msg":"trace[2126515958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"241.030396ms","start":"2026-09-07T10:45:44.917867Z","end":"2026-09-07T10:45:45.158897Z","steps":["trace[2126515958] 'agreement among raft nodes before linearized reading' (duration: 240.772059ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:45:45.159481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:45:44.775502Z","time spent":"382.946834ms","remote":"127.0.0.1:50198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74754,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T10:45:45.163146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.106697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-07T10:45:45.163207Z","caller":"traceutil/trace.go:171","msg":"trace[755727973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:602; }","duration":"245.21898ms","start":"2026-09-07T10:45:44.917974Z","end":"2026-09-07T10:45:45.163193Z","steps":["trace[755727973] 'agreement among raft nodes before linearized reading' (duration: 245.034375ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:45:45.1636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.665539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-07T10:45:45.163625Z","caller":"traceutil/trace.go:171","msg":"trace[957481416] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:602; }","duration":"166.73375ms","start":"2026-09-07T10:45:44.996885Z","end":"2026-09-07T10:45:45.163619Z","steps":["trace[957481416] 'agreement among raft nodes before linearized reading' (duration: 166.670569ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:45:49.434552Z","caller":"traceutil/trace.go:171","msg":"trace[331439086] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"142.268272ms","start":"2026-09-07T10:45:49.292232Z","end":"2026-09-07T10:45:49.4345Z","steps":["trace[331439086] 'process raft request' (duration: 122.142471ms)","trace[331439086] 'compare' (duration: 19.448725ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:45:50.135439Z","caller":"traceutil/trace.go:171","msg":"trace[1207098916] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"149.519953ms","start":"2026-09-07T10:45:49.985899Z","end":"2026-09-07T10:45:50.135419Z","steps":["trace[1207098916] 'process raft request' (duration: 149.379879ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:45:50.639456Z","caller":"traceutil/trace.go:171","msg":"trace[1642918205] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"642.022433ms","start":"2026-09-07T10:45:49.997401Z","end":"2026-09-07T10:45:50.639423Z","steps":["trace[1642918205] 'process raft request' (duration: 637.607909ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:45:50.639656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:45:49.997383Z","time spent":"642.155926ms","remote":"127.0.0.1:50252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T10:46:05.213526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.882036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vck86\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-09-07T10:46:05.213624Z","caller":"traceutil/trace.go:171","msg":"trace[70978818] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vck86; range_end:; response_count:1; response_revision:802; }","duration":"324.028789ms","start":"2026-09-07T10:46:04.889574Z","end":"2026-09-07T10:46:05.213603Z","steps":["trace[70978818] 'range keys from in-memory index tree' (duration: 323.660942ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:46:05.213662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:46:04.889555Z","time spent":"324.098131ms","remote":"127.0.0.1:50318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vck86\" "} {"level":"info","ts":"2026-09-07T10:46:36.891183Z","caller":"traceutil/trace.go:171","msg":"trace[1296337905] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"121.594873ms","start":"2026-09-07T10:46:36.769564Z","end":"2026-09-07T10:46:36.891159Z","steps":["trace[1296337905] 'process raft request' (duration: 121.41569ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:47:22.78683Z","caller":"traceutil/trace.go:171","msg":"trace[1343091889] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"166.616032ms","start":"2026-09-07T10:47:22.620156Z","end":"2026-09-07T10:47:22.786772Z","steps":["trace[1343091889] 'process raft request' (duration: 166.46095ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:47:23.244846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.779864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:47:23.244941Z","caller":"traceutil/trace.go:171","msg":"trace[208002190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1862; }","duration":"160.944537ms","start":"2026-09-07T10:47:23.083976Z","end":"2026-09-07T10:47:23.244921Z","steps":["trace[208002190] 'range keys from in-memory index tree' (duration: 160.690103ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:47:23.245178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.347195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:552"} {"level":"info","ts":"2026-09-07T10:47:23.245234Z","caller":"traceutil/trace.go:171","msg":"trace[1205720561] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1862; }","duration":"329.433296ms","start":"2026-09-07T10:47:22.915782Z","end":"2026-09-07T10:47:23.245215Z","steps":["trace[1205720561] 'range keys from in-memory index tree' (duration: 329.164792ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:47:23.245267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:47:22.915762Z","time spent":"329.495026ms","remote":"127.0.0.1:50410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":575,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-09-07T10:47:23.245301Z","caller":"traceutil/trace.go:171","msg":"trace[78896359] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1915; }","duration":"114.884813ms","start":"2026-09-07T10:47:23.130386Z","end":"2026-09-07T10:47:23.245271Z","steps":["trace[78896359] 'read index received' (duration: 18.10501ms)","trace[78896359] 'applied index is now lower than readState.Index' (duration: 96.778193ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:47:23.24546Z","caller":"traceutil/trace.go:171","msg":"trace[891954266] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"155.621585ms","start":"2026-09-07T10:47:23.089783Z","end":"2026-09-07T10:47:23.245404Z","steps":["trace[891954266] 'process raft request' (duration: 58.762922ms)","trace[891954266] 'compare' (duration: 96.321067ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:47:23.245593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.177576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-36a0045f-ef84-4510-96d9-c312de0bd2aa\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-07T10:47:23.245629Z","caller":"traceutil/trace.go:171","msg":"trace[530197618] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-36a0045f-ef84-4510-96d9-c312de0bd2aa; range_end:; response_count:1; response_revision:1863; }","duration":"115.254187ms","start":"2026-09-07T10:47:23.130362Z","end":"2026-09-07T10:47:23.245616Z","steps":["trace[530197618] 'agreement among raft nodes before linearized reading' (duration: 115.012514ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:47:23.39587Z","caller":"traceutil/trace.go:171","msg":"trace[302508746] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"104.274369ms","start":"2026-09-07T10:47:23.291566Z","end":"2026-09-07T10:47:23.39584Z","steps":["trace[302508746] 'process raft request' (duration: 101.307345ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:47:29.469987Z","caller":"traceutil/trace.go:171","msg":"trace[1013564653] linearizableReadLoop","detail":"{readStateIndex:1996; appliedIndex:1995; }","duration":"116.603673ms","start":"2026-09-07T10:47:29.353364Z","end":"2026-09-07T10:47:29.469968Z","steps":["trace[1013564653] 'read index received' (duration: 116.413581ms)","trace[1013564653] 'applied index is now lower than readState.Index' (duration: 189.312µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:47:29.470045Z","caller":"traceutil/trace.go:171","msg":"trace[1681593715] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"123.528152ms","start":"2026-09-07T10:47:29.346497Z","end":"2026-09-07T10:47:29.470025Z","steps":["trace[1681593715] 'process raft request' (duration: 123.32166ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:47:29.47046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.198963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"} {"level":"info","ts":"2026-09-07T10:47:29.470899Z","caller":"traceutil/trace.go:171","msg":"trace[621122417] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1940; }","duration":"111.657709ms","start":"2026-09-07T10:47:29.359224Z","end":"2026-09-07T10:47:29.470882Z","steps":["trace[621122417] 'agreement among raft nodes before linearized reading' (duration: 111.040542ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:47:29.470542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.813646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-09-07T10:47:29.471178Z","caller":"traceutil/trace.go:171","msg":"trace[1090371721] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1940; }","duration":"117.785437ms","start":"2026-09-07T10:47:29.353295Z","end":"2026-09-07T10:47:29.471081Z","steps":["trace[1090371721] 'agreement among raft nodes before linearized reading' (duration: 116.793856ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:47:29.591882Z","caller":"traceutil/trace.go:171","msg":"trace[1228676041] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"111.412155ms","start":"2026-09-07T10:47:29.480441Z","end":"2026-09-07T10:47:29.591853Z","steps":["trace[1228676041] 'process raft request' (duration: 111.352385ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:47:29.592238Z","caller":"traceutil/trace.go:171","msg":"trace[130900659] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"112.221275ms","start":"2026-09-07T10:47:29.479964Z","end":"2026-09-07T10:47:29.592186Z","steps":["trace[130900659] 'process raft request' (duration: 111.7986ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:47:29.592261Z","caller":"traceutil/trace.go:171","msg":"trace[1338075104] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"112.67375ms","start":"2026-09-07T10:47:29.479565Z","end":"2026-09-07T10:47:29.592239Z","steps":["trace[1338075104] 'process raft request' (duration: 112.144054ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:47:29.592382Z","caller":"traceutil/trace.go:171","msg":"trace[870655212] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"112.841082ms","start":"2026-09-07T10:47:29.479421Z","end":"2026-09-07T10:47:29.592262Z","steps":["trace[870655212] 'process raft request' (duration: 77.17519ms)","trace[870655212] 'compare' (duration: 34.972944ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:47:56.066844Z","caller":"traceutil/trace.go:171","msg":"trace[315572901] linearizableReadLoop","detail":"{readStateIndex:2200; appliedIndex:2199; }","duration":"138.721607ms","start":"2026-09-07T10:47:55.928063Z","end":"2026-09-07T10:47:56.066784Z","steps":["trace[315572901] 'read index received' (duration: 138.582656ms)","trace[315572901] 'applied index is now lower than readState.Index' (duration: 137.911µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:47:56.067157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.071061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"} {"level":"info","ts":"2026-09-07T10:47:56.067206Z","caller":"traceutil/trace.go:171","msg":"trace[92007245] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2134; }","duration":"139.158422ms","start":"2026-09-07T10:47:55.928033Z","end":"2026-09-07T10:47:56.067192Z","steps":["trace[92007245] 'agreement among raft nodes before linearized reading' (duration: 138.985561ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:47:56.067212Z","caller":"traceutil/trace.go:171","msg":"trace[1532216115] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"155.112194ms","start":"2026-09-07T10:47:55.91206Z","end":"2026-09-07T10:47:56.067172Z","steps":["trace[1532216115] 'process raft request' (duration: 154.587959ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:47:56.067327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.04382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-07T10:47:56.067422Z","caller":"traceutil/trace.go:171","msg":"trace[897516239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2134; }","duration":"139.193532ms","start":"2026-09-07T10:47:55.928208Z","end":"2026-09-07T10:47:56.067402Z","steps":["trace[897516239] 'agreement among raft nodes before linearized reading' (duration: 138.886149ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:47:56.067425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.895758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-07T10:47:56.067506Z","caller":"traceutil/trace.go:171","msg":"trace[1144357964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2134; }","duration":"131.990129ms","start":"2026-09-07T10:47:55.935497Z","end":"2026-09-07T10:47:56.067487Z","steps":["trace[1144357964] 'agreement among raft nodes before linearized reading' (duration: 131.683256ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:47:56.260638Z","caller":"traceutil/trace.go:171","msg":"trace[965010115] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"187.724522ms","start":"2026-09-07T10:47:56.072632Z","end":"2026-09-07T10:47:56.260357Z","steps":["trace[965010115] 'process raft request' (duration: 124.953356ms)","trace[965010115] 'compare' (duration: 62.521423ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:47:56.286195Z","caller":"traceutil/trace.go:171","msg":"trace[450165357] linearizableReadLoop","detail":"{readStateIndex:2203; appliedIndex:2200; }","duration":"201.969015ms","start":"2026-09-07T10:47:56.084204Z","end":"2026-09-07T10:47:56.286173Z","steps":["trace[450165357] 'read index received' (duration: 113.481409ms)","trace[450165357] 'applied index is now lower than readState.Index' (duration: 88.484696ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:47:56.286264Z","caller":"traceutil/trace.go:171","msg":"trace[1453956666] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"212.925116ms","start":"2026-09-07T10:47:56.073297Z","end":"2026-09-07T10:47:56.286222Z","steps":["trace[1453956666] 'process raft request' (duration: 212.727454ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:47:56.286428Z","caller":"traceutil/trace.go:171","msg":"trace[970015416] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"210.513592ms","start":"2026-09-07T10:47:56.075888Z","end":"2026-09-07T10:47:56.286402Z","steps":["trace[970015416] 'process raft request' (duration: 210.236409ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:47:56.286845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.604752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:47:56.286897Z","caller":"traceutil/trace.go:171","msg":"trace[2101982962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2137; }","duration":"202.724643ms","start":"2026-09-07T10:47:56.084158Z","end":"2026-09-07T10:47:56.286883Z","steps":["trace[2101982962] 'agreement among raft nodes before linearized reading' (duration: 202.099897ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:48:48.665405Z","caller":"traceutil/trace.go:171","msg":"trace[1915483488] linearizableReadLoop","detail":"{readStateIndex:2690; appliedIndex:2689; }","duration":"136.333266ms","start":"2026-09-07T10:48:48.52904Z","end":"2026-09-07T10:48:48.665373Z","steps":["trace[1915483488] 'read index received' (duration: 136.091244ms)","trace[1915483488] 'applied index is now lower than readState.Index' (duration: 240.652µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:48:48.665668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.600669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-07T10:48:48.665715Z","caller":"traceutil/trace.go:171","msg":"trace[1152297305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2599; }","duration":"136.677029ms","start":"2026-09-07T10:48:48.529021Z","end":"2026-09-07T10:48:48.665698Z","steps":["trace[1152297305] 'agreement among raft nodes before linearized reading' (duration: 136.468057ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:48:48.666129Z","caller":"traceutil/trace.go:171","msg":"trace[267744877] transaction","detail":"{read_only:false; response_revision:2599; number_of_response:1; }","duration":"138.433995ms","start":"2026-09-07T10:48:48.527679Z","end":"2026-09-07T10:48:48.666113Z","steps":["trace[267744877] 'process raft request' (duration: 137.463286ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:49:20.72464Z","caller":"traceutil/trace.go:171","msg":"trace[1698799726] linearizableReadLoop","detail":"{readStateIndex:2925; appliedIndex:2924; }","duration":"109.635757ms","start":"2026-09-07T10:49:20.614976Z","end":"2026-09-07T10:49:20.724612Z","steps":["trace[1698799726] 'read index received' (duration: 109.553243ms)","trace[1698799726] 'applied index is now lower than readState.Index' (duration: 81.614µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:49:20.724795Z","caller":"traceutil/trace.go:171","msg":"trace[656451750] transaction","detail":"{read_only:false; response_revision:2820; number_of_response:1; }","duration":"208.522563ms","start":"2026-09-07T10:49:20.516259Z","end":"2026-09-07T10:49:20.724781Z","steps":["trace[656451750] 'process raft request' (duration: 208.192669ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:49:20.724794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.793225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:49:20.725028Z","caller":"traceutil/trace.go:171","msg":"trace[1723529374] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:2820; }","duration":"110.071036ms","start":"2026-09-07T10:49:20.614938Z","end":"2026-09-07T10:49:20.725009Z","steps":["trace[1723529374] 'agreement among raft nodes before linearized reading' (duration: 109.803885ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:37.129099Z","caller":"traceutil/trace.go:171","msg":"trace[1598630781] transaction","detail":"{read_only:false; response_revision:3898; number_of_response:1; }","duration":"102.611074ms","start":"2026-09-07T10:51:37.026468Z","end":"2026-09-07T10:51:37.129079Z","steps":["trace[1598630781] 'process raft request' (duration: 102.44139ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:38.070926Z","caller":"traceutil/trace.go:171","msg":"trace[434367767] transaction","detail":"{read_only:false; response_revision:3912; number_of_response:1; }","duration":"121.230554ms","start":"2026-09-07T10:51:37.94967Z","end":"2026-09-07T10:51:38.0709Z","steps":["trace[434367767] 'process raft request' (duration: 120.418115ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:38.124514Z","caller":"traceutil/trace.go:171","msg":"trace[445680562] transaction","detail":"{read_only:false; number_of_response:0; response_revision:3912; }","duration":"126.543174ms","start":"2026-09-07T10:51:37.997929Z","end":"2026-09-07T10:51:38.124472Z","steps":["trace[445680562] 'process raft request' (duration: 124.492216ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:38.347787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.532533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11497"} {"level":"info","ts":"2026-09-07T10:51:38.347927Z","caller":"traceutil/trace.go:171","msg":"trace[1171148224] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3914; }","duration":"108.688227ms","start":"2026-09-07T10:51:38.239183Z","end":"2026-09-07T10:51:38.347871Z","steps":["trace[1171148224] 'range keys from in-memory index tree' (duration: 108.320519ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:48.713208Z","caller":"traceutil/trace.go:171","msg":"trace[1390177001] transaction","detail":"{read_only:false; response_revision:4395; number_of_response:1; }","duration":"113.013118ms","start":"2026-09-07T10:51:48.60017Z","end":"2026-09-07T10:51:48.713184Z","steps":["trace[1390177001] 'process raft request' (duration: 92.674079ms)","trace[1390177001] 'compare' (duration: 20.225907ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:51:48.729314Z","caller":"traceutil/trace.go:171","msg":"trace[1280560300] transaction","detail":"{read_only:false; response_revision:4397; number_of_response:1; }","duration":"103.484594ms","start":"2026-09-07T10:51:48.625814Z","end":"2026-09-07T10:51:48.729298Z","steps":["trace[1280560300] 'process raft request' (duration: 103.402452ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:48.729376Z","caller":"traceutil/trace.go:171","msg":"trace[1034499191] transaction","detail":"{read_only:false; response_revision:4396; number_of_response:1; }","duration":"123.763892ms","start":"2026-09-07T10:51:48.605578Z","end":"2026-09-07T10:51:48.729342Z","steps":["trace[1034499191] 'process raft request' (duration: 123.548577ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:53.918Z","caller":"traceutil/trace.go:171","msg":"trace[823659953] linearizableReadLoop","detail":"{readStateIndex:4715; appliedIndex:4714; }","duration":"126.74704ms","start":"2026-09-07T10:51:53.791231Z","end":"2026-09-07T10:51:53.917979Z","steps":["trace[823659953] 'read index received' (duration: 69.177453ms)","trace[823659953] 'applied index is now lower than readState.Index' (duration: 57.568717ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:51:53.918312Z","caller":"traceutil/trace.go:171","msg":"trace[2065940614] transaction","detail":"{read_only:false; response_revision:4523; number_of_response:1; }","duration":"129.661294ms","start":"2026-09-07T10:51:53.78864Z","end":"2026-09-07T10:51:53.918302Z","steps":["trace[2065940614] 'process raft request' (duration: 71.835802ms)","trace[2065940614] 'compare' (duration: 57.388073ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T10:51:53.919015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.754023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-09-07T10:51:53.919106Z","caller":"traceutil/trace.go:171","msg":"trace[1362054530] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4523; }","duration":"127.882136ms","start":"2026-09-07T10:51:53.791201Z","end":"2026-09-07T10:51:53.919083Z","steps":["trace[1362054530] 'agreement among raft nodes before linearized reading' (duration: 127.63057ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:51:54.192973Z","caller":"traceutil/trace.go:171","msg":"trace[112061623] linearizableReadLoop","detail":"{readStateIndex:4722; appliedIndex:4721; }","duration":"109.0198ms","start":"2026-09-07T10:51:54.083928Z","end":"2026-09-07T10:51:54.192947Z","steps":["trace[112061623] 'read index received' (duration: 108.819646ms)","trace[112061623] 'applied index is now lower than readState.Index' (duration: 199.154µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:51:54.193075Z","caller":"traceutil/trace.go:171","msg":"trace[682366954] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4529; }","duration":"109.429289ms","start":"2026-09-07T10:51:54.083637Z","end":"2026-09-07T10:51:54.193066Z","steps":["trace[682366954] 'process raft request' (duration: 109.152393ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:54.193428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.47449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:51:54.193542Z","caller":"traceutil/trace.go:171","msg":"trace[268027752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4529; }","duration":"109.613693ms","start":"2026-09-07T10:51:54.083907Z","end":"2026-09-07T10:51:54.19352Z","steps":["trace[268027752] 'agreement among raft nodes before linearized reading' (duration: 109.444679ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:54.205217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.659919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60486"} {"level":"info","ts":"2026-09-07T10:51:54.205277Z","caller":"traceutil/trace.go:171","msg":"trace[2049894015] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4530; }","duration":"116.74878ms","start":"2026-09-07T10:51:54.088514Z","end":"2026-09-07T10:51:54.205263Z","steps":["trace[2049894015] 'agreement among raft nodes before linearized reading' (duration: 116.543776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:51:54.205515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.413806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-09-07T10:51:54.205536Z","caller":"traceutil/trace.go:171","msg":"trace[494857586] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4530; }","duration":"117.455116ms","start":"2026-09-07T10:51:54.088075Z","end":"2026-09-07T10:51:54.20553Z","steps":["trace[494857586] 'agreement among raft nodes before linearized reading' (duration: 117.389475ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:52:00.139512Z","caller":"traceutil/trace.go:171","msg":"trace[1552071378] linearizableReadLoop","detail":"{readStateIndex:4836; appliedIndex:4835; }","duration":"153.647692ms","start":"2026-09-07T10:51:59.985834Z","end":"2026-09-07T10:52:00.139482Z","steps":["trace[1552071378] 'read index received' (duration: 153.337815ms)","trace[1552071378] 'applied index is now lower than readState.Index' (duration: 308.457µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:52:00.139661Z","caller":"traceutil/trace.go:171","msg":"trace[1647255310] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"160.46888ms","start":"2026-09-07T10:51:59.979175Z","end":"2026-09-07T10:52:00.139644Z","steps":["trace[1647255310] 'process raft request' (duration: 160.090282ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:52:00.139829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.949157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-07T10:52:00.139903Z","caller":"traceutil/trace.go:171","msg":"trace[474688712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4639; }","duration":"153.039999ms","start":"2026-09-07T10:51:59.986842Z","end":"2026-09-07T10:52:00.139882Z","steps":["trace[474688712] 'agreement among raft nodes before linearized reading' (duration: 152.854494ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:52:00.140535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.681404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-07T10:52:00.140936Z","caller":"traceutil/trace.go:171","msg":"trace[1565112719] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4639; }","duration":"155.114063ms","start":"2026-09-07T10:51:59.985805Z","end":"2026-09-07T10:52:00.140919Z","steps":["trace[1565112719] 'agreement among raft nodes before linearized reading' (duration: 154.123232ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:52:00.140579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.526306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-09-07T10:52:00.141036Z","caller":"traceutil/trace.go:171","msg":"trace[506905870] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4639; }","duration":"111.366765ms","start":"2026-09-07T10:52:00.029628Z","end":"2026-09-07T10:52:00.140995Z","steps":["trace[506905870] 'agreement among raft nodes before linearized reading' (duration: 110.451515ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:52:00.140621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.018515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-09-07T10:52:00.141203Z","caller":"traceutil/trace.go:171","msg":"trace[1629288458] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4639; }","duration":"146.622459ms","start":"2026-09-07T10:51:59.994565Z","end":"2026-09-07T10:52:00.141187Z","steps":["trace[1629288458] 'agreement among raft nodes before linearized reading' (duration: 145.961384ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:52:00.402129Z","caller":"traceutil/trace.go:171","msg":"trace[1241782540] linearizableReadLoop","detail":"{readStateIndex:4840; appliedIndex:4837; }","duration":"235.975395ms","start":"2026-09-07T10:52:00.166134Z","end":"2026-09-07T10:52:00.402109Z","steps":["trace[1241782540] 'read index received' (duration: 223.564326ms)","trace[1241782540] 'applied index is now lower than readState.Index' (duration: 12.410159ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:52:00.402254Z","caller":"traceutil/trace.go:171","msg":"trace[75357331] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"255.54229ms","start":"2026-09-07T10:52:00.146675Z","end":"2026-09-07T10:52:00.402218Z","steps":["trace[75357331] 'process raft request' (duration: 243.070039ms)","trace[75357331] 'compare' (duration: 12.176824ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:52:00.402477Z","caller":"traceutil/trace.go:171","msg":"trace[1143098177] transaction","detail":"{read_only:false; response_revision:4642; number_of_response:1; }","duration":"255.190122ms","start":"2026-09-07T10:52:00.147275Z","end":"2026-09-07T10:52:00.402465Z","steps":["trace[1143098177] 'process raft request' (duration: 254.748653ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:52:00.402472Z","caller":"traceutil/trace.go:171","msg":"trace[1713223992] transaction","detail":"{read_only:false; response_revision:4643; number_of_response:1; }","duration":"252.050014ms","start":"2026-09-07T10:52:00.150397Z","end":"2026-09-07T10:52:00.402447Z","steps":["trace[1713223992] 'process raft request' (duration: 251.667835ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:52:00.402968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.813633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e8acc1ff-4306-4805-a97d-424af9a5a141\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-07T10:52:00.403041Z","caller":"traceutil/trace.go:171","msg":"trace[1448641488] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e8acc1ff-4306-4805-a97d-424af9a5a141; range_end:; response_count:1; response_revision:4643; }","duration":"236.940486ms","start":"2026-09-07T10:52:00.166086Z","end":"2026-09-07T10:52:00.403027Z","steps":["trace[1448641488] 'agreement among raft nodes before linearized reading' (duration: 236.126129ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:52:14.164066Z","caller":"traceutil/trace.go:171","msg":"trace[1816610873] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"269.964291ms","start":"2026-09-07T10:52:13.894072Z","end":"2026-09-07T10:52:14.164036Z","steps":["trace[1816610873] 'process raft request' (duration: 249.68105ms)","trace[1816610873] 'compare' (duration: 19.829241ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T10:52:14.164238Z","caller":"traceutil/trace.go:171","msg":"trace[1414816533] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"270.148905ms","start":"2026-09-07T10:52:13.894072Z","end":"2026-09-07T10:52:14.16422Z","steps":["trace[1414816533] 'process raft request' (duration: 269.859129ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:52:14.164337Z","caller":"traceutil/trace.go:171","msg":"trace[2075684918] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"268.725765ms","start":"2026-09-07T10:52:13.895561Z","end":"2026-09-07T10:52:14.164287Z","steps":["trace[2075684918] 'process raft request' (duration: 268.511631ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:52:14.164659Z","caller":"traceutil/trace.go:171","msg":"trace[1068256425] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"269.500581ms","start":"2026-09-07T10:52:13.895144Z","end":"2026-09-07T10:52:14.164644Z","steps":["trace[1068256425] 'process raft request' (duration: 268.862118ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:52:49.906838Z","caller":"traceutil/trace.go:171","msg":"trace[474310754] transaction","detail":"{read_only:false; response_revision:5223; number_of_response:1; }","duration":"203.953286ms","start":"2026-09-07T10:52:49.702824Z","end":"2026-09-07T10:52:49.906777Z","steps":["trace[474310754] 'process raft request' (duration: 203.712601ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:55:05.172867Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3203} {"level":"info","ts":"2026-09-07T10:55:05.279978Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3203,"took":"105.405642ms","hash":558153222,"current-db-size-bytes":57884672,"current-db-size":"58 MB","current-db-size-in-use-bytes":31330304,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-07T10:55:05.280054Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":558153222,"revision":3203,"compact-revision":-1} {"level":"info","ts":"2026-09-07T10:55:43.715626Z","caller":"traceutil/trace.go:171","msg":"trace[1696999829] transaction","detail":"{read_only:false; response_revision:6675; number_of_response:1; }","duration":"102.94625ms","start":"2026-09-07T10:55:43.612662Z","end":"2026-09-07T10:55:43.715608Z","steps":["trace[1696999829] 'process raft request' (duration: 100.089499ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:57:22.476279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.029239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T10:57:22.476366Z","caller":"traceutil/trace.go:171","msg":"trace[1864188166] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7395; }","duration":"132.15257ms","start":"2026-09-07T10:57:22.344185Z","end":"2026-09-07T10:57:22.476338Z","steps":["trace[1864188166] 'range keys from in-memory index tree' (duration: 131.968317ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T10:57:22.476237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.090383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"warn","ts":"2026-09-07T10:57:22.476527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.415318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-07T10:57:22.476595Z","caller":"traceutil/trace.go:171","msg":"trace[47434533] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7395; }","duration":"136.537929ms","start":"2026-09-07T10:57:22.340008Z","end":"2026-09-07T10:57:22.476546Z","steps":["trace[47434533] 'range keys from in-memory index tree' (duration: 135.533215ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T10:57:22.476527Z","caller":"traceutil/trace.go:171","msg":"trace[1310213764] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:7395; }","duration":"164.488218ms","start":"2026-09-07T10:57:22.312015Z","end":"2026-09-07T10:57:22.476503Z","steps":["trace[1310213764] 'range keys from in-memory index tree' (duration: 163.730848ms)"],"step_count":1}