{"level":"warn","ts":"2026-10-13T10:53:23.091365Z","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-13T10:53:23.091446Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.205: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.205:2380","--initial-cluster=instance=https://162.253.55.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.205: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-13T10:53:23.091509Z","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-13T10:53:23.09152Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.205:2380"]} {"level":"info","ts":"2026-10-13T10:53:23.091539Z","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-13T10:53:23.09214Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.205:2379"]} {"level":"info","ts":"2026-10-13T10:53:23.092234Z","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.205:2380"],"listen-peer-urls":["https://162.253.55.205:2380"],"advertise-client-urls":["https://162.253.55.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.205: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-13T10:53:23.095192Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.732651ms"} {"level":"info","ts":"2026-10-13T10:53:23.101578Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f1f73ead33f822e","cluster-id":"eaba2551c55d0fa5"} {"level":"info","ts":"2026-10-13T10:53:23.10168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e switched to configuration voters=()"} {"level":"info","ts":"2026-10-13T10:53:23.101707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became follower at term 0"} {"level":"info","ts":"2026-10-13T10:53:23.101725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f1f73ead33f822e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-13T10:53:23.101734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became follower at term 1"} {"level":"info","ts":"2026-10-13T10:53:23.101767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e switched to configuration voters=(6854324610284880430)"} {"level":"warn","ts":"2026-10-13T10:53:23.106503Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-13T10:53:23.107816Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-13T10:53:23.108851Z","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-13T10:53:23.110716Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f1f73ead33f822e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-13T10:53:23.110817Z","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-13T10:53:23.110869Z","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-13T10:53:23.110877Z","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-13T10:53:23.111077Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f1f73ead33f822e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-13T10:53:23.111524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e switched to configuration voters=(6854324610284880430)"} {"level":"info","ts":"2026-10-13T10:53:23.111682Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"eaba2551c55d0fa5","local-member-id":"5f1f73ead33f822e","added-peer-id":"5f1f73ead33f822e","added-peer-peer-urls":["https://162.253.55.205:2380"]} {"level":"info","ts":"2026-10-13T10:53:23.114266Z","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-13T10:53:23.114452Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.205:2380"} {"level":"info","ts":"2026-10-13T10:53:23.114561Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.205:2380"} {"level":"info","ts":"2026-10-13T10:53:23.115461Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f1f73ead33f822e","initial-advertise-peer-urls":["https://162.253.55.205:2380"],"listen-peer-urls":["https://162.253.55.205:2380"],"advertise-client-urls":["https://162.253.55.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-13T10:53:23.115491Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-13T10:53:23.902864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e is starting a new election at term 1"} {"level":"info","ts":"2026-10-13T10:53:23.902919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became pre-candidate at term 1"} {"level":"info","ts":"2026-10-13T10:53:23.902952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e received MsgPreVoteResp from 5f1f73ead33f822e at term 1"} {"level":"info","ts":"2026-10-13T10:53:23.902981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became candidate at term 2"} {"level":"info","ts":"2026-10-13T10:53:23.902996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e received MsgVoteResp from 5f1f73ead33f822e at term 2"} {"level":"info","ts":"2026-10-13T10:53:23.903014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f1f73ead33f822e became leader at term 2"} {"level":"info","ts":"2026-10-13T10:53:23.903034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f1f73ead33f822e elected leader 5f1f73ead33f822e at term 2"} {"level":"info","ts":"2026-10-13T10:53:23.904037Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T10:53:23.905253Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f1f73ead33f822e","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.205:2379]}","request-path":"/0/members/5f1f73ead33f822e/attributes","cluster-id":"eaba2551c55d0fa5","publish-timeout":"7s"} {"level":"info","ts":"2026-10-13T10:53:23.905281Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T10:53:23.905301Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T10:53:23.905523Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-13T10:53:23.905544Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-13T10:53:23.905817Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"eaba2551c55d0fa5","local-member-id":"5f1f73ead33f822e","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T10:53:23.905913Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T10:53:23.905952Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T10:53:23.907194Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.205:2379"} {"level":"info","ts":"2026-10-13T10:53:23.908748Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-13T10:53:38.821324Z","caller":"traceutil/trace.go:171","msg":"trace[29247934] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"139.292605ms","start":"2026-10-13T10:53:38.682006Z","end":"2026-10-13T10:53:38.821298Z","steps":["trace[29247934] 'process raft request' (duration: 139.144771ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:53:39.212879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.674018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:53:39.212986Z","caller":"traceutil/trace.go:171","msg":"trace[164491932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:369; }","duration":"316.837772ms","start":"2026-10-13T10:53:38.896131Z","end":"2026-10-13T10:53:39.212969Z","steps":["trace[164491932] 'range keys from in-memory index tree' (duration: 316.558645ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:53:39.213023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:53:38.896109Z","time spent":"316.906733ms","remote":"127.0.0.1:41242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-13T10:53:39.213357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.166103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4796"} {"level":"info","ts":"2026-10-13T10:53:39.213452Z","caller":"traceutil/trace.go:171","msg":"trace[2111638769] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:369; }","duration":"314.300397ms","start":"2026-10-13T10:53:38.89913Z","end":"2026-10-13T10:53:39.213431Z","steps":["trace[2111638769] 'range keys from in-memory index tree' (duration: 314.06187ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:53:39.213472Z","caller":"traceutil/trace.go:171","msg":"trace[1263420603] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"183.260243ms","start":"2026-10-13T10:53:39.03018Z","end":"2026-10-13T10:53:39.21344Z","steps":["trace[1263420603] 'process raft request' (duration: 174.581501ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:53:39.213499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:53:38.899118Z","time spent":"314.369118ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":4819,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"info","ts":"2026-10-13T10:54:10.619921Z","caller":"traceutil/trace.go:171","msg":"trace[194555107] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"230.868375ms","start":"2026-10-13T10:54:10.38901Z","end":"2026-10-13T10:54:10.619896Z","steps":["trace[194555107] 'process raft request' (duration: 230.757772ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:54:14.283501Z","caller":"traceutil/trace.go:171","msg":"trace[1493928507] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"167.862159ms","start":"2026-10-13T10:54:14.1156Z","end":"2026-10-13T10:54:14.283462Z","steps":["trace[1493928507] 'process raft request' (duration: 159.960096ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:54:14.32051Z","caller":"traceutil/trace.go:171","msg":"trace[1761428311] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"204.834668ms","start":"2026-10-13T10:54:14.115642Z","end":"2026-10-13T10:54:14.320477Z","steps":["trace[1761428311] 'process raft request' (duration: 204.236143ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:54:14.835574Z","caller":"traceutil/trace.go:171","msg":"trace[415522446] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"433.840695ms","start":"2026-10-13T10:54:14.401701Z","end":"2026-10-13T10:54:14.835542Z","steps":["trace[415522446] 'process raft request' (duration: 433.686611ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:54:14.836273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:54:14.401674Z","time spent":"433.99473ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T10:54:29.659631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.126559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-13T10:54:29.659834Z","caller":"traceutil/trace.go:171","msg":"trace[761789315] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:769; }","duration":"204.372366ms","start":"2026-10-13T10:54:29.455437Z","end":"2026-10-13T10:54:29.659809Z","steps":["trace[761789315] 'range keys from in-memory index tree' (duration: 203.928904ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:08.890098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.989392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-13T10:55:08.890339Z","caller":"traceutil/trace.go:171","msg":"trace[640469182] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1056; }","duration":"297.273939ms","start":"2026-10-13T10:55:08.593048Z","end":"2026-10-13T10:55:08.890322Z","steps":["trace[640469182] 'count revisions from in-memory index tree' (duration: 296.8687ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:26.112559Z","caller":"traceutil/trace.go:171","msg":"trace[2041396700] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"151.010396ms","start":"2026-10-13T10:55:25.961521Z","end":"2026-10-13T10:55:26.112531Z","steps":["trace[2041396700] 'process raft request' (duration: 150.874243ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:26.482905Z","caller":"traceutil/trace.go:171","msg":"trace[558498083] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"123.209773ms","start":"2026-10-13T10:55:26.359639Z","end":"2026-10-13T10:55:26.482848Z","steps":["trace[558498083] 'process raft request' (duration: 123.033548ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:26.757287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.694511ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T10:55:26.75737Z","caller":"traceutil/trace.go:171","msg":"trace[1055870488] linearizableReadLoop","detail":"{readStateIndex:1174; appliedIndex:1173; }","duration":"272.071433ms","start":"2026-10-13T10:55:26.485284Z","end":"2026-10-13T10:55:26.757356Z","steps":["trace[1055870488] 'read index received' (duration: 146.89947ms)","trace[1055870488] 'applied index is now lower than readState.Index' (duration: 125.171143ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:26.757427Z","caller":"traceutil/trace.go:171","msg":"trace[728377085] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"283.910427ms","start":"2026-10-13T10:55:26.4735Z","end":"2026-10-13T10:55:26.757411Z","steps":["trace[728377085] 'process raft request' (duration: 158.748234ms)","trace[728377085] 'compare' (duration: 124.395123ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:55:26.757494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.207586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:55:26.757577Z","caller":"traceutil/trace.go:171","msg":"trace[422872982] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1133; }","duration":"272.343279ms","start":"2026-10-13T10:55:26.485214Z","end":"2026-10-13T10:55:26.757557Z","steps":["trace[422872982] 'agreement among raft nodes before linearized reading' (duration: 272.211466ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:26.757594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.786316ms","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-10-13T10:55:26.75762Z","caller":"traceutil/trace.go:171","msg":"trace[45233431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1133; }","duration":"250.850239ms","start":"2026-10-13T10:55:26.506763Z","end":"2026-10-13T10:55:26.757613Z","steps":["trace[45233431] 'agreement among raft nodes before linearized reading' (duration: 250.738696ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:26.971344Z","caller":"traceutil/trace.go:171","msg":"trace[1864122424] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"210.190655ms","start":"2026-10-13T10:55:26.761122Z","end":"2026-10-13T10:55:26.971313Z","steps":["trace[1864122424] 'process raft request' (duration: 210.035571ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:26.991377Z","caller":"traceutil/trace.go:171","msg":"trace[306671176] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"207.708171ms","start":"2026-10-13T10:55:26.783645Z","end":"2026-10-13T10:55:26.991353Z","steps":["trace[306671176] 'process raft request' (duration: 207.597708ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:27.214447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.918361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-13T10:55:27.214528Z","caller":"traceutil/trace.go:171","msg":"trace[5002983] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1136; }","duration":"154.042113ms","start":"2026-10-13T10:55:27.060468Z","end":"2026-10-13T10:55:27.214511Z","steps":["trace[5002983] 'range keys from in-memory index tree' (duration: 153.836019ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:27.584213Z","caller":"traceutil/trace.go:171","msg":"trace[1649033814] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"228.294368ms","start":"2026-10-13T10:55:27.355896Z","end":"2026-10-13T10:55:27.58419Z","steps":["trace[1649033814] 'process raft request' (duration: 228.142955ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:27.584353Z","caller":"traceutil/trace.go:171","msg":"trace[1799274102] linearizableReadLoop","detail":"{readStateIndex:1179; appliedIndex:1179; }","duration":"221.473014ms","start":"2026-10-13T10:55:27.362836Z","end":"2026-10-13T10:55:27.584309Z","steps":["trace[1799274102] 'read index received' (duration: 221.463874ms)","trace[1799274102] 'applied index is now lower than readState.Index' (duration: 7.27µs)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:55:27.584537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.664329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:55:27.584592Z","caller":"traceutil/trace.go:171","msg":"trace[1373716628] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1137; }","duration":"221.768982ms","start":"2026-10-13T10:55:27.362806Z","end":"2026-10-13T10:55:27.584575Z","steps":["trace[1373716628] 'agreement among raft nodes before linearized reading' (duration: 221.637699ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.05261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.593963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:55:28.052667Z","caller":"traceutil/trace.go:171","msg":"trace[220378292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1137; }","duration":"155.659245ms","start":"2026-10-13T10:55:27.896995Z","end":"2026-10-13T10:55:28.052654Z","steps":["trace[220378292] 'range keys from in-memory index tree' (duration: 155.526511ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.293333Z","caller":"traceutil/trace.go:171","msg":"trace[102569449] linearizableReadLoop","detail":"{readStateIndex:1180; appliedIndex:1179; }","duration":"133.515066ms","start":"2026-10-13T10:55:28.1598Z","end":"2026-10-13T10:55:28.293315Z","steps":["trace[102569449] 'read index received' (duration: 133.458604ms)","trace[102569449] 'applied index is now lower than readState.Index' (duration: 55.782µs)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:55:28.293463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.64834ms","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-10-13T10:55:28.293483Z","caller":"traceutil/trace.go:171","msg":"trace[1200379157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1138; }","duration":"133.713821ms","start":"2026-10-13T10:55:28.159762Z","end":"2026-10-13T10:55:28.293476Z","steps":["trace[1200379157] 'agreement among raft nodes before linearized reading' (duration: 133.620638ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.293575Z","caller":"traceutil/trace.go:171","msg":"trace[493987226] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"174.224792ms","start":"2026-10-13T10:55:28.119327Z","end":"2026-10-13T10:55:28.293552Z","steps":["trace[493987226] 'process raft request' (duration: 173.888883ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.473312Z","caller":"traceutil/trace.go:171","msg":"trace[1250978664] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"176.939411ms","start":"2026-10-13T10:55:28.296356Z","end":"2026-10-13T10:55:28.473295Z","steps":["trace[1250978664] 'process raft request' (duration: 176.818758ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.517893Z","caller":"traceutil/trace.go:171","msg":"trace[335964384] linearizableReadLoop","detail":"{readStateIndex:1182; appliedIndex:1180; }","duration":"118.409849ms","start":"2026-10-13T10:55:28.399412Z","end":"2026-10-13T10:55:28.517822Z","steps":["trace[335964384] 'read index received' (duration: 73.772063ms)","trace[335964384] 'applied index is now lower than readState.Index' (duration: 44.636926ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:28.51798Z","caller":"traceutil/trace.go:171","msg":"trace[2120299253] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"220.196901ms","start":"2026-10-13T10:55:28.297734Z","end":"2026-10-13T10:55:28.517931Z","steps":["trace[2120299253] 'process raft request' (duration: 219.930915ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.518029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.599393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:55:28.518201Z","caller":"traceutil/trace.go:171","msg":"trace[731090526] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1140; }","duration":"118.81136ms","start":"2026-10-13T10:55:28.399378Z","end":"2026-10-13T10:55:28.518189Z","steps":["trace[731090526] 'agreement among raft nodes before linearized reading' (duration: 118.591963ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.64467Z","caller":"traceutil/trace.go:171","msg":"trace[379255962] linearizableReadLoop","detail":"{readStateIndex:1183; appliedIndex:1182; }","duration":"121.58013ms","start":"2026-10-13T10:55:28.523069Z","end":"2026-10-13T10:55:28.644649Z","steps":["trace[379255962] 'read index received' (duration: 24.058638ms)","trace[379255962] 'applied index is now lower than readState.Index' (duration: 97.520692ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:28.644813Z","caller":"traceutil/trace.go:171","msg":"trace[1382616669] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"122.827022ms","start":"2026-10-13T10:55:28.521964Z","end":"2026-10-13T10:55:28.644791Z","steps":["trace[1382616669] 'process raft request' (duration: 25.125845ms)","trace[1382616669] 'compare' (duration: 97.44229ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:55:28.644841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.749925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:55:28.644902Z","caller":"traceutil/trace.go:171","msg":"trace[988564552] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:1141; }","duration":"121.827768ms","start":"2026-10-13T10:55:28.523064Z","end":"2026-10-13T10:55:28.644892Z","steps":["trace[988564552] 'agreement among raft nodes before linearized reading' (duration: 121.725635ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.658362Z","caller":"traceutil/trace.go:171","msg":"trace[1663636949] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"108.769262ms","start":"2026-10-13T10:55:28.549557Z","end":"2026-10-13T10:55:28.658326Z","steps":["trace[1663636949] 'process raft request' (duration: 108.592236ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.889783Z","caller":"traceutil/trace.go:171","msg":"trace[1657192623] linearizableReadLoop","detail":"{readStateIndex:1186; appliedIndex:1185; }","duration":"167.788707ms","start":"2026-10-13T10:55:28.721957Z","end":"2026-10-13T10:55:28.889746Z","steps":["trace[1657192623] 'read index received' (duration: 167.577551ms)","trace[1657192623] 'applied index is now lower than readState.Index' (duration: 210.236µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:28.889807Z","caller":"traceutil/trace.go:171","msg":"trace[172377651] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"228.859004ms","start":"2026-10-13T10:55:28.660915Z","end":"2026-10-13T10:55:28.889774Z","steps":["trace[172377651] 'process raft request' (duration: 228.568267ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.89Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.015972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-10-13T10:55:28.890051Z","caller":"traceutil/trace.go:171","msg":"trace[1707221459] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1144; }","duration":"168.091255ms","start":"2026-10-13T10:55:28.721937Z","end":"2026-10-13T10:55:28.890028Z","steps":["trace[1707221459] 'agreement among raft nodes before linearized reading' (duration: 167.91663ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.89946Z","caller":"traceutil/trace.go:171","msg":"trace[1329977510] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"177.379463ms","start":"2026-10-13T10:55:28.722063Z","end":"2026-10-13T10:55:28.899442Z","steps":["trace[1329977510] 'process raft request' (duration: 177.025173ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.899812Z","caller":"traceutil/trace.go:171","msg":"trace[145164394] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"136.902064ms","start":"2026-10-13T10:55:28.762882Z","end":"2026-10-13T10:55:28.899784Z","steps":["trace[145164394] 'process raft request' (duration: 136.787811ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.899865Z","caller":"traceutil/trace.go:171","msg":"trace[232319450] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"177.321742ms","start":"2026-10-13T10:55:28.722512Z","end":"2026-10-13T10:55:28.899834Z","steps":["trace[232319450] 'process raft request' (duration: 176.893901ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:29.144779Z","caller":"traceutil/trace.go:171","msg":"trace[1482778455] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"249.906884ms","start":"2026-10-13T10:55:28.894846Z","end":"2026-10-13T10:55:29.144753Z","steps":["trace[1482778455] 'process raft request' (duration: 225.509217ms)","trace[1482778455] 'compare' (duration: 23.566476ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:29.14489Z","caller":"traceutil/trace.go:171","msg":"trace[1439039413] linearizableReadLoop","detail":"{readStateIndex:1190; appliedIndex:1189; }","duration":"169.084139ms","start":"2026-10-13T10:55:28.975782Z","end":"2026-10-13T10:55:29.144866Z","steps":["trace[1439039413] 'read index received' (duration: 144.517519ms)","trace[1439039413] 'applied index is now lower than readState.Index' (duration: 24.56514ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:55:29.145118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.305495ms","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-10-13T10:55:29.145173Z","caller":"traceutil/trace.go:171","msg":"trace[932576453] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1148; }","duration":"169.415908ms","start":"2026-10-13T10:55:28.975742Z","end":"2026-10-13T10:55:29.145158Z","steps":["trace[932576453] 'agreement among raft nodes before linearized reading' (duration: 169.223573ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:29.305329Z","caller":"traceutil/trace.go:171","msg":"trace[303547557] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"156.479715ms","start":"2026-10-13T10:55:29.148832Z","end":"2026-10-13T10:55:29.305312Z","steps":["trace[303547557] 'process raft request' (duration: 151.875258ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:15.981467Z","caller":"traceutil/trace.go:171","msg":"trace[247138673] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"104.394437ms","start":"2026-10-13T10:59:15.877038Z","end":"2026-10-13T10:59:15.981433Z","steps":["trace[247138673] 'process raft request' (duration: 38.473015ms)","trace[247138673] 'compare' (duration: 65.776298ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:59:19.161911Z","caller":"traceutil/trace.go:171","msg":"trace[1278167929] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"173.743989ms","start":"2026-10-13T10:59:18.988139Z","end":"2026-10-13T10:59:19.161883Z","steps":["trace[1278167929] 'process raft request' (duration: 173.607646ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:21.34905Z","caller":"traceutil/trace.go:171","msg":"trace[1709511108] linearizableReadLoop","detail":"{readStateIndex:2327; appliedIndex:2326; }","duration":"135.235283ms","start":"2026-10-13T10:59:21.213792Z","end":"2026-10-13T10:59:21.349028Z","steps":["trace[1709511108] 'read index received' (duration: 135.046439ms)","trace[1709511108] 'applied index is now lower than readState.Index' (duration: 187.544µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:59:21.349161Z","caller":"traceutil/trace.go:171","msg":"trace[613976733] transaction","detail":"{read_only:false; response_revision:2238; number_of_response:1; }","duration":"179.292444ms","start":"2026-10-13T10:59:21.169834Z","end":"2026-10-13T10:59:21.349126Z","steps":["trace[613976733] 'process raft request' (duration: 179.028917ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:21.349258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.440979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-13T10:59:21.349299Z","caller":"traceutil/trace.go:171","msg":"trace[470415104] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2238; }","duration":"135.51886ms","start":"2026-10-13T10:59:21.213766Z","end":"2026-10-13T10:59:21.349285Z","steps":["trace[470415104] 'agreement among raft nodes before linearized reading' (duration: 135.352466ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:23.053378Z","caller":"traceutil/trace.go:171","msg":"trace[1145563890] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"165.865843ms","start":"2026-10-13T10:59:22.887489Z","end":"2026-10-13T10:59:23.053355Z","steps":["trace[1145563890] 'process raft request' (duration: 165.72816ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:23.461651Z","caller":"traceutil/trace.go:171","msg":"trace[262615502] transaction","detail":"{read_only:false; response_revision:2248; number_of_response:1; }","duration":"104.071179ms","start":"2026-10-13T10:59:23.357555Z","end":"2026-10-13T10:59:23.461626Z","steps":["trace[262615502] 'process raft request' (duration: 99.809328ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T11:00:04.93279Z","caller":"traceutil/trace.go:171","msg":"trace[1775415313] transaction","detail":"{read_only:false; response_revision:2466; number_of_response:1; }","duration":"144.215667ms","start":"2026-10-13T11:00:04.788544Z","end":"2026-10-13T11:00:04.932759Z","steps":["trace[1775415313] 'process raft request' (duration: 100.117169ms)","trace[1775415313] 'compare' (duration: 43.937804ms)"],"step_count":2}