{"level":"warn","ts":"2026-10-17T10:31:18.739058Z","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-17T10:31:18.739213Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.147: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.147:2380","--initial-cluster=instance=https://162.253.55.147:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.147:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.147: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-17T10:31:18.739342Z","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-17T10:31:18.739358Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.147:2380"]} {"level":"info","ts":"2026-10-17T10:31:18.739386Z","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-17T10:31:18.740546Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.147:2379"]} {"level":"info","ts":"2026-10-17T10:31:18.74071Z","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.147:2380"],"listen-peer-urls":["https://162.253.55.147:2380"],"advertise-client-urls":["https://162.253.55.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.147: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-17T10:31:18.747207Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.105183ms"} {"level":"info","ts":"2026-10-17T10:31:18.75452Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4d4c1b1786e4e6dd","cluster-id":"c387147481076682"} {"level":"info","ts":"2026-10-17T10:31:18.75463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4d4c1b1786e4e6dd switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T10:31:18.754657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4d4c1b1786e4e6dd became follower at term 0"} {"level":"info","ts":"2026-10-17T10:31:18.754696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4d4c1b1786e4e6dd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T10:31:18.754713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4d4c1b1786e4e6dd became follower at term 1"} {"level":"info","ts":"2026-10-17T10:31:18.754778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4d4c1b1786e4e6dd switched to configuration voters=(5569856627011806941)"} {"level":"warn","ts":"2026-10-17T10:31:18.767248Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T10:31:18.769368Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T10:31:18.770716Z","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-17T10:31:18.77308Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4d4c1b1786e4e6dd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T10:31:18.77318Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4d4c1b1786e4e6dd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T10:31:18.773329Z","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-17T10:31:18.773365Z","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-17T10:31:18.773374Z","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-17T10:31:18.776915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4d4c1b1786e4e6dd switched to configuration voters=(5569856627011806941)"} {"level":"info","ts":"2026-10-17T10:31:18.777094Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c387147481076682","local-member-id":"4d4c1b1786e4e6dd","added-peer-id":"4d4c1b1786e4e6dd","added-peer-peer-urls":["https://162.253.55.147:2380"]} {"level":"info","ts":"2026-10-17T10:31:18.779499Z","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-17T10:31:18.782215Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.147:2380"} {"level":"info","ts":"2026-10-17T10:31:18.782249Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.147:2380"} {"level":"info","ts":"2026-10-17T10:31:18.786648Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4d4c1b1786e4e6dd","initial-advertise-peer-urls":["https://162.253.55.147:2380"],"listen-peer-urls":["https://162.253.55.147:2380"],"advertise-client-urls":["https://162.253.55.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T10:31:18.786741Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T10:31:19.156829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4d4c1b1786e4e6dd is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T10:31:19.156899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4d4c1b1786e4e6dd became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T10:31:19.156934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4d4c1b1786e4e6dd received MsgPreVoteResp from 4d4c1b1786e4e6dd at term 1"} {"level":"info","ts":"2026-10-17T10:31:19.157125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4d4c1b1786e4e6dd became candidate at term 2"} {"level":"info","ts":"2026-10-17T10:31:19.157151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4d4c1b1786e4e6dd received MsgVoteResp from 4d4c1b1786e4e6dd at term 2"} {"level":"info","ts":"2026-10-17T10:31:19.157232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4d4c1b1786e4e6dd became leader at term 2"} {"level":"info","ts":"2026-10-17T10:31:19.157257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4d4c1b1786e4e6dd elected leader 4d4c1b1786e4e6dd at term 2"} {"level":"info","ts":"2026-10-17T10:31:19.169144Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:31:19.169492Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4d4c1b1786e4e6dd","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.147:2379]}","request-path":"/0/members/4d4c1b1786e4e6dd/attributes","cluster-id":"c387147481076682","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T10:31:19.169519Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:31:19.169774Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:31:19.16991Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T10:31:19.169947Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T10:31:19.170437Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c387147481076682","local-member-id":"4d4c1b1786e4e6dd","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:31:19.170531Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:31:19.170572Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:31:19.172667Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.147:2379"} {"level":"info","ts":"2026-10-17T10:31:19.173361Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-17T10:31:22.302581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.269849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-17T10:31:22.302779Z","caller":"traceutil/trace.go:171","msg":"trace[1552882416] linearizableReadLoop","detail":"{readStateIndex:84; appliedIndex:83; }","duration":"546.239242ms","start":"2026-10-17T10:31:21.75652Z","end":"2026-10-17T10:31:22.30276Z","steps":["trace[1552882416] 'read index received' (duration: 261.302922ms)","trace[1552882416] 'applied index is now lower than readState.Index' (duration: 284.93466ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:31:22.302922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.396677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-17T10:31:22.302865Z","caller":"traceutil/trace.go:171","msg":"trace[1844744492] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"578.751961ms","start":"2026-10-17T10:31:21.724039Z","end":"2026-10-17T10:31:22.302791Z","steps":["trace[1844744492] 'process raft request' (duration: 293.732028ms)","trace[1844744492] 'compare' (duration: 284.084944ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:31:22.303Z","caller":"traceutil/trace.go:171","msg":"trace[1560522356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:80; }","duration":"546.510551ms","start":"2026-10-17T10:31:21.756478Z","end":"2026-10-17T10:31:22.302989Z","steps":["trace[1560522356] 'agreement among raft nodes before linearized reading' (duration: 546.372857ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:31:22.30314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:31:21.756465Z","time spent":"546.662365ms","remote":"127.0.0.1:46176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-17T10:31:22.303207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:31:21.723999Z","time spent":"579.04516ms","remote":"127.0.0.1:46514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":621,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-17T10:31:22.482219Z","caller":"traceutil/trace.go:171","msg":"trace[442638074] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"172.882356ms","start":"2026-10-17T10:31:22.309319Z","end":"2026-10-17T10:31:22.482201Z","steps":["trace[442638074] 'process raft request' (duration: 171.565825ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:31:22.801972Z","caller":"traceutil/trace.go:171","msg":"trace[641175402] transaction","detail":"{read_only:false; response_revision:114; number_of_response:1; }","duration":"101.809919ms","start":"2026-10-17T10:31:22.700134Z","end":"2026-10-17T10:31:22.801944Z","steps":["trace[641175402] 'process raft request' (duration: 100.184778ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:32:05.260843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.795425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-10-17T10:32:05.261105Z","caller":"traceutil/trace.go:171","msg":"trace[2124378486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"224.124187ms","start":"2026-10-17T10:32:05.03694Z","end":"2026-10-17T10:32:05.261064Z","steps":["trace[2124378486] 'range keys from in-memory index tree' (duration: 223.531298ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:32:05.261361Z","caller":"traceutil/trace.go:171","msg":"trace[678934924] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"199.336484ms","start":"2026-10-17T10:32:05.06199Z","end":"2026-10-17T10:32:05.261326Z","steps":["trace[678934924] 'process raft request' (duration: 197.359981ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:32:05.261424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.852888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-17T10:32:05.261513Z","caller":"traceutil/trace.go:171","msg":"trace[1679574356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"223.997883ms","start":"2026-10-17T10:32:05.037494Z","end":"2026-10-17T10:32:05.261492Z","steps":["trace[1679574356] 'range keys from in-memory index tree' (duration: 223.662192ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:32:05.262746Z","caller":"traceutil/trace.go:171","msg":"trace[1341964747] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"110.671879ms","start":"2026-10-17T10:32:05.152042Z","end":"2026-10-17T10:32:05.262714Z","steps":["trace[1341964747] 'process raft request' (duration: 110.412011ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:32:11.363863Z","caller":"traceutil/trace.go:171","msg":"trace[2017344157] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:691; }","duration":"127.117879ms","start":"2026-10-17T10:32:11.236705Z","end":"2026-10-17T10:32:11.363823Z","steps":["trace[2017344157] 'read index received' (duration: 125.683105ms)","trace[2017344157] 'applied index is now lower than readState.Index' (duration: 1.433664ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:32:11.363959Z","caller":"traceutil/trace.go:171","msg":"trace[1676537399] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"237.50413ms","start":"2026-10-17T10:32:11.126382Z","end":"2026-10-17T10:32:11.363886Z","steps":["trace[1676537399] 'process raft request' (duration: 236.443137ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:32:11.364185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.449739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5llq4\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-17T10:32:11.36429Z","caller":"traceutil/trace.go:171","msg":"trace[691329406] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5llq4; range_end:; response_count:1; response_revision:665; }","duration":"127.579183ms","start":"2026-10-17T10:32:11.236688Z","end":"2026-10-17T10:32:11.364267Z","steps":["trace[691329406] 'agreement among raft nodes before linearized reading' (duration: 127.270094ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:32:11.643114Z","caller":"traceutil/trace.go:171","msg":"trace[2017182675] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"272.792556ms","start":"2026-10-17T10:32:11.370296Z","end":"2026-10-17T10:32:11.643088Z","steps":["trace[2017182675] 'process raft request' (duration: 272.548018ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:32:11.643268Z","caller":"traceutil/trace.go:171","msg":"trace[1238640289] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"263.017687ms","start":"2026-10-17T10:32:11.380223Z","end":"2026-10-17T10:32:11.643241Z","steps":["trace[1238640289] 'read index received' (duration: 20.307262ms)","trace[1238640289] 'applied index is now lower than readState.Index' (duration: 242.708625ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:32:11.643405Z","caller":"traceutil/trace.go:171","msg":"trace[882438223] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"257.176303ms","start":"2026-10-17T10:32:11.386189Z","end":"2026-10-17T10:32:11.643365Z","steps":["trace[882438223] 'process raft request' (duration: 256.803461ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:32:11.643463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.212113ms","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-10-17T10:32:11.643489Z","caller":"traceutil/trace.go:171","msg":"trace[495239240] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:668; }","duration":"263.281995ms","start":"2026-10-17T10:32:11.380198Z","end":"2026-10-17T10:32:11.64348Z","steps":["trace[495239240] 'agreement among raft nodes before linearized reading' (duration: 263.12062ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:32:11.647499Z","caller":"traceutil/trace.go:171","msg":"trace[639759971] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"206.792898ms","start":"2026-10-17T10:32:11.440691Z","end":"2026-10-17T10:32:11.647484Z","steps":["trace[639759971] 'process raft request' (duration: 206.734147ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:32:11.871265Z","caller":"traceutil/trace.go:171","msg":"trace[717068416] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"213.882893ms","start":"2026-10-17T10:32:11.657354Z","end":"2026-10-17T10:32:11.871237Z","steps":["trace[717068416] 'read index received' (duration: 114.78038ms)","trace[717068416] 'applied index is now lower than readState.Index' (duration: 99.101313ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:32:11.871308Z","caller":"traceutil/trace.go:171","msg":"trace[1035437593] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"221.779733ms","start":"2026-10-17T10:32:11.649487Z","end":"2026-10-17T10:32:11.871266Z","steps":["trace[1035437593] 'process raft request' (duration: 122.617658ms)","trace[1035437593] 'compare' (duration: 99.00113ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:32:11.871401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.024577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-10-17T10:32:11.871435Z","caller":"traceutil/trace.go:171","msg":"trace[1091452965] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:670; }","duration":"214.13781ms","start":"2026-10-17T10:32:11.657286Z","end":"2026-10-17T10:32:11.871424Z","steps":["trace[1091452965] 'agreement among raft nodes before linearized reading' (duration: 214.048928ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:32:12.311672Z","caller":"traceutil/trace.go:171","msg":"trace[302184331] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"376.642129ms","start":"2026-10-17T10:32:11.934996Z","end":"2026-10-17T10:32:12.311638Z","steps":["trace[302184331] 'process raft request' (duration: 376.484464ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:32:12.311849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:32:11.934976Z","time spent":"376.783224ms","remote":"127.0.0.1:46270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-17T10:32:12.48897Z","caller":"traceutil/trace.go:171","msg":"trace[926607539] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"551.553991ms","start":"2026-10-17T10:32:11.937398Z","end":"2026-10-17T10:32:12.488952Z","steps":["trace[926607539] 'process raft request' (duration: 551.422216ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:32:12.488958Z","caller":"traceutil/trace.go:171","msg":"trace[1449961985] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"553.188862ms","start":"2026-10-17T10:32:11.935726Z","end":"2026-10-17T10:32:12.488915Z","steps":["trace[1449961985] 'process raft request' (duration: 545.340344ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:32:12.489154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:32:11.935706Z","time spent":"553.362518ms","remote":"127.0.0.1:46270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-17T10:32:12.48948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:32:11.937362Z","time spent":"551.682044ms","remote":"127.0.0.1:46404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:32:12.489546Z","caller":"traceutil/trace.go:171","msg":"trace[1764583726] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"551.754346ms","start":"2026-10-17T10:32:11.937736Z","end":"2026-10-17T10:32:12.48949Z","steps":["trace[1764583726] 'process raft request' (duration: 551.150658ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:32:12.489837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:32:11.937722Z","time spent":"551.933723ms","remote":"127.0.0.1:46358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:32:12.490261Z","caller":"traceutil/trace.go:171","msg":"trace[2079747369] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:698; }","duration":"548.667969ms","start":"2026-10-17T10:32:11.941562Z","end":"2026-10-17T10:32:12.49023Z","steps":["trace[2079747369] 'read index received' (duration: 369.910687ms)","trace[2079747369] 'applied index is now lower than readState.Index' (duration: 178.755452ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:32:12.490511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.950468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:32:12.490616Z","caller":"traceutil/trace.go:171","msg":"trace[1889389778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:676; }","duration":"549.071371ms","start":"2026-10-17T10:32:11.941506Z","end":"2026-10-17T10:32:12.490577Z","steps":["trace[1889389778] 'agreement among raft nodes before linearized reading' (duration: 548.889306ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:32:12.490659Z","caller":"traceutil/trace.go:171","msg":"trace[2136003210] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"434.820049ms","start":"2026-10-17T10:32:12.055818Z","end":"2026-10-17T10:32:12.490638Z","steps":["trace[2136003210] 'process raft request' (duration: 433.302872ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:32:12.490679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:32:11.941492Z","time spent":"549.177505ms","remote":"127.0.0.1:46176","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-17T10:32:12.490783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:32:12.055779Z","time spent":"434.924622ms","remote":"127.0.0.1:46428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:32:28.474064Z","caller":"traceutil/trace.go:171","msg":"trace[372301392] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"117.11862ms","start":"2026-10-17T10:32:28.35692Z","end":"2026-10-17T10:32:28.474039Z","steps":["trace[372301392] 'process raft request' (duration: 116.927674ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:33:12.176075Z","caller":"traceutil/trace.go:171","msg":"trace[1471840065] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1126; }","duration":"172.274694ms","start":"2026-10-17T10:33:12.003779Z","end":"2026-10-17T10:33:12.176053Z","steps":["trace[1471840065] 'read index received' (duration: 172.118699ms)","trace[1471840065] 'applied index is now lower than readState.Index' (duration: 155.065µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:33:12.176189Z","caller":"traceutil/trace.go:171","msg":"trace[1983863816] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"229.253455ms","start":"2026-10-17T10:33:11.9469Z","end":"2026-10-17T10:33:12.176154Z","steps":["trace[1983863816] 'process raft request' (duration: 229.003238ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:33:12.176283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.469971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:33:12.176369Z","caller":"traceutil/trace.go:171","msg":"trace[289633915] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1084; }","duration":"172.598064ms","start":"2026-10-17T10:33:12.003749Z","end":"2026-10-17T10:33:12.176347Z","steps":["trace[289633915] 'agreement among raft nodes before linearized reading' (duration: 172.422659ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:33:12.430963Z","caller":"traceutil/trace.go:171","msg":"trace[1375896641] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"250.907252ms","start":"2026-10-17T10:33:12.180017Z","end":"2026-10-17T10:33:12.430924Z","steps":["trace[1375896641] 'process raft request' (duration: 249.90742ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:33:28.25646Z","caller":"traceutil/trace.go:171","msg":"trace[115574795] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"101.215908ms","start":"2026-10-17T10:33:28.155207Z","end":"2026-10-17T10:33:28.256423Z","steps":["trace[115574795] 'process raft request' (duration: 100.983581ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:33:33.158799Z","caller":"traceutil/trace.go:171","msg":"trace[1171732973] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"187.443849ms","start":"2026-10-17T10:33:32.971327Z","end":"2026-10-17T10:33:33.158771Z","steps":["trace[1171732973] 'process raft request' (duration: 187.286984ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:33:33.165439Z","caller":"traceutil/trace.go:171","msg":"trace[471794162] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"193.550983ms","start":"2026-10-17T10:33:32.971852Z","end":"2026-10-17T10:33:33.165403Z","steps":["trace[471794162] 'process raft request' (duration: 193.470511ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:33:43.378273Z","caller":"traceutil/trace.go:171","msg":"trace[1692693833] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"166.295653ms","start":"2026-10-17T10:33:43.211953Z","end":"2026-10-17T10:33:43.378248Z","steps":["trace[1692693833] 'process raft request' (duration: 166.115448ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:33:43.761779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.165638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.147\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-17T10:33:43.761858Z","caller":"traceutil/trace.go:171","msg":"trace[1016586599] range","detail":"{range_begin:/registry/masterleases/162.253.55.147; range_end:; response_count:1; response_revision:1256; }","duration":"297.298192ms","start":"2026-10-17T10:33:43.464543Z","end":"2026-10-17T10:33:43.761841Z","steps":["trace[1016586599] 'range keys from in-memory index tree' (duration: 296.604081ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:33:43.762011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.123353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-10-17T10:33:43.762092Z","caller":"traceutil/trace.go:171","msg":"trace[83195928] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1256; }","duration":"263.227396ms","start":"2026-10-17T10:33:43.498849Z","end":"2026-10-17T10:33:43.762077Z","steps":["trace[83195928] 'range keys from in-memory index tree' (duration: 262.71191ms)"],"step_count":1}