{"level":"warn","ts":"2026-09-15T02:18:31.695723Z","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-15T02:18:31.695842Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.59: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.59:2380","--initial-cluster=instance=https://162.253.55.59:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.59:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.59: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-15T02:18:31.695987Z","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-15T02:18:31.696003Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.59:2380"]} {"level":"info","ts":"2026-09-15T02:18:31.696049Z","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-15T02:18:31.696967Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"]} {"level":"info","ts":"2026-09-15T02:18:31.697138Z","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.59:2380"],"listen-peer-urls":["https://162.253.55.59:2380"],"advertise-client-urls":["https://162.253.55.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.59: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-15T02:18:31.702634Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.149518ms"} {"level":"info","ts":"2026-09-15T02:18:31.71096Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f5132dc9ac390b66","cluster-id":"458d1cb56ab56fc4"} {"level":"info","ts":"2026-09-15T02:18:31.711083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=()"} {"level":"info","ts":"2026-09-15T02:18:31.711154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became follower at term 0"} {"level":"info","ts":"2026-09-15T02:18:31.711172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f5132dc9ac390b66 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-15T02:18:31.711214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became follower at term 1"} {"level":"info","ts":"2026-09-15T02:18:31.711326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=(17659508908050942822)"} {"level":"warn","ts":"2026-09-15T02:18:31.722902Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-15T02:18:31.724463Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-15T02:18:31.725787Z","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-15T02:18:31.7277Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f5132dc9ac390b66","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-15T02:18:31.727812Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f5132dc9ac390b66","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-15T02:18:31.727892Z","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-15T02:18:31.727953Z","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-15T02:18:31.72796Z","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-15T02:18:31.72903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=(17659508908050942822)"} {"level":"info","ts":"2026-09-15T02:18:31.729211Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"458d1cb56ab56fc4","local-member-id":"f5132dc9ac390b66","added-peer-id":"f5132dc9ac390b66","added-peer-peer-urls":["https://162.253.55.59:2380"]} {"level":"info","ts":"2026-09-15T02:18:31.730707Z","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-15T02:18:31.730816Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.59:2380"} {"level":"info","ts":"2026-09-15T02:18:31.730855Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.59:2380"} {"level":"info","ts":"2026-09-15T02:18:31.731031Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f5132dc9ac390b66","initial-advertise-peer-urls":["https://162.253.55.59:2380"],"listen-peer-urls":["https://162.253.55.59:2380"],"advertise-client-urls":["https://162.253.55.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-15T02:18:31.731124Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-15T02:18:32.712619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 is starting a new election at term 1"} {"level":"info","ts":"2026-09-15T02:18:32.712671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-15T02:18:32.712692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 received MsgPreVoteResp from f5132dc9ac390b66 at term 1"} {"level":"info","ts":"2026-09-15T02:18:32.712708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became candidate at term 2"} {"level":"info","ts":"2026-09-15T02:18:32.712718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 received MsgVoteResp from f5132dc9ac390b66 at term 2"} {"level":"info","ts":"2026-09-15T02:18:32.712733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became leader at term 2"} {"level":"info","ts":"2026-09-15T02:18:32.712745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f5132dc9ac390b66 elected leader f5132dc9ac390b66 at term 2"} {"level":"info","ts":"2026-09-15T02:18:32.718943Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:18:32.725611Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T02:18:32.725608Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f5132dc9ac390b66","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.59:2379]}","request-path":"/0/members/f5132dc9ac390b66/attributes","cluster-id":"458d1cb56ab56fc4","publish-timeout":"7s"} {"level":"info","ts":"2026-09-15T02:18:32.725659Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T02:18:32.726051Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-15T02:18:32.726098Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-15T02:18:32.728999Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-15T02:18:32.729451Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.59:2379"} {"level":"info","ts":"2026-09-15T02:18:32.729557Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"458d1cb56ab56fc4","local-member-id":"f5132dc9ac390b66","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:18:32.729686Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:18:32.729782Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:18:36.656378Z","caller":"traceutil/trace.go:171","msg":"trace[910077741] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"135.308499ms","start":"2026-09-15T02:18:36.520948Z","end":"2026-09-15T02:18:36.656256Z","steps":["trace[910077741] 'process raft request' (duration: 132.14274ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:18:46.510769Z","caller":"traceutil/trace.go:171","msg":"trace[1641538018] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"189.814233ms","start":"2026-09-15T02:18:46.32093Z","end":"2026-09-15T02:18:46.510744Z","steps":["trace[1641538018] 'process raft request' (duration: 189.526071ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:18:47.002211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.241733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.59\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-09-15T02:18:47.00221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.651387ms","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-15T02:18:47.002329Z","caller":"traceutil/trace.go:171","msg":"trace[1755738131] range","detail":"{range_begin:/registry/masterleases/162.253.55.59; range_end:; response_count:1; response_revision:405; }","duration":"129.426965ms","start":"2026-09-15T02:18:46.872879Z","end":"2026-09-15T02:18:47.002306Z","steps":["trace[1755738131] 'range keys from in-memory index tree' (duration: 129.130952ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:18:47.002346Z","caller":"traceutil/trace.go:171","msg":"trace[842185046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:405; }","duration":"130.828148ms","start":"2026-09-15T02:18:46.871493Z","end":"2026-09-15T02:18:47.002321Z","steps":["trace[842185046] 'range keys from in-memory index tree' (duration: 130.539015ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:18:47.002257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.952193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-15T02:18:47.002467Z","caller":"traceutil/trace.go:171","msg":"trace[396173486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:405; }","duration":"180.192376ms","start":"2026-09-15T02:18:46.822233Z","end":"2026-09-15T02:18:47.002426Z","steps":["trace[396173486] 'range keys from in-memory index tree' (duration: 179.814282ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:18:47.211598Z","caller":"traceutil/trace.go:171","msg":"trace[1678097819] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"202.627006ms","start":"2026-09-15T02:18:47.008943Z","end":"2026-09-15T02:18:47.21157Z","steps":["trace[1678097819] 'process raft request' (duration: 202.587906ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:18:47.21169Z","caller":"traceutil/trace.go:171","msg":"trace[960306873] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"204.073559ms","start":"2026-09-15T02:18:47.007581Z","end":"2026-09-15T02:18:47.211654Z","steps":["trace[960306873] 'process raft request' (duration: 203.681736ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:18:47.211801Z","caller":"traceutil/trace.go:171","msg":"trace[634472925] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"203.887028ms","start":"2026-09-15T02:18:47.007877Z","end":"2026-09-15T02:18:47.211764Z","steps":["trace[634472925] 'process raft request' (duration: 203.590425ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:19:21.934017Z","caller":"traceutil/trace.go:171","msg":"trace[1988075901] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"143.510339ms","start":"2026-09-15T02:19:21.790477Z","end":"2026-09-15T02:19:21.933987Z","steps":["trace[1988075901] 'process raft request' (duration: 142.956939ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:19:22.156127Z","caller":"traceutil/trace.go:171","msg":"trace[1628076536] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"153.421976ms","start":"2026-09-15T02:19:22.002675Z","end":"2026-09-15T02:19:22.156097Z","steps":["trace[1628076536] 'process raft request' (duration: 153.295219ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:19:22.457215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.667543ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-15T02:19:22.457294Z","caller":"traceutil/trace.go:171","msg":"trace[1880096783] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"160.300012ms","start":"2026-09-15T02:19:22.296981Z","end":"2026-09-15T02:19:22.457281Z","steps":["trace[1880096783] 'read index received' (duration: 46.408557ms)","trace[1880096783] 'applied index is now lower than readState.Index' (duration: 113.890145ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:19:22.457348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.364125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:19:22.457363Z","caller":"traceutil/trace.go:171","msg":"trace[1815009310] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"160.410728ms","start":"2026-09-15T02:19:22.296947Z","end":"2026-09-15T02:19:22.457358Z","steps":["trace[1815009310] 'agreement among raft nodes before linearized reading' (duration: 160.365096ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:19:23.137935Z","caller":"traceutil/trace.go:171","msg":"trace[526818247] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"391.283615ms","start":"2026-09-15T02:19:22.746625Z","end":"2026-09-15T02:19:23.137909Z","steps":["trace[526818247] 'read index received' (duration: 390.556617ms)","trace[526818247] 'applied index is now lower than readState.Index' (duration: 726.008µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:19:23.138228Z","caller":"traceutil/trace.go:171","msg":"trace[1022476033] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"588.812782ms","start":"2026-09-15T02:19:22.549207Z","end":"2026-09-15T02:19:23.138019Z","steps":["trace[1022476033] 'process raft request' (duration: 588.146767ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:19:23.138458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.816033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-15T02:19:23.138504Z","caller":"traceutil/trace.go:171","msg":"trace[118517541] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:649; }","duration":"391.926868ms","start":"2026-09-15T02:19:22.746564Z","end":"2026-09-15T02:19:23.138491Z","steps":["trace[118517541] 'agreement among raft nodes before linearized reading' (duration: 391.435833ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:19:23.138533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:19:22.746547Z","time spent":"391.979331ms","remote":"127.0.0.1:51264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-15T02:19:23.13879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:19:22.549172Z","time spent":"589.105267ms","remote":"127.0.0.1:51130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T02:19:40.961517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.617513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lbbcg\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-15T02:19:40.961651Z","caller":"traceutil/trace.go:171","msg":"trace[452060972] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lbbcg; range_end:; response_count:1; response_revision:815; }","duration":"182.815081ms","start":"2026-09-15T02:19:40.778802Z","end":"2026-09-15T02:19:40.961617Z","steps":["trace[452060972] 'range keys from in-memory index tree' (duration: 182.425455ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:19:45.061949Z","caller":"traceutil/trace.go:171","msg":"trace[1260816471] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"108.58403ms","start":"2026-09-15T02:19:44.953338Z","end":"2026-09-15T02:19:45.061922Z","steps":["trace[1260816471] 'process raft request' (duration: 96.030483ms)","trace[1260816471] 'compare' (duration: 12.39513ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:20:02.890095Z","caller":"traceutil/trace.go:171","msg":"trace[1379199477] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"116.470969ms","start":"2026-09-15T02:20:02.773595Z","end":"2026-09-15T02:20:02.890066Z","steps":["trace[1379199477] 'process raft request' (duration: 116.271172ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:20:13.38634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.688098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:20:13.386445Z","caller":"traceutil/trace.go:171","msg":"trace[494172650] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1227; }","duration":"185.837433ms","start":"2026-09-15T02:20:13.200579Z","end":"2026-09-15T02:20:13.386416Z","steps":["trace[494172650] 'range keys from in-memory index tree' (duration: 185.529732ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:20:13.386521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.85234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-15T02:20:13.386626Z","caller":"traceutil/trace.go:171","msg":"trace[280931982] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1227; }","duration":"128.026577ms","start":"2026-09-15T02:20:13.258576Z","end":"2026-09-15T02:20:13.386602Z","steps":["trace[280931982] 'count revisions from in-memory index tree' (duration: 127.741227ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.475249Z","caller":"traceutil/trace.go:171","msg":"trace[1717232519] transaction","detail":"{read_only:false; response_revision:1431; number_of_response:1; }","duration":"137.701745ms","start":"2026-09-15T02:20:34.337514Z","end":"2026-09-15T02:20:34.475216Z","steps":["trace[1717232519] 'process raft request' (duration: 137.487389ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.475513Z","caller":"traceutil/trace.go:171","msg":"trace[300696536] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"129.061566ms","start":"2026-09-15T02:20:34.346431Z","end":"2026-09-15T02:20:34.475492Z","steps":["trace[300696536] 'process raft request' (duration: 128.998885ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.475719Z","caller":"traceutil/trace.go:171","msg":"trace[38982232] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"132.854041ms","start":"2026-09-15T02:20:34.342849Z","end":"2026-09-15T02:20:34.475703Z","steps":["trace[38982232] 'process raft request' (duration: 132.430799ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.475776Z","caller":"traceutil/trace.go:171","msg":"trace[285790346] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"132.880622ms","start":"2026-09-15T02:20:34.342878Z","end":"2026-09-15T02:20:34.475758Z","steps":["trace[285790346] 'process raft request' (duration: 132.45628ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.475756Z","caller":"traceutil/trace.go:171","msg":"trace[1330306001] transaction","detail":"{read_only:false; response_revision:1432; number_of_response:1; }","duration":"136.847472ms","start":"2026-09-15T02:20:34.338874Z","end":"2026-09-15T02:20:34.475721Z","steps":["trace[1330306001] 'process raft request' (duration: 136.260936ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.475952Z","caller":"traceutil/trace.go:171","msg":"trace[1648219950] transaction","detail":"{read_only:false; response_revision:1433; number_of_response:1; }","duration":"136.308867ms","start":"2026-09-15T02:20:34.339625Z","end":"2026-09-15T02:20:34.475934Z","steps":["trace[1648219950] 'process raft request' (duration: 135.580147ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.496383Z","caller":"traceutil/trace.go:171","msg":"trace[437542150] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"124.285804ms","start":"2026-09-15T02:20:34.372073Z","end":"2026-09-15T02:20:34.496359Z","steps":["trace[437542150] 'process raft request' (duration: 124.11772ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.49681Z","caller":"traceutil/trace.go:171","msg":"trace[520920771] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"122.255909ms","start":"2026-09-15T02:20:34.374541Z","end":"2026-09-15T02:20:34.496797Z","steps":["trace[520920771] 'process raft request' (duration: 121.768465ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.645242Z","caller":"traceutil/trace.go:171","msg":"trace[1178913722] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"142.403505ms","start":"2026-09-15T02:20:34.502795Z","end":"2026-09-15T02:20:34.645198Z","steps":["trace[1178913722] 'process raft request' (duration: 111.914692ms)","trace[1178913722] 'compare' (duration: 30.277206ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:20:34.64525Z","caller":"traceutil/trace.go:171","msg":"trace[472488131] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"137.283464ms","start":"2026-09-15T02:20:34.507942Z","end":"2026-09-15T02:20:34.645226Z","steps":["trace[472488131] 'process raft request' (duration: 137.145269ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.645366Z","caller":"traceutil/trace.go:171","msg":"trace[449618932] transaction","detail":"{read_only:false; response_revision:1444; number_of_response:1; }","duration":"137.342095ms","start":"2026-09-15T02:20:34.508006Z","end":"2026-09-15T02:20:34.645348Z","steps":["trace[449618932] 'process raft request' (duration: 137.146229ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.645542Z","caller":"traceutil/trace.go:171","msg":"trace[781545977] linearizableReadLoop","detail":"{readStateIndex:1497; appliedIndex:1495; }","duration":"139.798383ms","start":"2026-09-15T02:20:34.505733Z","end":"2026-09-15T02:20:34.645532Z","steps":["trace[781545977] 'read index received' (duration: 39.587454ms)","trace[781545977] 'applied index is now lower than readState.Index' (duration: 100.210129ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:20:34.645718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.966028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/ingress-nginx/ingress-nginx-defaultbackend-6987ff55cf\" ","response":"range_response_count:1 size:4169"} {"level":"info","ts":"2026-09-15T02:20:34.645756Z","caller":"traceutil/trace.go:171","msg":"trace[1729444094] range","detail":"{range_begin:/registry/replicasets/ingress-nginx/ingress-nginx-defaultbackend-6987ff55cf; range_end:; response_count:1; response_revision:1445; }","duration":"140.05434ms","start":"2026-09-15T02:20:34.50569Z","end":"2026-09-15T02:20:34.645744Z","steps":["trace[1729444094] 'agreement among raft nodes before linearized reading' (duration: 139.881385ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:34.64585Z","caller":"traceutil/trace.go:171","msg":"trace[846876693] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"105.531776ms","start":"2026-09-15T02:20:34.540255Z","end":"2026-09-15T02:20:34.645787Z","steps":["trace[846876693] 'process raft request' (duration: 105.013552ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:21:04.898513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.669759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:21:04.898853Z","caller":"traceutil/trace.go:171","msg":"trace[1352181470] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"386.121419ms","start":"2026-09-15T02:21:04.512705Z","end":"2026-09-15T02:21:04.898826Z","steps":["trace[1352181470] 'process raft request' (duration: 47.031551ms)","trace[1352181470] 'compare' (duration: 338.490595ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:21:04.898967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:21:04.512681Z","time spent":"386.226141ms","remote":"127.0.0.1:51264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T02:21:04.909634Z","caller":"traceutil/trace.go:171","msg":"trace[319894726] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"299.146139ms","start":"2026-09-15T02:21:04.610468Z","end":"2026-09-15T02:21:04.909614Z","steps":["trace[319894726] 'process raft request' (duration: 299.025666ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:21:04.987432Z","caller":"traceutil/trace.go:171","msg":"trace[1069348815] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"182.107787ms","start":"2026-09-15T02:21:04.805295Z","end":"2026-09-15T02:21:04.987403Z","steps":["trace[1069348815] 'process raft request' (duration: 181.968394ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:21:05.383249Z","caller":"traceutil/trace.go:171","msg":"trace[825004610] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"185.452822ms","start":"2026-09-15T02:21:05.197767Z","end":"2026-09-15T02:21:05.38322Z","steps":["trace[825004610] 'process raft request' (duration: 185.198627ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:21:17.112932Z","caller":"traceutil/trace.go:171","msg":"trace[59223110] transaction","detail":"{read_only:false; response_revision:2023; number_of_response:1; }","duration":"166.762953ms","start":"2026-09-15T02:21:16.946134Z","end":"2026-09-15T02:21:17.112897Z","steps":["trace[59223110] 'process raft request' (duration: 155.230904ms)","trace[59223110] 'compare' (duration: 11.396046ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:21:17.242107Z","caller":"traceutil/trace.go:171","msg":"trace[1842863348] linearizableReadLoop","detail":"{readStateIndex:2110; appliedIndex:2108; }","duration":"174.886013ms","start":"2026-09-15T02:21:17.067195Z","end":"2026-09-15T02:21:17.242081Z","steps":["trace[1842863348] 'read index received' (duration: 34.245889ms)","trace[1842863348] 'applied index is now lower than readState.Index' (duration: 140.639074ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:21:17.242227Z","caller":"traceutil/trace.go:171","msg":"trace[169884810] transaction","detail":"{read_only:false; response_revision:2024; number_of_response:1; }","duration":"218.301459ms","start":"2026-09-15T02:21:17.023895Z","end":"2026-09-15T02:21:17.242196Z","steps":["trace[169884810] 'process raft request' (duration: 201.780843ms)","trace[169884810] 'compare' (duration: 16.200759ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:21:17.242411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.487525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-15T02:21:17.2424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.184789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-15T02:21:17.242463Z","caller":"traceutil/trace.go:171","msg":"trace[116743712] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2024; }","duration":"169.544897ms","start":"2026-09-15T02:21:17.072904Z","end":"2026-09-15T02:21:17.242449Z","steps":["trace[116743712] 'agreement among raft nodes before linearized reading' (duration: 169.464055ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:21:17.242472Z","caller":"traceutil/trace.go:171","msg":"trace[1781767592] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2024; }","duration":"175.301031ms","start":"2026-09-15T02:21:17.067158Z","end":"2026-09-15T02:21:17.242459Z","steps":["trace[1781767592] 'agreement among raft nodes before linearized reading' (duration: 175.058476ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:21:21.228487Z","caller":"traceutil/trace.go:171","msg":"trace[1529722286] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"104.884412ms","start":"2026-09-15T02:21:21.123572Z","end":"2026-09-15T02:21:21.228457Z","steps":["trace[1529722286] 'process raft request' (duration: 104.691938ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:21:37.975556Z","caller":"traceutil/trace.go:171","msg":"trace[380305530] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"158.226205ms","start":"2026-09-15T02:21:37.817313Z","end":"2026-09-15T02:21:37.97554Z","steps":["trace[380305530] 'process raft request' (duration: 157.844068ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:21:44.544178Z","caller":"traceutil/trace.go:171","msg":"trace[1054292428] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"227.512744ms","start":"2026-09-15T02:21:44.316635Z","end":"2026-09-15T02:21:44.544147Z","steps":["trace[1054292428] 'process raft request' (duration: 227.29188ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:21:44.806067Z","caller":"traceutil/trace.go:171","msg":"trace[86065014] linearizableReadLoop","detail":"{readStateIndex:2279; appliedIndex:2277; }","duration":"368.113044ms","start":"2026-09-15T02:21:44.437928Z","end":"2026-09-15T02:21:44.806041Z","steps":["trace[86065014] 'read index received' (duration: 105.962876ms)","trace[86065014] 'applied index is now lower than readState.Index' (duration: 262.149018ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:21:44.806264Z","caller":"traceutil/trace.go:171","msg":"trace[387595274] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"438.866957ms","start":"2026-09-15T02:21:44.367384Z","end":"2026-09-15T02:21:44.806251Z","steps":["trace[387595274] 'process raft request' (duration: 428.604097ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:21:44.806518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.220502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-15T02:21:44.806555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:21:44.367342Z","time spent":"439.08219ms","remote":"127.0.0.1:51264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T02:21:44.80657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.540546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-15T02:21:44.806586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.656014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-15T02:21:44.806608Z","caller":"traceutil/trace.go:171","msg":"trace[2048810349] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:2187; }","duration":"222.368826ms","start":"2026-09-15T02:21:44.584217Z","end":"2026-09-15T02:21:44.806586Z","steps":["trace[2048810349] 'agreement among raft nodes before linearized reading' (duration: 222.220553ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:21:44.806646Z","caller":"traceutil/trace.go:171","msg":"trace[1068193895] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2187; }","duration":"368.751746ms","start":"2026-09-15T02:21:44.437876Z","end":"2026-09-15T02:21:44.806628Z","steps":["trace[1068193895] 'agreement among raft nodes before linearized reading' (duration: 368.569452ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:21:44.806643Z","caller":"traceutil/trace.go:171","msg":"trace[1401365437] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2187; }","duration":"226.691929ms","start":"2026-09-15T02:21:44.579931Z","end":"2026-09-15T02:21:44.806623Z","steps":["trace[1401365437] 'agreement among raft nodes before linearized reading' (duration: 226.545806ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:21:44.806678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:21:44.437852Z","time spent":"368.817556ms","remote":"127.0.0.1:34180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-15T02:21:44.806684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.783461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-15T02:21:44.806775Z","caller":"traceutil/trace.go:171","msg":"trace[135398602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2187; }","duration":"341.906524ms","start":"2026-09-15T02:21:44.46484Z","end":"2026-09-15T02:21:44.806746Z","steps":["trace[135398602] 'agreement among raft nodes before linearized reading' (duration: 341.646399ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:21:44.806819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:21:44.464811Z","time spent":"341.999386ms","remote":"127.0.0.1:51264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-15T02:21:44.807096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.076781ms","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-15T02:21:44.807137Z","caller":"traceutil/trace.go:171","msg":"trace[1780306088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2187; }","duration":"353.145232ms","start":"2026-09-15T02:21:44.453981Z","end":"2026-09-15T02:21:44.807126Z","steps":["trace[1780306088] 'agreement among raft nodes before linearized reading' (duration: 352.306206ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:21:44.807163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:21:44.453968Z","time spent":"353.188313ms","remote":"127.0.0.1:51264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-15T02:22:39.365846Z","caller":"traceutil/trace.go:171","msg":"trace[1547706862] linearizableReadLoop","detail":"{readStateIndex:2690; appliedIndex:2689; }","duration":"284.12298ms","start":"2026-09-15T02:22:39.081706Z","end":"2026-09-15T02:22:39.365829Z","steps":["trace[1547706862] 'read index received' (duration: 284.081379ms)","trace[1547706862] 'applied index is now lower than readState.Index' (duration: 40.801µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:22:39.365933Z","caller":"traceutil/trace.go:171","msg":"trace[884578761] transaction","detail":"{read_only:false; response_revision:2585; number_of_response:1; }","duration":"346.629224ms","start":"2026-09-15T02:22:39.019297Z","end":"2026-09-15T02:22:39.365927Z","steps":["trace[884578761] 'process raft request' (duration: 346.40183ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:22:39.366023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:22:39.019267Z","time spent":"346.690275ms","remote":"127.0.0.1:51264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T02:22:39.366165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.470096ms","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-15T02:22:39.366183Z","caller":"traceutil/trace.go:171","msg":"trace[1700557652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2585; }","duration":"284.521487ms","start":"2026-09-15T02:22:39.081657Z","end":"2026-09-15T02:22:39.366178Z","steps":["trace[1700557652] 'agreement among raft nodes before linearized reading' (duration: 284.447386ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:22:39.368389Z","caller":"traceutil/trace.go:171","msg":"trace[1868697181] transaction","detail":"{read_only:false; response_revision:2586; number_of_response:1; }","duration":"262.176546ms","start":"2026-09-15T02:22:39.106182Z","end":"2026-09-15T02:22:39.368358Z","steps":["trace[1868697181] 'process raft request' (duration: 261.985013ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:22:39.368443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.115315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-15T02:22:39.36854Z","caller":"traceutil/trace.go:171","msg":"trace[1478464018] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2586; }","duration":"174.274418ms","start":"2026-09-15T02:22:39.194246Z","end":"2026-09-15T02:22:39.368521Z","steps":["trace[1478464018] 'agreement among raft nodes before linearized reading' (duration: 174.046544ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:23:14.442358Z","caller":"traceutil/trace.go:171","msg":"trace[1671714893] transaction","detail":"{read_only:false; response_revision:2780; number_of_response:1; }","duration":"149.849982ms","start":"2026-09-15T02:23:14.292483Z","end":"2026-09-15T02:23:14.442333Z","steps":["trace[1671714893] 'process raft request' (duration: 149.71588ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:23:14.456281Z","caller":"traceutil/trace.go:171","msg":"trace[154218805] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"121.118484ms","start":"2026-09-15T02:23:14.335138Z","end":"2026-09-15T02:23:14.456257Z","steps":["trace[154218805] 'process raft request' (duration: 120.991072ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:23:14.734429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.027504ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:23:14.734878Z","caller":"traceutil/trace.go:171","msg":"trace[1831960526] transaction","detail":"{read_only:false; response_revision:2782; number_of_response:1; }","duration":"210.27418ms","start":"2026-09-15T02:23:14.524574Z","end":"2026-09-15T02:23:14.734848Z","steps":["trace[1831960526] 'process raft request' (duration: 72.751907ms)","trace[1831960526] 'compare' (duration: 136.910212ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:23:15.011133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.70709ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:23:15.01127Z","caller":"traceutil/trace.go:171","msg":"trace[506596331] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2782; }","duration":"106.880892ms","start":"2026-09-15T02:23:14.904368Z","end":"2026-09-15T02:23:15.011249Z","steps":["trace[506596331] 'range keys from in-memory index tree' (duration: 106.687039ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:27:40.25121Z","caller":"traceutil/trace.go:171","msg":"trace[1889180076] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"127.258957ms","start":"2026-09-15T02:27:40.123927Z","end":"2026-09-15T02:27:40.251186Z","steps":["trace[1889180076] 'process raft request' (duration: 127.126394ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:27:40.258214Z","caller":"traceutil/trace.go:171","msg":"trace[1966312500] transaction","detail":"{read_only:false; response_revision:4868; number_of_response:1; }","duration":"124.481157ms","start":"2026-09-15T02:27:40.133709Z","end":"2026-09-15T02:27:40.258191Z","steps":["trace[1966312500] 'process raft request' (duration: 124.310824ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:45.883336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.560752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:45.883444Z","caller":"traceutil/trace.go:171","msg":"trace[1649671921] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:4922; }","duration":"296.709995ms","start":"2026-09-15T02:27:45.586717Z","end":"2026-09-15T02:27:45.883427Z","steps":["trace[1649671921] 'count revisions from in-memory index tree' (duration: 296.43934ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:45.883791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.96749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-15T02:27:45.883847Z","caller":"traceutil/trace.go:171","msg":"trace[1173153615] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4922; }","duration":"259.053742ms","start":"2026-09-15T02:27:45.624781Z","end":"2026-09-15T02:27:45.883835Z","steps":["trace[1173153615] 'range keys from in-memory index tree' (duration: 258.835919ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:27:46.360043Z","caller":"traceutil/trace.go:171","msg":"trace[2100510983] linearizableReadLoop","detail":"{readStateIndex:5123; appliedIndex:5122; }","duration":"160.648115ms","start":"2026-09-15T02:27:46.199379Z","end":"2026-09-15T02:27:46.360027Z","steps":["trace[2100510983] 'read index received' (duration: 160.544513ms)","trace[2100510983] 'applied index is now lower than readState.Index' (duration: 102.922µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:27:46.360239Z","caller":"traceutil/trace.go:171","msg":"trace[1690862652] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"174.524012ms","start":"2026-09-15T02:27:46.185708Z","end":"2026-09-15T02:27:46.360232Z","steps":["trace[1690862652] 'process raft request' (duration: 174.222716ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:46.36036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.971341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:46.360381Z","caller":"traceutil/trace.go:171","msg":"trace[1529199857] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4926; }","duration":"161.037341ms","start":"2026-09-15T02:27:46.199339Z","end":"2026-09-15T02:27:46.360376Z","steps":["trace[1529199857] 'agreement among raft nodes before linearized reading' (duration: 160.99315ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:46.360528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.459313ms","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-09-15T02:27:46.360547Z","caller":"traceutil/trace.go:171","msg":"trace[1945565652] 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:4926; }","duration":"104.478393ms","start":"2026-09-15T02:27:46.256062Z","end":"2026-09-15T02:27:46.360541Z","steps":["trace[1945565652] 'agreement among raft nodes before linearized reading' (duration: 104.411202ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:27:50.403414Z","caller":"traceutil/trace.go:171","msg":"trace[2134145114] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"112.31675ms","start":"2026-09-15T02:27:50.291069Z","end":"2026-09-15T02:27:50.403385Z","steps":["trace[2134145114] 'process raft request' (duration: 112.201537ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:28:32.751706Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2876} {"level":"info","ts":"2026-09-15T02:28:32.830581Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2876,"took":"77.463423ms","hash":1499489349,"current-db-size-bytes":53796864,"current-db-size":"54 MB","current-db-size-in-use-bytes":28639232,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-09-15T02:28:32.830645Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1499489349,"revision":2876,"compact-revision":-1} {"level":"info","ts":"2026-09-15T02:28:37.378303Z","caller":"traceutil/trace.go:171","msg":"trace[1208618217] transaction","detail":"{read_only:false; response_revision:5490; number_of_response:1; }","duration":"117.833623ms","start":"2026-09-15T02:28:37.260431Z","end":"2026-09-15T02:28:37.378265Z","steps":["trace[1208618217] 'process raft request' (duration: 110.052777ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:33:32.757744Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5464} {"level":"info","ts":"2026-09-15T02:33:32.869984Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5464,"took":"110.761979ms","hash":2252853785,"current-db-size-bytes":53796864,"current-db-size":"54 MB","current-db-size-in-use-bytes":18763776,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-15T02:33:32.870028Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2252853785,"revision":5464,"compact-revision":2876}