{"level":"warn","ts":"2026-02-14T01:49:44.563222Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-14T01:49:44.5634Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.52: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.52:2380","--initial-cluster=instance=https://162.253.55.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.52: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-02-14T01:49:44.563505Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-14T01:49:44.563553Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]} {"level":"info","ts":"2026-02-14T01:49:44.563598Z","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-02-14T01:49:44.564545Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"]} {"level":"info","ts":"2026-02-14T01:49:44.564666Z","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":2,"max-cpu-available":2,"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.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.52: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-02-14T01:49:44.589203Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"24.240556ms"} {"level":"info","ts":"2026-02-14T01:49:44.645991Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"} {"level":"info","ts":"2026-02-14T01:49:44.646156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"} {"level":"info","ts":"2026-02-14T01:49:44.646235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"} {"level":"info","ts":"2026-02-14T01:49:44.64625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b11e7fc5714be64b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-14T01:49:44.646329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"} {"level":"info","ts":"2026-02-14T01:49:44.646494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"warn","ts":"2026-02-14T01:49:44.788163Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-14T01:49:44.804785Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-14T01:49:44.809758Z","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-02-14T01:49:44.8141Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b11e7fc5714be64b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-14T01:49:44.819448Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b11e7fc5714be64b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-14T01:49:44.819696Z","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-02-14T01:49:44.819728Z","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-02-14T01:49:44.820033Z","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-02-14T01:49:44.821171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"info","ts":"2026-02-14T01:49:44.821628Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","added-peer-id":"b11e7fc5714be64b","added-peer-peer-urls":["https://162.253.55.52:2380"]} {"level":"info","ts":"2026-02-14T01:49:44.828755Z","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-02-14T01:49:44.830978Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-02-14T01:49:44.832142Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-02-14T01:49:44.833953Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b11e7fc5714be64b","initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-14T01:49:44.83398Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-14T01:49:44.946987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"} {"level":"info","ts":"2026-02-14T01:49:44.947018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"} {"level":"info","ts":"2026-02-14T01:49:44.947099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"} {"level":"info","ts":"2026-02-14T01:49:44.947117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"} {"level":"info","ts":"2026-02-14T01:49:44.94716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-02-14T01:49:44.947177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"} {"level":"info","ts":"2026-02-14T01:49:44.947221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-02-14T01:49:44.952397Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b11e7fc5714be64b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.52:2379]}","request-path":"/0/members/b11e7fc5714be64b/attributes","cluster-id":"9349e4f32a52a90a","publish-timeout":"7s"} {"level":"info","ts":"2026-02-14T01:49:44.95242Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-14T01:49:44.952704Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-14T01:49:44.952874Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-14T01:49:44.954995Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-14T01:49:44.955056Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-14T01:49:44.956179Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","cluster-version":"3.5"} {"level":"info","ts":"2026-02-14T01:49:44.956326Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-14T01:49:44.95638Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-14T01:49:44.957911Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-14T01:49:44.987862Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"} {"level":"info","ts":"2026-02-14T01:49:48.479693Z","caller":"traceutil/trace.go:171","msg":"trace[1998827227] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"163.258972ms","start":"2026-02-14T01:49:48.316392Z","end":"2026-02-14T01:49:48.479651Z","steps":["trace[1998827227] 'process raft request' (duration: 127.108465ms)","trace[1998827227] 'compare' (duration: 36.022166ms)"],"step_count":2} {"level":"warn","ts":"2026-02-14T01:50:01.910634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.241167ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-14T01:50:01.910853Z","caller":"traceutil/trace.go:171","msg":"trace[1836878888] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:414; }","duration":"534.787149ms","start":"2026-02-14T01:50:01.376054Z","end":"2026-02-14T01:50:01.910841Z","steps":["trace[1836878888] 'read index received' (duration: 114.974036ms)","trace[1836878888] 'applied index is now lower than readState.Index' (duration: 419.810973ms)"],"step_count":2} {"level":"info","ts":"2026-02-14T01:50:01.911211Z","caller":"traceutil/trace.go:171","msg":"trace[751757809] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"535.475526ms","start":"2026-02-14T01:50:01.375726Z","end":"2026-02-14T01:50:01.911202Z","steps":["trace[751757809] 'process raft request' (duration: 115.294719ms)","trace[751757809] 'compare' (duration: 418.229046ms)"],"step_count":2} {"level":"warn","ts":"2026-02-14T01:50:01.911402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:01.375709Z","time spent":"535.627167ms","remote":"127.0.0.1:52918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-14T01:50:01.911656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.596488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-5dd5756b68\" ","response":"range_response_count:1 size:3797"} {"level":"info","ts":"2026-02-14T01:50:01.911733Z","caller":"traceutil/trace.go:171","msg":"trace[975467913] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-5dd5756b68; range_end:; response_count:1; response_revision:402; }","duration":"535.688508ms","start":"2026-02-14T01:50:01.376036Z","end":"2026-02-14T01:50:01.911725Z","steps":["trace[975467913] 'agreement among raft nodes before linearized reading' (duration: 535.576237ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:01.911804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:01.376031Z","time spent":"535.764939ms","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3821,"request content":"key:\"/registry/replicasets/kube-system/coredns-5dd5756b68\" "} {"level":"warn","ts":"2026-02-14T01:50:01.912458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.733853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-14T01:50:01.912525Z","caller":"traceutil/trace.go:171","msg":"trace[2059491495] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:406; }","duration":"205.825104ms","start":"2026-02-14T01:50:01.706693Z","end":"2026-02-14T01:50:01.912518Z","steps":["trace[2059491495] 'agreement among raft nodes before linearized reading' (duration: 205.710723ms)"],"step_count":1} {"level":"info","ts":"2026-02-14T01:50:01.912918Z","caller":"traceutil/trace.go:171","msg":"trace[2133321514] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"533.580476ms","start":"2026-02-14T01:50:01.379328Z","end":"2026-02-14T01:50:01.912909Z","steps":["trace[2133321514] 'process raft request' (duration: 532.947969ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:01.913003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:01.379297Z","time spent":"533.684807ms","remote":"127.0.0.1:52552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-14T01:50:01.913237Z","caller":"traceutil/trace.go:171","msg":"trace[455919565] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"533.769907ms","start":"2026-02-14T01:50:01.379459Z","end":"2026-02-14T01:50:01.913229Z","steps":["trace[455919565] 'process raft request' (duration: 532.858658ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:01.913328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:01.379451Z","time spent":"533.827588ms","remote":"127.0.0.1:52636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4015,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-14T01:50:01.919222Z","caller":"traceutil/trace.go:171","msg":"trace[2005679785] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"539.695971ms","start":"2026-02-14T01:50:01.379516Z","end":"2026-02-14T01:50:01.919212Z","steps":["trace[2005679785] 'process raft request' (duration: 532.829798ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:01.919667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:01.379509Z","time spent":"540.129415ms","remote":"127.0.0.1:52552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-14T01:50:01.919329Z","caller":"traceutil/trace.go:171","msg":"trace[1645740142] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"536.717449ms","start":"2026-02-14T01:50:01.382606Z","end":"2026-02-14T01:50:01.919324Z","steps":["trace[1645740142] 'process raft request' (duration: 529.771075ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:01.920126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:01.3826Z","time spent":"537.455867ms","remote":"127.0.0.1:52958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3818,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-14T01:50:07.541629Z","caller":"traceutil/trace.go:171","msg":"trace[1269935686] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"460.879698ms","start":"2026-02-14T01:50:07.080727Z","end":"2026-02-14T01:50:07.541606Z","steps":["trace[1269935686] 'process raft request' (duration: 460.738047ms)"],"step_count":1} {"level":"info","ts":"2026-02-14T01:50:07.541635Z","caller":"traceutil/trace.go:171","msg":"trace[832200104] linearizableReadLoop","detail":"{readStateIndex:436; appliedIndex:436; }","duration":"424.945313ms","start":"2026-02-14T01:50:07.116668Z","end":"2026-02-14T01:50:07.541613Z","steps":["trace[832200104] 'read index received' (duration: 424.937543ms)","trace[832200104] 'applied index is now lower than readState.Index' (duration: 6.45µs)"],"step_count":2} {"level":"warn","ts":"2026-02-14T01:50:07.541764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:07.080716Z","time spent":"460.97953ms","remote":"127.0.0.1:52734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-14T01:50:07.541832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.145586ms","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-02-14T01:50:07.541858Z","caller":"traceutil/trace.go:171","msg":"trace[1105386429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:422; }","duration":"425.213846ms","start":"2026-02-14T01:50:07.116636Z","end":"2026-02-14T01:50:07.54185Z","steps":["trace[1105386429] 'agreement among raft nodes before linearized reading' (duration: 425.092325ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:07.541886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:07.116619Z","time spent":"425.257356ms","remote":"127.0.0.1:52734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-14T01:50:07.542766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.509118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-14T01:50:07.5428Z","caller":"traceutil/trace.go:171","msg":"trace[1426055362] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:423; }","duration":"303.569169ms","start":"2026-02-14T01:50:07.239223Z","end":"2026-02-14T01:50:07.542792Z","steps":["trace[1426055362] 'agreement among raft nodes before linearized reading' (duration: 303.505328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:07.542819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:07.239209Z","time spent":"303.605189ms","remote":"127.0.0.1:52734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-14T01:50:07.542921Z","caller":"traceutil/trace.go:171","msg":"trace[468433241] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"200.265808ms","start":"2026-02-14T01:50:07.342649Z","end":"2026-02-14T01:50:07.542915Z","steps":["trace[468433241] 'process raft request' (duration: 200.005495ms)"],"step_count":1} {"level":"info","ts":"2026-02-14T01:50:10.767483Z","caller":"traceutil/trace.go:171","msg":"trace[888245421] linearizableReadLoop","detail":"{readStateIndex:446; appliedIndex:445; }","duration":"230.265164ms","start":"2026-02-14T01:50:10.537197Z","end":"2026-02-14T01:50:10.767462Z","steps":["trace[888245421] 'read index received' (duration: 230.098263ms)","trace[888245421] 'applied index is now lower than readState.Index' (duration: 166.061µs)"],"step_count":2} {"level":"info","ts":"2026-02-14T01:50:10.767735Z","caller":"traceutil/trace.go:171","msg":"trace[1755189384] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"266.858189ms","start":"2026-02-14T01:50:10.500867Z","end":"2026-02-14T01:50:10.767725Z","steps":["trace[1755189384] 'process raft request' (duration: 266.485545ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:10.767925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.717699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-14T01:50:10.767956Z","caller":"traceutil/trace.go:171","msg":"trace[145429187] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:431; }","duration":"230.781779ms","start":"2026-02-14T01:50:10.537165Z","end":"2026-02-14T01:50:10.767947Z","steps":["trace[145429187] 'agreement among raft nodes before linearized reading' (duration: 230.713879ms)"],"step_count":1} {"level":"info","ts":"2026-02-14T01:50:14.740731Z","caller":"traceutil/trace.go:171","msg":"trace[1485469209] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:490; }","duration":"484.045513ms","start":"2026-02-14T01:50:14.256647Z","end":"2026-02-14T01:50:14.740692Z","steps":["trace[1485469209] 'read index received' (duration: 483.898031ms)","trace[1485469209] 'applied index is now lower than readState.Index' (duration: 146.842µs)"],"step_count":2} {"level":"info","ts":"2026-02-14T01:50:14.740964Z","caller":"traceutil/trace.go:171","msg":"trace[1932480081] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"610.479551ms","start":"2026-02-14T01:50:14.130477Z","end":"2026-02-14T01:50:14.740957Z","steps":["trace[1932480081] 'process raft request' (duration: 610.116838ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:14.741043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:14.130462Z","time spent":"610.526922ms","remote":"127.0.0.1:52634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4210,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-14T01:50:14.741174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.534047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-14T01:50:14.741196Z","caller":"traceutil/trace.go:171","msg":"trace[595277434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:475; }","duration":"484.590309ms","start":"2026-02-14T01:50:14.256598Z","end":"2026-02-14T01:50:14.741188Z","steps":["trace[595277434] 'agreement among raft nodes before linearized reading' (duration: 484.558518ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:14.741214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:14.256574Z","time spent":"484.635369ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-14T01:50:21.222714Z","caller":"traceutil/trace.go:171","msg":"trace[1701383378] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"390.973033ms","start":"2026-02-14T01:50:20.831705Z","end":"2026-02-14T01:50:21.222678Z","steps":["trace[1701383378] 'process raft request' (duration: 390.705131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:21.223048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:20.831664Z","time spent":"391.199386ms","remote":"127.0.0.1:52734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-14T01:50:21.394548Z","caller":"traceutil/trace.go:171","msg":"trace[2093362394] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"291.176011ms","start":"2026-02-14T01:50:21.103345Z","end":"2026-02-14T01:50:21.394521Z","steps":["trace[2093362394] 'process raft request' (duration: 291.05363ms)"],"step_count":1} {"level":"info","ts":"2026-02-14T01:50:22.085425Z","caller":"traceutil/trace.go:171","msg":"trace[61127648] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:533; }","duration":"486.549586ms","start":"2026-02-14T01:50:21.59886Z","end":"2026-02-14T01:50:22.08541Z","steps":["trace[61127648] 'read index received' (duration: 486.410714ms)","trace[61127648] 'applied index is now lower than readState.Index' (duration: 138.372µs)"],"step_count":2} {"level":"info","ts":"2026-02-14T01:50:22.08579Z","caller":"traceutil/trace.go:171","msg":"trace[261277525] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"654.694107ms","start":"2026-02-14T01:50:21.431089Z","end":"2026-02-14T01:50:22.085783Z","steps":["trace[261277525] 'process raft request' (duration: 654.239553ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:22.085862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:21.43108Z","time spent":"654.734487ms","remote":"127.0.0.1:52636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-14T01:50:22.086065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.209182ms","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-02-14T01:50:22.086091Z","caller":"traceutil/trace.go:171","msg":"trace[1196134315] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:517; }","duration":"487.287982ms","start":"2026-02-14T01:50:21.598793Z","end":"2026-02-14T01:50:22.086081Z","steps":["trace[1196134315] 'agreement among raft nodes before linearized reading' (duration: 487.241311ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:22.08611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:21.598771Z","time spent":"487.334292ms","remote":"127.0.0.1:52734","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":"warn","ts":"2026-02-14T01:50:22.086273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.294592ms","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-02-14T01:50:22.086293Z","caller":"traceutil/trace.go:171","msg":"trace[93237823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:517; }","duration":"457.350162ms","start":"2026-02-14T01:50:21.628937Z","end":"2026-02-14T01:50:22.086287Z","steps":["trace[93237823] 'agreement among raft nodes before linearized reading' (duration: 457.313181ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:22.08631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:21.628921Z","time spent":"457.385902ms","remote":"127.0.0.1:52734","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-02-14T01:50:22.086899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.150681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-14T01:50:22.086976Z","caller":"traceutil/trace.go:171","msg":"trace[442826348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:517; }","duration":"440.250862ms","start":"2026-02-14T01:50:21.646689Z","end":"2026-02-14T01:50:22.086939Z","steps":["trace[442826348] 'agreement among raft nodes before linearized reading' (duration: 440.133141ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:22.087009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:21.646658Z","time spent":"440.344633ms","remote":"127.0.0.1:52734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-14T01:50:23.803434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096874446s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-14T01:50:23.803484Z","caller":"traceutil/trace.go:171","msg":"trace[96061043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"1.096970846s","start":"2026-02-14T01:50:22.706503Z","end":"2026-02-14T01:50:23.803473Z","steps":["trace[96061043] 'range keys from in-memory index tree' (duration: 1.096802036s)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:23.803504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:22.706486Z","time spent":"1.097013568s","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-14T01:50:23.803834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.192573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-14T01:50:23.803849Z","caller":"traceutil/trace.go:171","msg":"trace[1352117497] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"578.237193ms","start":"2026-02-14T01:50:23.225608Z","end":"2026-02-14T01:50:23.803845Z","steps":["trace[1352117497] 'range keys from in-memory index tree' (duration: 578.114222ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:23.803862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:50:23.225588Z","time spent":"578.269923ms","remote":"127.0.0.1:52734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-14T01:50:23.939597Z","caller":"traceutil/trace.go:171","msg":"trace[1911422118] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"132.552747ms","start":"2026-02-14T01:50:23.807022Z","end":"2026-02-14T01:50:23.939575Z","steps":["trace[1911422118] 'process raft request' (duration: 132.401706ms)"],"step_count":1} {"level":"info","ts":"2026-02-14T01:50:23.942042Z","caller":"traceutil/trace.go:171","msg":"trace[588129753] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:538; }","duration":"132.424446ms","start":"2026-02-14T01:50:23.809603Z","end":"2026-02-14T01:50:23.942027Z","steps":["trace[588129753] 'read index received' (duration: 132.419366ms)","trace[588129753] 'applied index is now lower than readState.Index' (duration: 4.11µs)"],"step_count":2} {"level":"warn","ts":"2026-02-14T01:50:23.942124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.502896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-14T01:50:23.942153Z","caller":"traceutil/trace.go:171","msg":"trace[1538625671] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"132.555197ms","start":"2026-02-14T01:50:23.809589Z","end":"2026-02-14T01:50:23.942145Z","steps":["trace[1538625671] 'agreement among raft nodes before linearized reading' (duration: 132.489996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:50:25.891045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.389191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-14T01:50:25.891113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.583402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-14T01:50:25.891133Z","caller":"traceutil/trace.go:171","msg":"trace[1705982622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:535; }","duration":"185.489082ms","start":"2026-02-14T01:50:25.705621Z","end":"2026-02-14T01:50:25.89111Z","steps":["trace[1705982622] 'range keys from in-memory index tree' (duration: 185.33834ms)"],"step_count":1} {"level":"info","ts":"2026-02-14T01:50:25.891183Z","caller":"traceutil/trace.go:171","msg":"trace[875835389] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:535; }","duration":"245.705254ms","start":"2026-02-14T01:50:25.645461Z","end":"2026-02-14T01:50:25.891167Z","steps":["trace[875835389] 'range keys from in-memory index tree' (duration: 245.540262ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:51:43.097356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.373244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-14T01:51:43.09744Z","caller":"traceutil/trace.go:171","msg":"trace[924979867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:933; }","duration":"389.503637ms","start":"2026-02-14T01:51:42.70792Z","end":"2026-02-14T01:51:43.097424Z","steps":["trace[924979867] 'range keys from in-memory index tree' (duration: 389.300801ms)"],"step_count":1} {"level":"warn","ts":"2026-02-14T01:51:43.097483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-14T01:51:42.707901Z","time spent":"389.573418ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-14T01:51:43.098103Z","caller":"traceutil/trace.go:171","msg":"trace[562728486] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"119.885868ms","start":"2026-02-14T01:51:42.978205Z","end":"2026-02-14T01:51:43.09809Z","steps":["trace[562728486] 'process raft request' (duration: 113.802709ms)"],"step_count":1}