{"level":"warn","ts":"2026-09-18T15:15:00.935404Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T15:15:00.935508Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.226: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.226:2380","--initial-cluster=instance=https://162.253.55.226:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.226:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.226:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-18T15:15:00.935581Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T15:15:00.935593Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.226:2380"]} {"level":"info","ts":"2026-09-18T15:15:00.935616Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-18T15:15:00.936321Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.226:2379"]} {"level":"info","ts":"2026-09-18T15:15:00.936406Z","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.226:2380"],"listen-peer-urls":["https://162.253.55.226:2380"],"advertise-client-urls":["https://162.253.55.226:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.226:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.226:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-18T15:15:00.953591Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"16.894369ms"} {"level":"info","ts":"2026-09-18T15:15:00.987252Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"44dd5fde65d22f67","cluster-id":"a84a11fd322465c5"} {"level":"info","ts":"2026-09-18T15:15:00.987326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"44dd5fde65d22f67 switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T15:15:00.987345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"44dd5fde65d22f67 became follower at term 0"} {"level":"info","ts":"2026-09-18T15:15:00.987353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 44dd5fde65d22f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T15:15:00.987361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"44dd5fde65d22f67 became follower at term 1"} {"level":"info","ts":"2026-09-18T15:15:00.987397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"44dd5fde65d22f67 switched to configuration voters=(4962227773227806567)"} {"level":"warn","ts":"2026-09-18T15:15:01.013648Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T15:15:01.018753Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T15:15:01.025842Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-18T15:15:01.028722Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"44dd5fde65d22f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T15:15:01.028914Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"44dd5fde65d22f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T15:15:01.029219Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-18T15:15:01.029271Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-18T15:15:01.029341Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-18T15:15:01.032605Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-18T15:15:01.032809Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.226:2380"} {"level":"info","ts":"2026-09-18T15:15:01.032847Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.226:2380"} {"level":"info","ts":"2026-09-18T15:15:01.033658Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"44dd5fde65d22f67","initial-advertise-peer-urls":["https://162.253.55.226:2380"],"listen-peer-urls":["https://162.253.55.226:2380"],"advertise-client-urls":["https://162.253.55.226:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.226:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T15:15:01.033691Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T15:15:01.03833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"44dd5fde65d22f67 switched to configuration voters=(4962227773227806567)"} {"level":"info","ts":"2026-09-18T15:15:01.038523Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a84a11fd322465c5","local-member-id":"44dd5fde65d22f67","added-peer-id":"44dd5fde65d22f67","added-peer-peer-urls":["https://162.253.55.226:2380"]} {"level":"info","ts":"2026-09-18T15:15:01.988242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"44dd5fde65d22f67 is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T15:15:01.988299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"44dd5fde65d22f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T15:15:01.98834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"44dd5fde65d22f67 received MsgPreVoteResp from 44dd5fde65d22f67 at term 1"} {"level":"info","ts":"2026-09-18T15:15:01.988361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"44dd5fde65d22f67 became candidate at term 2"} {"level":"info","ts":"2026-09-18T15:15:01.988372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"44dd5fde65d22f67 received MsgVoteResp from 44dd5fde65d22f67 at term 2"} {"level":"info","ts":"2026-09-18T15:15:01.988398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"44dd5fde65d22f67 became leader at term 2"} {"level":"info","ts":"2026-09-18T15:15:01.988412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 44dd5fde65d22f67 elected leader 44dd5fde65d22f67 at term 2"} {"level":"info","ts":"2026-09-18T15:15:01.989788Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:15:01.990861Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"44dd5fde65d22f67","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.226:2379]}","request-path":"/0/members/44dd5fde65d22f67/attributes","cluster-id":"a84a11fd322465c5","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T15:15:01.990922Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:15:01.991022Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:15:01.991259Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a84a11fd322465c5","local-member-id":"44dd5fde65d22f67","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:15:01.991367Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:15:01.991342Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T15:15:01.991391Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T15:15:01.991396Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:15:01.994718Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.226:2379"} {"level":"info","ts":"2026-09-18T15:15:01.994748Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T15:15:17.025026Z","caller":"traceutil/trace.go:171","msg":"trace[1746652942] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:376; }","duration":"110.515766ms","start":"2026-09-18T15:15:16.914481Z","end":"2026-09-18T15:15:17.024997Z","steps":["trace[1746652942] 'read index received' (duration: 110.26591ms)","trace[1746652942] 'applied index is now lower than readState.Index' (duration: 248.766µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:15:17.025129Z","caller":"traceutil/trace.go:171","msg":"trace[940140888] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"153.17ms","start":"2026-09-18T15:15:16.871904Z","end":"2026-09-18T15:15:17.025074Z","steps":["trace[940140888] 'process raft request' (duration: 152.890793ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:15:17.025241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.736233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-09-18T15:15:17.025354Z","caller":"traceutil/trace.go:171","msg":"trace[1015892505] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:366; }","duration":"110.916268ms","start":"2026-09-18T15:15:16.914418Z","end":"2026-09-18T15:15:17.025334Z","steps":["trace[1015892505] 'agreement among raft nodes before linearized reading' (duration: 110.696851ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:15:17.422791Z","caller":"traceutil/trace.go:171","msg":"trace[1831486359] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"389.267296ms","start":"2026-09-18T15:15:17.033491Z","end":"2026-09-18T15:15:17.422759Z","steps":["trace[1831486359] 'process raft request' (duration: 389.01576ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:15:17.424778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:15:17.033465Z","time spent":"389.434842ms","remote":"127.0.0.1:49940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:15:52.984539Z","caller":"traceutil/trace.go:171","msg":"trace[2105544837] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"453.007928ms","start":"2026-09-18T15:15:52.531505Z","end":"2026-09-18T15:15:52.984513Z","steps":["trace[2105544837] 'read index received' (duration: 452.939356ms)","trace[2105544837] 'applied index is now lower than readState.Index' (duration: 67.462µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:15:52.984623Z","caller":"traceutil/trace.go:171","msg":"trace[245317493] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"479.744716ms","start":"2026-09-18T15:15:52.504799Z","end":"2026-09-18T15:15:52.984544Z","steps":["trace[245317493] 'process raft request' (duration: 479.536131ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:15:52.984748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.299068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:15:52.984822Z","caller":"traceutil/trace.go:171","msg":"trace[1902088529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"350.38207ms","start":"2026-09-18T15:15:52.634426Z","end":"2026-09-18T15:15:52.984808Z","steps":["trace[1902088529] 'agreement among raft nodes before linearized reading' (duration: 350.271427ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:15:52.984863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:15:52.634379Z","time spent":"350.475502ms","remote":"127.0.0.1:49732","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-09-18T15:15:52.984931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:15:52.50477Z","time spent":"479.987221ms","remote":"127.0.0.1:50130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T15:15:52.985048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.5246ms","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-09-18T15:15:52.985199Z","caller":"traceutil/trace.go:171","msg":"trace[981491596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:607; }","duration":"453.724556ms","start":"2026-09-18T15:15:52.53145Z","end":"2026-09-18T15:15:52.985175Z","steps":["trace[981491596] 'agreement among raft nodes before linearized reading' (duration: 453.173082ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:15:52.98526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:15:52.53143Z","time spent":"453.81811ms","remote":"127.0.0.1:50028","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-09-18T15:15:53.543367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.836974ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:15:53.543468Z","caller":"traceutil/trace.go:171","msg":"trace[319242088] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"547.219484ms","start":"2026-09-18T15:15:52.996234Z","end":"2026-09-18T15:15:53.543454Z","steps":["trace[319242088] 'read index received' (duration: 13.02494ms)","trace[319242088] 'applied index is now lower than readState.Index' (duration: 534.193284ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:15:53.543544Z","caller":"traceutil/trace.go:171","msg":"trace[1149894073] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"552.071627ms","start":"2026-09-18T15:15:52.991442Z","end":"2026-09-18T15:15:53.543514Z","steps":["trace[1149894073] 'process raft request' (duration: 17.894063ms)","trace[1149894073] 'compare' (duration: 533.617009ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:15:53.543679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:15:52.991416Z","time spent":"552.19099ms","remote":"127.0.0.1:50028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:15:53.543826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.580893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:15:53.543858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.812883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qzb7s\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-18T15:15:53.543938Z","caller":"traceutil/trace.go:171","msg":"trace[2144400937] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qzb7s; range_end:; response_count:1; response_revision:608; }","duration":"531.909846ms","start":"2026-09-18T15:15:53.01201Z","end":"2026-09-18T15:15:53.54392Z","steps":["trace[2144400937] 'agreement among raft nodes before linearized reading' (duration: 531.706971ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:15:53.543989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:15:53.011952Z","time spent":"532.025999ms","remote":"127.0.0.1:49940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-qzb7s\" "} {"level":"info","ts":"2026-09-18T15:15:53.544062Z","caller":"traceutil/trace.go:171","msg":"trace[1674099931] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:608; }","duration":"547.711466ms","start":"2026-09-18T15:15:52.996198Z","end":"2026-09-18T15:15:53.54391Z","steps":["trace[1674099931] 'agreement among raft nodes before linearized reading' (duration: 547.506921ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:15:53.54418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:15:52.996185Z","time spent":"547.976713ms","remote":"127.0.0.1:50266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"info","ts":"2026-09-18T15:15:53.670861Z","caller":"traceutil/trace.go:171","msg":"trace[496625536] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"109.03618ms","start":"2026-09-18T15:15:53.561789Z","end":"2026-09-18T15:15:53.670825Z","steps":["trace[496625536] 'process raft request' (duration: 106.635439ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:15:55.285673Z","caller":"traceutil/trace.go:171","msg":"trace[271722215] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"121.568628ms","start":"2026-09-18T15:15:55.164077Z","end":"2026-09-18T15:15:55.285646Z","steps":["trace[271722215] 'process raft request' (duration: 121.318211ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:56.241163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.311319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-18T15:16:56.241215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.614297ms","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-09-18T15:16:56.241249Z","caller":"traceutil/trace.go:171","msg":"trace[278343580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:913; }","duration":"177.449643ms","start":"2026-09-18T15:16:56.063783Z","end":"2026-09-18T15:16:56.241233Z","steps":["trace[278343580] 'range keys from in-memory index tree' (duration: 177.115914ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:56.24131Z","caller":"traceutil/trace.go:171","msg":"trace[1206533917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:913; }","duration":"337.73118ms","start":"2026-09-18T15:16:55.903547Z","end":"2026-09-18T15:16:56.241279Z","steps":["trace[1206533917] 'range keys from in-memory index tree' (duration: 337.440062ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:56.24157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:55.903527Z","time spent":"338.015188ms","remote":"127.0.0.1:50028","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":"info","ts":"2026-09-18T15:16:56.245909Z","caller":"traceutil/trace.go:171","msg":"trace[1029854756] linearizableReadLoop","detail":"{readStateIndex:949; appliedIndex:948; }","duration":"102.437124ms","start":"2026-09-18T15:16:56.143457Z","end":"2026-09-18T15:16:56.245894Z","steps":["trace[1029854756] 'read index received' (duration: 102.396383ms)","trace[1029854756] 'applied index is now lower than readState.Index' (duration: 39.881µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:16:56.246092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.635098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-18T15:16:56.246127Z","caller":"traceutil/trace.go:171","msg":"trace[366687303] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:914; }","duration":"102.675339ms","start":"2026-09-18T15:16:56.143441Z","end":"2026-09-18T15:16:56.246116Z","steps":["trace[366687303] 'agreement among raft nodes before linearized reading' (duration: 102.511085ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:56.246161Z","caller":"traceutil/trace.go:171","msg":"trace[1309194269] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"124.314317ms","start":"2026-09-18T15:16:56.121829Z","end":"2026-09-18T15:16:56.246143Z","steps":["trace[1309194269] 'process raft request' (duration: 123.952368ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:16.660337Z","caller":"traceutil/trace.go:171","msg":"trace[1667394740] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"105.455049ms","start":"2026-09-18T15:17:16.554859Z","end":"2026-09-18T15:17:16.660314Z","steps":["trace[1667394740] 'process raft request' (duration: 79.439503ms)","trace[1667394740] 'compare' (duration: 25.890493ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:17:16.660446Z","caller":"traceutil/trace.go:171","msg":"trace[152937373] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"105.319346ms","start":"2026-09-18T15:17:16.555098Z","end":"2026-09-18T15:17:16.660417Z","steps":["trace[152937373] 'process raft request' (duration: 105.179972ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:55.118798Z","caller":"traceutil/trace.go:171","msg":"trace[1307374409] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"121.628237ms","start":"2026-09-18T15:17:54.997148Z","end":"2026-09-18T15:17:55.118776Z","steps":["trace[1307374409] 'process raft request' (duration: 80.585302ms)","trace[1307374409] 'compare' (duration: 40.976253ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:17:55.769599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.927719ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:17:55.769695Z","caller":"traceutil/trace.go:171","msg":"trace[996767021] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1316; }","duration":"173.034292ms","start":"2026-09-18T15:17:55.596644Z","end":"2026-09-18T15:17:55.769679Z","steps":["trace[996767021] 'read index received' (duration: 1.875477ms)","trace[996767021] 'applied index is now lower than readState.Index' (duration: 171.157695ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:17:55.76979Z","caller":"traceutil/trace.go:171","msg":"trace[1962468988] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"335.17457ms","start":"2026-09-18T15:17:55.4346Z","end":"2026-09-18T15:17:55.769774Z","steps":["trace[1962468988] 'process raft request' (duration: 163.974154ms)","trace[1962468988] 'compare' (duration: 170.805686ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:17:55.769862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:17:55.43458Z","time spent":"335.247282ms","remote":"127.0.0.1:49802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:17:55.770173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.524655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:17:55.770214Z","caller":"traceutil/trace.go:171","msg":"trace[1057511726] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1267; }","duration":"173.590466ms","start":"2026-09-18T15:17:55.596612Z","end":"2026-09-18T15:17:55.770203Z","steps":["trace[1057511726] 'agreement among raft nodes before linearized reading' (duration: 173.498424ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:55.77046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.944528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:17:55.770502Z","caller":"traceutil/trace.go:171","msg":"trace[704081398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1267; }","duration":"140.01353ms","start":"2026-09-18T15:17:55.630478Z","end":"2026-09-18T15:17:55.770492Z","steps":["trace[704081398] 'agreement among raft nodes before linearized reading' (duration: 139.953789ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:57.086246Z","caller":"traceutil/trace.go:171","msg":"trace[1847163807] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"148.297879ms","start":"2026-09-18T15:17:56.937916Z","end":"2026-09-18T15:17:57.086214Z","steps":["trace[1847163807] 'process raft request' (duration: 147.90541ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:57.338185Z","caller":"traceutil/trace.go:171","msg":"trace[409613969] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"210.065016ms","start":"2026-09-18T15:17:57.128084Z","end":"2026-09-18T15:17:57.338149Z","steps":["trace[409613969] 'process raft request' (duration: 188.110863ms)","trace[409613969] 'compare' (duration: 21.597094ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:12.016898Z","caller":"traceutil/trace.go:171","msg":"trace[1204860722] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"111.216878ms","start":"2026-09-18T15:18:11.905647Z","end":"2026-09-18T15:18:12.016864Z","steps":["trace[1204860722] 'process raft request' (duration: 111.015623ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:12.118612Z","caller":"traceutil/trace.go:171","msg":"trace[1639046926] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"211.08281ms","start":"2026-09-18T15:18:11.907492Z","end":"2026-09-18T15:18:12.118575Z","steps":["trace[1639046926] 'process raft request' (duration: 210.792643ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:12.555758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.342658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:12.55588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.140961ms","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:533"} {"level":"info","ts":"2026-09-18T15:18:12.556132Z","caller":"traceutil/trace.go:171","msg":"trace[2116987780] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1384; }","duration":"223.673327ms","start":"2026-09-18T15:18:12.332328Z","end":"2026-09-18T15:18:12.556002Z","steps":["trace[2116987780] 'count revisions from in-memory index tree' (duration: 223.196145ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:12.556405Z","caller":"traceutil/trace.go:171","msg":"trace[1961179766] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1384; }","duration":"368.502391ms","start":"2026-09-18T15:18:12.187655Z","end":"2026-09-18T15:18:12.556158Z","steps":["trace[1961179766] 'range keys from in-memory index tree' (duration: 367.913276ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:12.556584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:12.187631Z","time spent":"368.865799ms","remote":"127.0.0.1:50028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}