{"level":"warn","ts":"2026-10-09T02:16:26.903932Z","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-09T02:16:26.90402Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.215: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.215:2380","--initial-cluster=instance=https://162.253.55.215:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.215:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.215: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-09T02:16:26.904083Z","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-09T02:16:26.904093Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.215:2380"]} {"level":"info","ts":"2026-10-09T02:16:26.904114Z","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-09T02:16:26.904746Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.215:2379"]} {"level":"info","ts":"2026-10-09T02:16:26.904824Z","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.215:2380"],"listen-peer-urls":["https://162.253.55.215:2380"],"advertise-client-urls":["https://162.253.55.215:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.215:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.215: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-09T02:16:26.908704Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.673621ms"} {"level":"info","ts":"2026-10-09T02:16:26.914989Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4b019b7871d5da9a","cluster-id":"608f860684155cc8"} {"level":"info","ts":"2026-10-09T02:16:26.915044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a switched to configuration voters=()"} {"level":"info","ts":"2026-10-09T02:16:26.915062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became follower at term 0"} {"level":"info","ts":"2026-10-09T02:16:26.915072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4b019b7871d5da9a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-09T02:16:26.915087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became follower at term 1"} {"level":"info","ts":"2026-10-09T02:16:26.915115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a switched to configuration voters=(5404771969429527194)"} {"level":"warn","ts":"2026-10-09T02:16:26.921468Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-09T02:16:26.92994Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-09T02:16:26.931157Z","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-09T02:16:26.932886Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4b019b7871d5da9a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-09T02:16:26.934909Z","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-09T02:16:26.935037Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4b019b7871d5da9a","initial-advertise-peer-urls":["https://162.253.55.215:2380"],"listen-peer-urls":["https://162.253.55.215:2380"],"advertise-client-urls":["https://162.253.55.215:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.215:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-09T02:16:26.935059Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-09T02:16:26.935165Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.215:2380"} {"level":"info","ts":"2026-10-09T02:16:26.935188Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.215:2380"} {"level":"info","ts":"2026-10-09T02:16:26.93514Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4b019b7871d5da9a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-09T02:16:26.935423Z","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-09T02:16:26.935487Z","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-09T02:16:26.935501Z","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-09T02:16:26.935861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a switched to configuration voters=(5404771969429527194)"} {"level":"info","ts":"2026-10-09T02:16:26.93598Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"608f860684155cc8","local-member-id":"4b019b7871d5da9a","added-peer-id":"4b019b7871d5da9a","added-peer-peer-urls":["https://162.253.55.215:2380"]} {"level":"info","ts":"2026-10-09T02:16:27.915745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a is starting a new election at term 1"} {"level":"info","ts":"2026-10-09T02:16:27.915827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became pre-candidate at term 1"} {"level":"info","ts":"2026-10-09T02:16:27.915858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a received MsgPreVoteResp from 4b019b7871d5da9a at term 1"} {"level":"info","ts":"2026-10-09T02:16:27.915878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became candidate at term 2"} {"level":"info","ts":"2026-10-09T02:16:27.915888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a received MsgVoteResp from 4b019b7871d5da9a at term 2"} {"level":"info","ts":"2026-10-09T02:16:27.915908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4b019b7871d5da9a became leader at term 2"} {"level":"info","ts":"2026-10-09T02:16:27.91592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4b019b7871d5da9a elected leader 4b019b7871d5da9a at term 2"} {"level":"info","ts":"2026-10-09T02:16:27.916748Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:16:27.917982Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:16:27.917981Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4b019b7871d5da9a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.215:2379]}","request-path":"/0/members/4b019b7871d5da9a/attributes","cluster-id":"608f860684155cc8","publish-timeout":"7s"} {"level":"info","ts":"2026-10-09T02:16:27.91803Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:16:27.9184Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"608f860684155cc8","local-member-id":"4b019b7871d5da9a","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:16:27.918467Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-09T02:16:27.918568Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-09T02:16:27.918646Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:16:27.918707Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:16:27.921241Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.215:2379"} {"level":"info","ts":"2026-10-09T02:16:27.921502Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-09T02:17:19.441081Z","caller":"traceutil/trace.go:171","msg":"trace[1522847375] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"143.59891ms","start":"2026-10-09T02:17:19.297457Z","end":"2026-10-09T02:17:19.441056Z","steps":["trace[1522847375] 'process raft request' (duration: 143.42939ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:17:20.357629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.955934ms","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-09T02:17:20.357784Z","caller":"traceutil/trace.go:171","msg":"trace[421843160] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"685.131044ms","start":"2026-10-09T02:17:19.67263Z","end":"2026-10-09T02:17:20.357761Z","steps":["trace[421843160] 'range keys from in-memory index tree' (duration: 684.786954ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:17:20.357828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:17:19.672582Z","time spent":"685.23526ms","remote":"127.0.0.1:52630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-09T02:17:20.358153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.307879ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:17:20.358282Z","caller":"traceutil/trace.go:171","msg":"trace[2146291254] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"667.149791ms","start":"2026-10-09T02:17:19.691101Z","end":"2026-10-09T02:17:20.358251Z","steps":["trace[2146291254] 'process raft request' (duration: 489.251798ms)","trace[2146291254] 'compare' (duration: 177.01514ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:17:20.35835Z","caller":"traceutil/trace.go:171","msg":"trace[1442936668] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"308.224496ms","start":"2026-10-09T02:17:20.050111Z","end":"2026-10-09T02:17:20.358336Z","steps":["trace[1442936668] 'process raft request' (duration: 308.141671ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:17:20.358353Z","caller":"traceutil/trace.go:171","msg":"trace[966765859] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"520.060892ms","start":"2026-10-09T02:17:19.838279Z","end":"2026-10-09T02:17:20.35834Z","steps":["trace[966765859] 'read index received' (duration: 342.071823ms)","trace[966765859] 'applied index is now lower than readState.Index' (duration: 177.987629ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:17:20.358393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:17:19.691087Z","time spent":"667.265239ms","remote":"127.0.0.1:52902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:17:20.358461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.18879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:17:20.358496Z","caller":"traceutil/trace.go:171","msg":"trace[275640404] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"520.286406ms","start":"2026-10-09T02:17:19.838199Z","end":"2026-10-09T02:17:20.358485Z","steps":["trace[275640404] 'agreement among raft nodes before linearized reading' (duration: 520.184859ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:17:20.35854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:17:19.838176Z","time spent":"520.357869ms","remote":"127.0.0.1:52366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-09T02:17:20.358544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:17:20.050084Z","time spent":"308.291429ms","remote":"127.0.0.1:52630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:17:35.984216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.688142ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:17:35.984324Z","caller":"traceutil/trace.go:171","msg":"trace[976836538] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"145.557471ms","start":"2026-10-09T02:17:35.838751Z","end":"2026-10-09T02:17:35.984308Z","steps":["trace[976836538] 'read index received' (duration: 69.784µs)","trace[976836538] 'applied index is now lower than readState.Index' (duration: 145.486487ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:17:35.984352Z","caller":"traceutil/trace.go:171","msg":"trace[793336812] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"276.905224ms","start":"2026-10-09T02:17:35.707424Z","end":"2026-10-09T02:17:35.984329Z","steps":["trace[793336812] 'process raft request' (duration: 122.02404ms)","trace[793336812] 'compare' (duration: 154.570384ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:17:35.984393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.645397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:17:35.98445Z","caller":"traceutil/trace.go:171","msg":"trace[594809359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"145.738362ms","start":"2026-10-09T02:17:35.838701Z","end":"2026-10-09T02:17:35.984439Z","steps":["trace[594809359] 'agreement among raft nodes before linearized reading' (duration: 145.654327ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:18:06.566285Z","caller":"traceutil/trace.go:171","msg":"trace[221206763] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"126.301547ms","start":"2026-10-09T02:18:06.439956Z","end":"2026-10-09T02:18:06.566258Z","steps":["trace[221206763] 'process raft request' (duration: 126.145367ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:18:28.413369Z","caller":"traceutil/trace.go:171","msg":"trace[925175283] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"109.632561ms","start":"2026-10-09T02:18:28.303705Z","end":"2026-10-09T02:18:28.413338Z","steps":["trace[925175283] 'process raft request' (duration: 88.058754ms)","trace[925175283] 'compare' (duration: 21.367703ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:18:28.413887Z","caller":"traceutil/trace.go:171","msg":"trace[348364008] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"109.648942ms","start":"2026-10-09T02:18:28.3042Z","end":"2026-10-09T02:18:28.413849Z","steps":["trace[348364008] 'process raft request' (duration: 109.547785ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:18:28.413939Z","caller":"traceutil/trace.go:171","msg":"trace[780028176] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"109.932891ms","start":"2026-10-09T02:18:28.303986Z","end":"2026-10-09T02:18:28.413919Z","steps":["trace[780028176] 'process raft request' (duration: 109.674324ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:18:28.414198Z","caller":"traceutil/trace.go:171","msg":"trace[400906249] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"110.284684ms","start":"2026-10-09T02:18:28.303878Z","end":"2026-10-09T02:18:28.414162Z","steps":["trace[400906249] 'process raft request' (duration: 109.547565ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:18:28.414797Z","caller":"traceutil/trace.go:171","msg":"trace[1641848236] linearizableReadLoop","detail":"{readStateIndex:1461; appliedIndex:1455; }","duration":"106.317328ms","start":"2026-10-09T02:18:28.308448Z","end":"2026-10-09T02:18:28.414765Z","steps":["trace[1641848236] 'read index received' (duration: 83.355879ms)","trace[1641848236] 'applied index is now lower than readState.Index' (duration: 22.960509ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:18:28.415029Z","caller":"traceutil/trace.go:171","msg":"trace[494487846] transaction","detail":"{read_only:false; response_revision:1416; number_of_response:1; }","duration":"111.236758ms","start":"2026-10-09T02:18:28.303768Z","end":"2026-10-09T02:18:28.415005Z","steps":["trace[494487846] 'process raft request' (duration: 110.042569ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:18:28.415069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.612198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/ingress-nginx-admission\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:18:28.415139Z","caller":"traceutil/trace.go:171","msg":"trace[1005723948] range","detail":"{range_begin:/registry/clusterroles/ingress-nginx-admission; range_end:; response_count:0; response_revision:1417; }","duration":"106.691553ms","start":"2026-10-09T02:18:28.308408Z","end":"2026-10-09T02:18:28.415099Z","steps":["trace[1005723948] 'agreement among raft nodes before linearized reading' (duration: 106.611108ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:18:28.414945Z","caller":"traceutil/trace.go:171","msg":"trace[858722479] transaction","detail":"{read_only:false; response_revision:1417; number_of_response:1; }","duration":"109.664743ms","start":"2026-10-09T02:18:28.305263Z","end":"2026-10-09T02:18:28.414928Z","steps":["trace[858722479] 'process raft request' (duration: 108.658106ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:18:55.971789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.798941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-09T02:18:55.971823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.491424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3fbdef2d-783d-40ef-b711-a18cadc62a10\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-09T02:18:55.971884Z","caller":"traceutil/trace.go:171","msg":"trace[2003474957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1861; }","duration":"132.932976ms","start":"2026-10-09T02:18:55.838931Z","end":"2026-10-09T02:18:55.971864Z","steps":["trace[2003474957] 'range keys from in-memory index tree' (duration: 132.697754ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:18:55.971903Z","caller":"traceutil/trace.go:171","msg":"trace[424159203] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3fbdef2d-783d-40ef-b711-a18cadc62a10; range_end:; response_count:1; response_revision:1861; }","duration":"192.615969ms","start":"2026-10-09T02:18:55.779267Z","end":"2026-10-09T02:18:55.971883Z","steps":["trace[424159203] 'range keys from in-memory index tree' (duration: 192.309041ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:18:55.972293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.021101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-09T02:18:55.97242Z","caller":"traceutil/trace.go:171","msg":"trace[2018188214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1861; }","duration":"228.217894ms","start":"2026-10-09T02:18:55.744182Z","end":"2026-10-09T02:18:55.9724Z","steps":["trace[2018188214] 'range keys from in-memory index tree' (duration: 227.77722ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:18:56.099881Z","caller":"traceutil/trace.go:171","msg":"trace[1366656015] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"120.628443ms","start":"2026-10-09T02:18:55.979224Z","end":"2026-10-09T02:18:56.099852Z","steps":["trace[1366656015] 'process raft request' (duration: 107.257678ms)","trace[1366656015] 'compare' (duration: 13.21764ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:18:56.41004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.864907ms","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-09T02:18:56.410126Z","caller":"traceutil/trace.go:171","msg":"trace[1196067068] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1863; }","duration":"197.028031ms","start":"2026-10-09T02:18:56.213077Z","end":"2026-10-09T02:18:56.410105Z","steps":["trace[1196067068] 'range keys from in-memory index tree' (duration: 196.627636ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:18:56.41033Z","caller":"traceutil/trace.go:171","msg":"trace[1053953514] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"132.991683ms","start":"2026-10-09T02:18:56.2773Z","end":"2026-10-09T02:18:56.410291Z","steps":["trace[1053953514] 'process raft request' (duration: 62.143668ms)","trace[1053953514] 'compare' (duration: 70.383512ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:19:09.05318Z","caller":"traceutil/trace.go:171","msg":"trace[1138553309] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"106.828503ms","start":"2026-10-09T02:19:08.946298Z","end":"2026-10-09T02:19:09.053127Z","steps":["trace[1138553309] 'process raft request' (duration: 40.220274ms)","trace[1138553309] 'compare' (duration: 66.431534ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:19:12.517285Z","caller":"traceutil/trace.go:171","msg":"trace[1001554728] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"110.188799ms","start":"2026-10-09T02:19:12.407073Z","end":"2026-10-09T02:19:12.517262Z","steps":["trace[1001554728] 'process raft request' (duration: 110.029433ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:19:35.436621Z","caller":"traceutil/trace.go:171","msg":"trace[511216537] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"105.33268ms","start":"2026-10-09T02:19:35.331248Z","end":"2026-10-09T02:19:35.43658Z","steps":["trace[511216537] 'process raft request' (duration: 52.376278ms)","trace[511216537] 'compare' (duration: 52.736494ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:19:36.374878Z","caller":"traceutil/trace.go:171","msg":"trace[1630409402] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"128.16793ms","start":"2026-10-09T02:19:36.246679Z","end":"2026-10-09T02:19:36.374847Z","steps":["trace[1630409402] 'process raft request' (duration: 127.997272ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:19:36.755873Z","caller":"traceutil/trace.go:171","msg":"trace[862642886] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"109.767917ms","start":"2026-10-09T02:19:36.646083Z","end":"2026-10-09T02:19:36.755851Z","steps":["trace[862642886] 'read index received' (duration: 109.695708ms)","trace[862642886] 'applied index is now lower than readState.Index' (duration: 70.659µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:19:36.755995Z","caller":"traceutil/trace.go:171","msg":"trace[1455926445] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"143.222859ms","start":"2026-10-09T02:19:36.61272Z","end":"2026-10-09T02:19:36.755943Z","steps":["trace[1455926445] 'process raft request' (duration: 142.979602ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:19:36.756207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.084794ms","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-09T02:19:36.756307Z","caller":"traceutil/trace.go:171","msg":"trace[2046782548] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2131; }","duration":"110.246131ms","start":"2026-10-09T02:19:36.646041Z","end":"2026-10-09T02:19:36.756287Z","steps":["trace[2046782548] 'agreement among raft nodes before linearized reading' (duration: 109.977474ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:19:36.78826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.257106ms","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-09T02:19:36.788326Z","caller":"traceutil/trace.go:171","msg":"trace[253086644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2131; }","duration":"130.348285ms","start":"2026-10-09T02:19:36.65796Z","end":"2026-10-09T02:19:36.788309Z","steps":["trace[253086644] 'agreement among raft nodes before linearized reading' (duration: 130.159328ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:20:59.624115Z","caller":"traceutil/trace.go:171","msg":"trace[1927902561] transaction","detail":"{read_only:false; response_revision:2691; number_of_response:1; }","duration":"180.944466ms","start":"2026-10-09T02:20:59.443136Z","end":"2026-10-09T02:20:59.62408Z","steps":["trace[1927902561] 'process raft request' (duration: 180.746272ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:21:04.914596Z","caller":"traceutil/trace.go:171","msg":"trace[588436575] linearizableReadLoop","detail":"{readStateIndex:2818; appliedIndex:2817; }","duration":"101.141325ms","start":"2026-10-09T02:21:04.813429Z","end":"2026-10-09T02:21:04.914571Z","steps":["trace[588436575] 'read index received' (duration: 100.94887ms)","trace[588436575] 'applied index is now lower than readState.Index' (duration: 191.515µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:21:04.914978Z","caller":"traceutil/trace.go:171","msg":"trace[1926143679] transaction","detail":"{read_only:false; response_revision:2716; number_of_response:1; }","duration":"102.709263ms","start":"2026-10-09T02:21:04.812252Z","end":"2026-10-09T02:21:04.914961Z","steps":["trace[1926143679] 'process raft request' (duration: 102.184849ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:21:04.914949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.492103ms","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-09T02:21:04.915204Z","caller":"traceutil/trace.go:171","msg":"trace[1262036661] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2716; }","duration":"101.74992ms","start":"2026-10-09T02:21:04.813397Z","end":"2026-10-09T02:21:04.915147Z","steps":["trace[1262036661] 'agreement among raft nodes before linearized reading' (duration: 101.35616ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:24.498706Z","caller":"traceutil/trace.go:171","msg":"trace[762003595] transaction","detail":"{read_only:false; response_revision:4720; number_of_response:1; }","duration":"135.193642ms","start":"2026-10-09T02:25:24.363495Z","end":"2026-10-09T02:25:24.498689Z","steps":["trace[762003595] 'process raft request' (duration: 135.100667ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:26.872026Z","caller":"traceutil/trace.go:171","msg":"trace[1792878604] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"150.187081ms","start":"2026-10-09T02:25:26.721812Z","end":"2026-10-09T02:25:26.871999Z","steps":["trace[1792878604] 'process raft request' (duration: 149.848373ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:32.524046Z","caller":"traceutil/trace.go:171","msg":"trace[1764828132] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"212.452457ms","start":"2026-10-09T02:25:32.311566Z","end":"2026-10-09T02:25:32.524018Z","steps":["trace[1764828132] 'process raft request' (duration: 138.922642ms)","trace[1764828132] 'compare' (duration: 73.330814ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:25:33.009513Z","caller":"traceutil/trace.go:171","msg":"trace[149749195] linearizableReadLoop","detail":"{readStateIndex:5099; appliedIndex:5097; }","duration":"171.836307ms","start":"2026-10-09T02:25:32.83765Z","end":"2026-10-09T02:25:33.009486Z","steps":["trace[149749195] 'read index received' (duration: 15.802597ms)","trace[149749195] 'applied index is now lower than readState.Index' (duration: 156.03268ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:25:33.009703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.763972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:25:33.009616Z","caller":"traceutil/trace.go:171","msg":"trace[1725515340] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"217.747375ms","start":"2026-10-09T02:25:32.791825Z","end":"2026-10-09T02:25:33.009573Z","steps":["trace[1725515340] 'process raft request' (duration: 217.502832ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:33.009737Z","caller":"traceutil/trace.go:171","msg":"trace[1330920865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4914; }","duration":"171.8946ms","start":"2026-10-09T02:25:32.837832Z","end":"2026-10-09T02:25:33.009727Z","steps":["trace[1330920865] 'agreement among raft nodes before linearized reading' (duration: 171.786264ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:33.009814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.123662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-10-09T02:25:33.010009Z","caller":"traceutil/trace.go:171","msg":"trace[86610989] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4914; }","duration":"172.316082ms","start":"2026-10-09T02:25:32.837642Z","end":"2026-10-09T02:25:33.009958Z","steps":["trace[86610989] 'agreement among raft nodes before linearized reading' (duration: 171.941422ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:20.973288Z","caller":"traceutil/trace.go:171","msg":"trace[673149306] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"112.929724ms","start":"2026-10-09T02:26:20.86033Z","end":"2026-10-09T02:26:20.97326Z","steps":["trace[673149306] 'process raft request' (duration: 96.993318ms)","trace[673149306] 'compare' (duration: 15.338302ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:20.976299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.661941ms","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-09T02:26:20.976354Z","caller":"traceutil/trace.go:171","msg":"trace[1441210285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5402; }","duration":"116.926306ms","start":"2026-10-09T02:26:20.859413Z","end":"2026-10-09T02:26:20.97634Z","steps":["trace[1441210285] 'range keys from in-memory index tree' (duration: 113.151775ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:27.95652Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2840} {"level":"info","ts":"2026-10-09T02:26:28.050367Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2840,"took":"92.560298ms","hash":2429130177,"current-db-size-bytes":53473280,"current-db-size":"54 MB","current-db-size-in-use-bytes":28696576,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-09T02:26:28.050532Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2429130177,"revision":2840,"compact-revision":-1} {"level":"info","ts":"2026-10-09T02:26:36.240947Z","caller":"traceutil/trace.go:171","msg":"trace[2082877955] transaction","detail":"{read_only:false; response_revision:5512; number_of_response:1; }","duration":"100.130967ms","start":"2026-10-09T02:26:36.140795Z","end":"2026-10-09T02:26:36.240926Z","steps":["trace[2082877955] 'process raft request' (duration: 99.772957ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:31:27.962419Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5463} {"level":"info","ts":"2026-10-09T02:31:28.097362Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5463,"took":"133.192594ms","hash":2206937519,"current-db-size-bytes":53473280,"current-db-size":"54 MB","current-db-size-in-use-bytes":18636800,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-09T02:31:28.097432Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2206937519,"revision":5463,"compact-revision":2840}