{"level":"warn","ts":"2026-02-08T16:27:22.837824Z","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-08T16:27:22.837932Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.74: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.74:2380","--initial-cluster=instance=https://162.253.55.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.74: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-08T16:27:22.838006Z","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-08T16:27:22.838017Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-02-08T16:27:22.838041Z","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-08T16:27:22.839056Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"]} {"level":"info","ts":"2026-02-08T16:27:22.839155Z","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.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.74: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-08T16:27:22.844904Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.499513ms"} {"level":"info","ts":"2026-02-08T16:27:22.855822Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"30aa8136fb61a722","cluster-id":"e7ea3889c4872560"} {"level":"info","ts":"2026-02-08T16:27:22.856023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=()"} {"level":"info","ts":"2026-02-08T16:27:22.856058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 0"} {"level":"info","ts":"2026-02-08T16:27:22.856071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 30aa8136fb61a722 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-08T16:27:22.856079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 1"} {"level":"info","ts":"2026-02-08T16:27:22.856137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"warn","ts":"2026-02-08T16:27:22.86511Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-08T16:27:22.872611Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-08T16:27:22.881689Z","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-08T16:27:22.885414Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"30aa8136fb61a722","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-08T16:27:22.888696Z","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-08T16:27:22.888799Z","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-08T16:27:22.88883Z","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-08T16:27:22.889307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"info","ts":"2026-02-08T16:27:22.889463Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","added-peer-id":"30aa8136fb61a722","added-peer-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-02-08T16:27:22.886511Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"30aa8136fb61a722","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-08T16:27:22.893465Z","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-08T16:27:22.893658Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-02-08T16:27:22.893691Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-02-08T16:27:22.895363Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"30aa8136fb61a722","initial-advertise-peer-urls":["https://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-08T16:27:22.895499Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-08T16:27:23.857331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 is starting a new election at term 1"} {"level":"info","ts":"2026-02-08T16:27:23.857393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-08T16:27:23.857422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgPreVoteResp from 30aa8136fb61a722 at term 1"} {"level":"info","ts":"2026-02-08T16:27:23.857439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became candidate at term 2"} {"level":"info","ts":"2026-02-08T16:27:23.857445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgVoteResp from 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-02-08T16:27:23.857456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became leader at term 2"} {"level":"info","ts":"2026-02-08T16:27:23.857477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 30aa8136fb61a722 elected leader 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-02-08T16:27:23.863283Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:27:23.866702Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"30aa8136fb61a722","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.74:2379]}","request-path":"/0/members/30aa8136fb61a722/attributes","cluster-id":"e7ea3889c4872560","publish-timeout":"7s"} {"level":"info","ts":"2026-02-08T16:27:23.866727Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-08T16:27:23.867174Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-08T16:27:23.86877Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:27:23.868905Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:27:23.868952Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:27:23.90681Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.74:2379"} {"level":"info","ts":"2026-02-08T16:27:23.910564Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-08T16:27:23.910584Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-08T16:27:23.911276Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-08T16:27:39.844554Z","caller":"traceutil/trace.go:171","msg":"trace[1751434672] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"318.135588ms","start":"2026-02-08T16:27:39.526395Z","end":"2026-02-08T16:27:39.84453Z","steps":["trace[1751434672] 'process raft request' (duration: 317.997377ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:39.844992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:39.526381Z","time spent":"318.24253ms","remote":"127.0.0.1:51684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5073,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T16:27:40.512589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.631893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4726"} {"level":"info","ts":"2026-02-08T16:27:40.516517Z","caller":"traceutil/trace.go:171","msg":"trace[1733593162] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:376; }","duration":"665.576344ms","start":"2026-02-08T16:27:39.850918Z","end":"2026-02-08T16:27:40.516494Z","steps":["trace[1733593162] 'range keys from in-memory index tree' (duration: 661.515852ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:40.516793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:39.850887Z","time spent":"665.886257ms","remote":"127.0.0.1:51684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":4749,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-02-08T16:27:40.513879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.711832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-08T16:27:40.517199Z","caller":"traceutil/trace.go:171","msg":"trace[1815801132] linearizableReadLoop","detail":"{readStateIndex:387; appliedIndex:386; }","duration":"607.208568ms","start":"2026-02-08T16:27:39.909946Z","end":"2026-02-08T16:27:40.517155Z","steps":["trace[1815801132] 'read index received' (duration: 340.943589ms)","trace[1815801132] 'applied index is now lower than readState.Index' (duration: 266.263079ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:27:40.517325Z","caller":"traceutil/trace.go:171","msg":"trace[2114962973] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"607.834585ms","start":"2026-02-08T16:27:39.909462Z","end":"2026-02-08T16:27:40.517296Z","steps":["trace[2114962973] 'process raft request' (duration: 341.492224ms)","trace[2114962973] 'compare' (duration: 261.892564ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:27:40.517411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:39.909437Z","time spent":"607.925025ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T16:27:40.517697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.746294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:27:40.517726Z","caller":"traceutil/trace.go:171","msg":"trace[1195742186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:377; }","duration":"607.810574ms","start":"2026-02-08T16:27:39.909908Z","end":"2026-02-08T16:27:40.517719Z","steps":["trace[1195742186] 'agreement among raft nodes before linearized reading' (duration: 607.757083ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:40.517749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:39.909891Z","time spent":"607.853334ms","remote":"127.0.0.1:51488","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-02-08T16:27:40.518252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.633651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-08T16:27:40.522292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.823192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4018"} {"level":"info","ts":"2026-02-08T16:27:40.522319Z","caller":"traceutil/trace.go:171","msg":"trace[1456677651] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:377; }","duration":"260.871213ms","start":"2026-02-08T16:27:40.26144Z","end":"2026-02-08T16:27:40.522311Z","steps":["trace[1456677651] 'agreement among raft nodes before linearized reading' (duration: 260.818232ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:40.522614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.249328ms","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-02-08T16:27:40.522635Z","caller":"traceutil/trace.go:171","msg":"trace[2054156145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:377; }","duration":"398.330899ms","start":"2026-02-08T16:27:40.124299Z","end":"2026-02-08T16:27:40.52263Z","steps":["trace[2054156145] 'agreement among raft nodes before linearized reading' (duration: 398.291538ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:40.52265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:40.124275Z","time spent":"398.370009ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-08T16:27:40.522796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.046848ms","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-08T16:27:40.52281Z","caller":"traceutil/trace.go:171","msg":"trace[1925482988] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:377; }","duration":"405.067899ms","start":"2026-02-08T16:27:40.117738Z","end":"2026-02-08T16:27:40.522806Z","steps":["trace[1925482988] 'agreement among raft nodes before linearized reading' (duration: 405.028878ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:40.522823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:40.117677Z","time spent":"405.14298ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-08T16:27:40.518439Z","caller":"traceutil/trace.go:171","msg":"trace[625696078] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:377; }","duration":"496.866553ms","start":"2026-02-08T16:27:40.021558Z","end":"2026-02-08T16:27:40.518424Z","steps":["trace[625696078] 'agreement among raft nodes before linearized reading' (duration: 496.642671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:40.528045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:40.021532Z","time spent":"506.501805ms","remote":"127.0.0.1:51750","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":"warn","ts":"2026-02-08T16:27:44.740714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.379958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-08T16:27:44.74117Z","caller":"traceutil/trace.go:171","msg":"trace[1455848146] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"179.844878ms","start":"2026-02-08T16:27:44.561304Z","end":"2026-02-08T16:27:44.741149Z","steps":["trace[1455848146] 'process raft request' (duration: 179.528818ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:27:44.741493Z","caller":"traceutil/trace.go:171","msg":"trace[1557675602] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"181.159795ms","start":"2026-02-08T16:27:44.560318Z","end":"2026-02-08T16:27:44.741478Z","steps":["trace[1557675602] 'process raft request' (duration: 24.910706ms)","trace[1557675602] 'compare' (duration: 155.209262ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:27:57.188665Z","caller":"traceutil/trace.go:171","msg":"trace[1240356487] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"498.168748ms","start":"2026-02-08T16:27:56.690478Z","end":"2026-02-08T16:27:57.188647Z","steps":["trace[1240356487] 'process raft request' (duration: 498.059095ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:57.189108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:56.690465Z","time spent":"498.505498ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T16:27:57.224003Z","caller":"traceutil/trace.go:171","msg":"trace[450277313] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:494; }","duration":"408.065579ms","start":"2026-02-08T16:27:56.815917Z","end":"2026-02-08T16:27:57.223982Z","steps":["trace[450277313] 'read index received' (duration: 374.882026ms)","trace[450277313] 'applied index is now lower than readState.Index' (duration: 33.182673ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:27:57.224227Z","caller":"traceutil/trace.go:171","msg":"trace[885089831] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"533.039214ms","start":"2026-02-08T16:27:56.691181Z","end":"2026-02-08T16:27:57.224221Z","steps":["trace[885089831] 'process raft request' (duration: 532.673942ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:57.224313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:56.691162Z","time spent":"533.080735ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T16:27:57.224413Z","caller":"traceutil/trace.go:171","msg":"trace[628140658] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"437.118175ms","start":"2026-02-08T16:27:56.787289Z","end":"2026-02-08T16:27:57.224407Z","steps":["trace[628140658] 'process raft request' (duration: 436.6631ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:57.224441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:56.787269Z","time spent":"437.154916ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T16:27:57.224517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.598516ms","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-08T16:27:57.224533Z","caller":"traceutil/trace.go:171","msg":"trace[971927292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:482; }","duration":"408.634997ms","start":"2026-02-08T16:27:56.815893Z","end":"2026-02-08T16:27:57.224528Z","steps":["trace[971927292] 'agreement among raft nodes before linearized reading' (duration: 408.598946ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:57.224546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:56.815883Z","time spent":"408.660928ms","remote":"127.0.0.1:51750","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-08T16:27:57.224618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.476717ms","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-08T16:27:57.224658Z","caller":"traceutil/trace.go:171","msg":"trace[1990805637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:482; }","duration":"402.528839ms","start":"2026-02-08T16:27:56.822117Z","end":"2026-02-08T16:27:57.224646Z","steps":["trace[1990805637] 'agreement among raft nodes before linearized reading' (duration: 402.452557ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:27:57.224694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:27:56.822111Z","time spent":"402.57637ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-08T16:28:04.910226Z","caller":"traceutil/trace.go:171","msg":"trace[1115859198] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"188.658078ms","start":"2026-02-08T16:28:04.72154Z","end":"2026-02-08T16:28:04.910198Z","steps":["trace[1115859198] 'process raft request' (duration: 188.513614ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:28:05.493094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.777642ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:28:05.493171Z","caller":"traceutil/trace.go:171","msg":"trace[109507808] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:524; }","duration":"444.863515ms","start":"2026-02-08T16:28:05.048294Z","end":"2026-02-08T16:28:05.493157Z","steps":["trace[109507808] 'range keys from in-memory index tree' (duration: 444.763751ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:28:05.493402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.903448ms","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-02-08T16:28:05.493416Z","caller":"traceutil/trace.go:171","msg":"trace[618099295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:524; }","duration":"260.96099ms","start":"2026-02-08T16:28:05.232451Z","end":"2026-02-08T16:28:05.493412Z","steps":["trace[618099295] 'range keys from in-memory index tree' (duration: 260.772484ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:28:05.493524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.212643ms","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-08T16:28:05.493537Z","caller":"traceutil/trace.go:171","msg":"trace[526523834] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:524; }","duration":"239.251264ms","start":"2026-02-08T16:28:05.254281Z","end":"2026-02-08T16:28:05.493532Z","steps":["trace[526523834] 'range keys from in-memory index tree' (duration: 239.14009ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:28:05.49361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.306584ms","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-08T16:28:05.493622Z","caller":"traceutil/trace.go:171","msg":"trace[342601903] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:524; }","duration":"179.333465ms","start":"2026-02-08T16:28:05.314284Z","end":"2026-02-08T16:28:05.493618Z","steps":["trace[342601903] 'range keys from in-memory index tree' (duration: 179.240273ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:28:05.493687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.293856ms","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-08T16:28:05.493699Z","caller":"traceutil/trace.go:171","msg":"trace[1742800022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:524; }","duration":"172.316466ms","start":"2026-02-08T16:28:05.321378Z","end":"2026-02-08T16:28:05.493695Z","steps":["trace[1742800022] 'range keys from in-memory index tree' (duration: 172.243284ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:28:06.209233Z","caller":"traceutil/trace.go:171","msg":"trace[234872055] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"711.700878ms","start":"2026-02-08T16:28:05.497513Z","end":"2026-02-08T16:28:06.209214Z","steps":["trace[234872055] 'process raft request' (duration: 711.608076ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:28:06.20935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:28:05.497483Z","time spent":"711.808841ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T16:28:06.215666Z","caller":"traceutil/trace.go:171","msg":"trace[2009325343] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:541; }","duration":"482.074956ms","start":"2026-02-08T16:28:05.733579Z","end":"2026-02-08T16:28:06.215654Z","steps":["trace[2009325343] 'read index received' (duration: 475.620355ms)","trace[2009325343] 'applied index is now lower than readState.Index' (duration: 6.453621ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T16:28:06.215857Z","caller":"traceutil/trace.go:171","msg":"trace[1020761246] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"716.527634ms","start":"2026-02-08T16:28:05.499324Z","end":"2026-02-08T16:28:06.215851Z","steps":["trace[1020761246] 'process raft request' (duration: 716.219936ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:28:06.215911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:28:05.499318Z","time spent":"716.560865ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T16:28:06.215985Z","caller":"traceutil/trace.go:171","msg":"trace[998575239] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"715.136524ms","start":"2026-02-08T16:28:05.500844Z","end":"2026-02-08T16:28:06.215981Z","steps":["trace[998575239] 'process raft request' (duration: 714.759844ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:28:06.216008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:28:05.500806Z","time spent":"715.188715ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T16:28:06.216063Z","caller":"traceutil/trace.go:171","msg":"trace[2124225957] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"714.531797ms","start":"2026-02-08T16:28:05.501527Z","end":"2026-02-08T16:28:06.216059Z","steps":["trace[2124225957] 'process raft request' (duration: 714.099545ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:28:06.216096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:28:05.50152Z","time spent":"714.562208ms","remote":"127.0.0.1:51750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T16:28:06.216188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.607201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:28:06.216206Z","caller":"traceutil/trace.go:171","msg":"trace[131346390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:528; }","duration":"482.653502ms","start":"2026-02-08T16:28:05.733546Z","end":"2026-02-08T16:28:06.2162Z","steps":["trace[131346390] 'agreement among raft nodes before linearized reading' (duration: 482.624581ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:28:06.216223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:28:05.73353Z","time spent":"482.689593ms","remote":"127.0.0.1:51488","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-02-08T16:28:06.21632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.220541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:28:06.216346Z","caller":"traceutil/trace.go:171","msg":"trace[1031570797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:528; }","duration":"311.275563ms","start":"2026-02-08T16:28:05.905065Z","end":"2026-02-08T16:28:06.216341Z","steps":["trace[1031570797] 'agreement among raft nodes before linearized reading' (duration: 311.241162ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T16:28:06.216358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:28:05.905047Z","time spent":"311.307543ms","remote":"127.0.0.1:51496","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-02-08T16:28:11.077318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.486912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T16:28:11.077364Z","caller":"traceutil/trace.go:171","msg":"trace[1740844190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"158.562213ms","start":"2026-02-08T16:28:10.918792Z","end":"2026-02-08T16:28:11.077354Z","steps":["trace[1740844190] 'range keys from in-memory index tree' (duration: 158.43859ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T16:29:37.796575Z","caller":"traceutil/trace.go:171","msg":"trace[539402978] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1009; }","duration":"290.269011ms","start":"2026-02-08T16:29:37.506283Z","end":"2026-02-08T16:29:37.796553Z","steps":["trace[539402978] 'read index received' (duration: 290.087848ms)","trace[539402978] 'applied index is now lower than readState.Index' (duration: 180.163µs)"],"step_count":2} {"level":"warn","ts":"2026-02-08T16:29:37.796585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T16:29:37.448983Z","time spent":"347.597601ms","remote":"127.0.0.1:51512","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-08T16:29:37.796698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.404204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-08T16:29:37.796714Z","caller":"traceutil/trace.go:171","msg":"trace[258832934] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:971; }","duration":"290.433514ms","start":"2026-02-08T16:29:37.506276Z","end":"2026-02-08T16:29:37.796709Z","steps":["trace[258832934] 'agreement among raft nodes before linearized reading' (duration: 290.342923ms)"],"step_count":1}