{"level":"warn","ts":"2026-09-09T01:01:10.824131Z","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-09T01:01:10.824268Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.181: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.181:2380","--initial-cluster=instance=https://162.253.55.181:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.181:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.181: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-09T01:01:10.824482Z","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-09T01:01:10.824503Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.181:2380"]} {"level":"info","ts":"2026-09-09T01:01:10.824537Z","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-09T01:01:10.826208Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.181:2379"]} {"level":"info","ts":"2026-09-09T01:01:10.826378Z","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.181:2380"],"listen-peer-urls":["https://162.253.55.181:2380"],"advertise-client-urls":["https://162.253.55.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.181: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-09T01:01:10.831693Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.034001ms"} {"level":"info","ts":"2026-09-09T01:01:10.840178Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"865c2c1f02504fb9","cluster-id":"c3b098aaa499ad51"} {"level":"info","ts":"2026-09-09T01:01:10.840289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 switched to configuration voters=()"} {"level":"info","ts":"2026-09-09T01:01:10.840328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 became follower at term 0"} {"level":"info","ts":"2026-09-09T01:01:10.840338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 865c2c1f02504fb9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-09T01:01:10.840346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 became follower at term 1"} {"level":"info","ts":"2026-09-09T01:01:10.840392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 switched to configuration voters=(9681661810634149817)"} {"level":"warn","ts":"2026-09-09T01:01:10.849577Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-09T01:01:10.850956Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-09T01:01:10.852424Z","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-09T01:01:10.859636Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"865c2c1f02504fb9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-09T01:01:10.860115Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"865c2c1f02504fb9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-09T01:01:10.860457Z","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-09T01:01:10.860511Z","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-09T01:01:10.860523Z","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-09T01:01:10.862024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 switched to configuration voters=(9681661810634149817)"} {"level":"info","ts":"2026-09-09T01:01:10.862175Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c3b098aaa499ad51","local-member-id":"865c2c1f02504fb9","added-peer-id":"865c2c1f02504fb9","added-peer-peer-urls":["https://162.253.55.181:2380"]} {"level":"info","ts":"2026-09-09T01:01:10.865345Z","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-09T01:01:10.865439Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.181:2380"} {"level":"info","ts":"2026-09-09T01:01:10.865464Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.181:2380"} {"level":"info","ts":"2026-09-09T01:01:10.865868Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"865c2c1f02504fb9","initial-advertise-peer-urls":["https://162.253.55.181:2380"],"listen-peer-urls":["https://162.253.55.181:2380"],"advertise-client-urls":["https://162.253.55.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-09T01:01:10.865913Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-09T01:01:11.841488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 is starting a new election at term 1"} {"level":"info","ts":"2026-09-09T01:01:11.841591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-09T01:01:11.841645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 received MsgPreVoteResp from 865c2c1f02504fb9 at term 1"} {"level":"info","ts":"2026-09-09T01:01:11.84167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 became candidate at term 2"} {"level":"info","ts":"2026-09-09T01:01:11.841685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 received MsgVoteResp from 865c2c1f02504fb9 at term 2"} {"level":"info","ts":"2026-09-09T01:01:11.841706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"865c2c1f02504fb9 became leader at term 2"} {"level":"info","ts":"2026-09-09T01:01:11.841723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 865c2c1f02504fb9 elected leader 865c2c1f02504fb9 at term 2"} {"level":"info","ts":"2026-09-09T01:01:11.861563Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"865c2c1f02504fb9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.181:2379]}","request-path":"/0/members/865c2c1f02504fb9/attributes","cluster-id":"c3b098aaa499ad51","publish-timeout":"7s"} {"level":"info","ts":"2026-09-09T01:01:11.861624Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T01:01:11.861704Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T01:01:11.861847Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-09T01:01:11.861865Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-09T01:01:11.861892Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:01:11.867101Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.181:2379"} {"level":"info","ts":"2026-09-09T01:01:11.867141Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-09T01:01:11.872627Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c3b098aaa499ad51","local-member-id":"865c2c1f02504fb9","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:01:11.873539Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:01:11.87361Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:01:14.972793Z","caller":"traceutil/trace.go:171","msg":"trace[1903436246] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"114.277752ms","start":"2026-09-09T01:01:14.858467Z","end":"2026-09-09T01:01:14.972744Z","steps":["trace[1903436246] 'process raft request' (duration: 103.539455ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.344186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.419456ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:01:17.344287Z","caller":"traceutil/trace.go:171","msg":"trace[1722585627] linearizableReadLoop","detail":"{readStateIndex:284; appliedIndex:283; }","duration":"386.446676ms","start":"2026-09-09T01:01:16.957831Z","end":"2026-09-09T01:01:17.344277Z","steps":["trace[1722585627] 'read index received' (duration: 188.639134ms)","trace[1722585627] 'applied index is now lower than readState.Index' (duration: 197.806392ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:17.344332Z","caller":"traceutil/trace.go:171","msg":"trace[1699292342] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"388.169476ms","start":"2026-09-09T01:01:16.956122Z","end":"2026-09-09T01:01:17.344291Z","steps":["trace[1699292342] 'process raft request' (duration: 190.289612ms)","trace[1699292342] 'compare' (duration: 197.257564ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:01:17.344385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.554138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:01:17.344405Z","caller":"traceutil/trace.go:171","msg":"trace[2043093189] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:0; response_revision:278; }","duration":"386.590139ms","start":"2026-09-09T01:01:16.957806Z","end":"2026-09-09T01:01:17.344396Z","steps":["trace[2043093189] 'agreement among raft nodes before linearized reading' (duration: 386.532328ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.344422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:16.957799Z","time spent":"386.619041ms","remote":"127.0.0.1:43498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" "} {"level":"warn","ts":"2026-09-09T01:01:17.344457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:16.956109Z","time spent":"388.277777ms","remote":"127.0.0.1:43358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:01:17.374756Z","caller":"traceutil/trace.go:171","msg":"trace[1570206029] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"415.700621ms","start":"2026-09-09T01:01:16.959025Z","end":"2026-09-09T01:01:17.374725Z","steps":["trace[1570206029] 'process raft request' (duration: 415.547679ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.374887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:16.959017Z","time spent":"415.804853ms","remote":"127.0.0.1:43372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-09T01:01:17.375015Z","caller":"traceutil/trace.go:171","msg":"trace[1111040226] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"327.558245ms","start":"2026-09-09T01:01:17.047427Z","end":"2026-09-09T01:01:17.374985Z","steps":["trace[1111040226] 'process raft request' (duration: 327.315831ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:17.375125Z","caller":"traceutil/trace.go:171","msg":"trace[1165140930] transaction","detail":"{read_only:false; number_of_response:0; response_revision:282; }","duration":"327.029385ms","start":"2026-09-09T01:01:17.04809Z","end":"2026-09-09T01:01:17.37512Z","steps":["trace[1165140930] 'process raft request' (duration: 326.783031ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.375141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.047405Z","time spent":"327.680077ms","remote":"127.0.0.1:43474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-09T01:01:17.375158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.048084Z","time spent":"327.060626ms","remote":"127.0.0.1:43474","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-09T01:01:17.375258Z","caller":"traceutil/trace.go:171","msg":"trace[99269314] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"327.495284ms","start":"2026-09-09T01:01:17.047758Z","end":"2026-09-09T01:01:17.375253Z","steps":["trace[99269314] 'process raft request' (duration: 327.040155ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.375239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.68248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-09-09T01:01:17.375264Z","caller":"traceutil/trace.go:171","msg":"trace[1652217198] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"325.814965ms","start":"2026-09-09T01:01:17.049379Z","end":"2026-09-09T01:01:17.375194Z","steps":["trace[1652217198] 'process raft request' (duration: 325.52545ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.375294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.04773Z","time spent":"327.546865ms","remote":"127.0.0.1:43474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-09T01:01:17.37531Z","caller":"traceutil/trace.go:171","msg":"trace[898523728] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:283; }","duration":"415.787582ms","start":"2026-09-09T01:01:16.959504Z","end":"2026-09-09T01:01:17.375292Z","steps":["trace[898523728] 'agreement among raft nodes before linearized reading' (duration: 415.617008ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:17.375335Z","caller":"traceutil/trace.go:171","msg":"trace[1623187134] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"327.452233ms","start":"2026-09-09T01:01:17.047877Z","end":"2026-09-09T01:01:17.375329Z","steps":["trace[1623187134] 'process raft request' (duration: 326.961384ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.375347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:16.959492Z","time spent":"415.848433ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":688,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-09-09T01:01:17.375368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.047872Z","time spent":"327.479053ms","remote":"127.0.0.1:43474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-09T01:01:17.375355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.049358Z","time spent":"325.952308ms","remote":"127.0.0.1:43474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-09T01:01:17.375469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.266811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-09-09T01:01:17.375488Z","caller":"traceutil/trace.go:171","msg":"trace[165014888] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:283; }","duration":"416.302091ms","start":"2026-09-09T01:01:16.959182Z","end":"2026-09-09T01:01:17.375484Z","steps":["trace[165014888] 'agreement among raft nodes before linearized reading' (duration: 416.23426ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.375503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:16.959177Z","time spent":"416.323192ms","remote":"127.0.0.1:43458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4041,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-09-09T01:01:17.375521Z","caller":"traceutil/trace.go:171","msg":"trace[1166215152] transaction","detail":"{read_only:false; number_of_response:0; response_revision:279; }","duration":"340.202259ms","start":"2026-09-09T01:01:17.035303Z","end":"2026-09-09T01:01:17.375506Z","steps":["trace[1166215152] 'process raft request' (duration: 339.391335ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.375601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.035285Z","time spent":"340.29102ms","remote":"127.0.0.1:43458","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-09T01:01:17.871303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.27668ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:01:17.871499Z","caller":"traceutil/trace.go:171","msg":"trace[1178835486] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"491.21794ms","start":"2026-09-09T01:01:17.380265Z","end":"2026-09-09T01:01:17.871483Z","steps":["trace[1178835486] 'process raft request' (duration: 491.18047ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:17.871532Z","caller":"traceutil/trace.go:171","msg":"trace[1888655377] linearizableReadLoop","detail":"{readStateIndex:292; appliedIndex:291; }","duration":"496.54854ms","start":"2026-09-09T01:01:17.374958Z","end":"2026-09-09T01:01:17.871506Z","steps":["trace[1888655377] 'read index received' (duration: 255.940934ms)","trace[1888655377] 'applied index is now lower than readState.Index' (duration: 240.604746ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:01:17.871562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.380242Z","time spent":"491.290191ms","remote":"127.0.0.1:43372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-09T01:01:17.871672Z","caller":"traceutil/trace.go:171","msg":"trace[1559671166] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"525.697882ms","start":"2026-09-09T01:01:17.345949Z","end":"2026-09-09T01:01:17.871647Z","steps":["trace[1559671166] 'process raft request' (duration: 284.999195ms)","trace[1559671166] 'compare' (duration: 240.058947ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:17.871746Z","caller":"traceutil/trace.go:171","msg":"trace[179126273] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"493.039941ms","start":"2026-09-09T01:01:17.378696Z","end":"2026-09-09T01:01:17.871736Z","steps":["trace[179126273] 'process raft request' (duration: 492.698315ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.871757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.345918Z","time spent":"525.795893ms","remote":"127.0.0.1:43488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1196,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-09T01:01:17.871794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.378669Z","time spent":"493.100841ms","remote":"127.0.0.1:43568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-09T01:01:17.872364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.5583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-09T01:01:17.872424Z","caller":"traceutil/trace.go:171","msg":"trace[210063249] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:286; }","duration":"525.805234ms","start":"2026-09-09T01:01:17.346603Z","end":"2026-09-09T01:01:17.872408Z","steps":["trace[210063249] 'agreement among raft nodes before linearized reading' (duration: 525.502378ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.872482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.346586Z","time spent":"525.884685ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-09T01:01:17.872967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.112795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:01:17.873028Z","caller":"traceutil/trace.go:171","msg":"trace[399095332] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:286; }","duration":"160.214857ms","start":"2026-09-09T01:01:17.712797Z","end":"2026-09-09T01:01:17.873012Z","steps":["trace[399095332] 'agreement among raft nodes before linearized reading' (duration: 160.122606ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.873129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.655225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-09-09T01:01:17.873181Z","caller":"traceutil/trace.go:171","msg":"trace[786328704] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:286; }","duration":"495.750136ms","start":"2026-09-09T01:01:17.377418Z","end":"2026-09-09T01:01:17.873168Z","steps":["trace[786328704] 'agreement among raft nodes before linearized reading' (duration: 495.650994ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.87324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.377406Z","time spent":"495.826198ms","remote":"127.0.0.1:43474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5921,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-09-09T01:01:17.873614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.225211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-09-09T01:01:17.873651Z","caller":"traceutil/trace.go:171","msg":"trace[1102953946] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:286; }","duration":"497.284581ms","start":"2026-09-09T01:01:17.376357Z","end":"2026-09-09T01:01:17.873642Z","steps":["trace[1102953946] 'agreement among raft nodes before linearized reading' (duration: 497.22165ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:17.873675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:17.376272Z","time spent":"497.397305ms","remote":"127.0.0.1:43458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4041,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-09-09T01:01:51.677524Z","caller":"traceutil/trace.go:171","msg":"trace[1925820709] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"130.334592ms","start":"2026-09-09T01:01:51.54716Z","end":"2026-09-09T01:01:51.677495Z","steps":["trace[1925820709] 'process raft request' (duration: 106.064623ms)","trace[1925820709] 'compare' (duration: 24.153618ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:51.678222Z","caller":"traceutil/trace.go:171","msg":"trace[2106860395] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"129.641403ms","start":"2026-09-09T01:01:51.548552Z","end":"2026-09-09T01:01:51.678193Z","steps":["trace[2106860395] 'process raft request' (duration: 129.164217ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:56.860864Z","caller":"traceutil/trace.go:171","msg":"trace[899832815] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"184.047055ms","start":"2026-09-09T01:01:56.676778Z","end":"2026-09-09T01:01:56.860825Z","steps":["trace[899832815] 'process raft request' (duration: 183.805132ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:56.872049Z","caller":"traceutil/trace.go:171","msg":"trace[1925909462] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"130.825565ms","start":"2026-09-09T01:01:56.741205Z","end":"2026-09-09T01:01:56.872031Z","steps":["trace[1925909462] 'process raft request' (duration: 130.440751ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:58.234191Z","caller":"traceutil/trace.go:171","msg":"trace[607147742] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"138.864637ms","start":"2026-09-09T01:01:58.095299Z","end":"2026-09-09T01:01:58.234163Z","steps":["trace[607147742] 'process raft request' (duration: 137.853974ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:58.869271Z","caller":"traceutil/trace.go:171","msg":"trace[926940520] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"574.054954ms","start":"2026-09-09T01:01:58.295184Z","end":"2026-09-09T01:01:58.869239Z","steps":["trace[926940520] 'process raft request' (duration: 573.368336ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:58.869434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:58.295153Z","time spent":"574.198096ms","remote":"127.0.0.1:43388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:02:00.389247Z","caller":"traceutil/trace.go:171","msg":"trace[1436754254] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"127.169672ms","start":"2026-09-09T01:02:00.262046Z","end":"2026-09-09T01:02:00.389215Z","steps":["trace[1436754254] 'read index received' (duration: 79.638721ms)","trace[1436754254] 'applied index is now lower than readState.Index' (duration: 47.529341ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:02:00.389398Z","caller":"traceutil/trace.go:171","msg":"trace[2067280662] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"128.445728ms","start":"2026-09-09T01:02:00.260916Z","end":"2026-09-09T01:02:00.389362Z","steps":["trace[2067280662] 'process raft request' (duration: 80.632893ms)","trace[2067280662] 'compare' (duration: 47.528741ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:02:00.389667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.590157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:02:00.389734Z","caller":"traceutil/trace.go:171","msg":"trace[336344673] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:673; }","duration":"127.688318ms","start":"2026-09-09T01:02:00.262027Z","end":"2026-09-09T01:02:00.389715Z","steps":["trace[336344673] 'agreement among raft nodes before linearized reading' (duration: 127.349894ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:00.39069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.02419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:02:00.390658Z","caller":"traceutil/trace.go:171","msg":"trace[1566400727] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"126.718376ms","start":"2026-09-09T01:02:00.263921Z","end":"2026-09-09T01:02:00.390639Z","steps":["trace[1566400727] 'process raft request' (duration: 126.542114ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:02:00.390741Z","caller":"traceutil/trace.go:171","msg":"trace[305968449] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:676; }","duration":"127.100551ms","start":"2026-09-09T01:02:00.263627Z","end":"2026-09-09T01:02:00.390728Z","steps":["trace[305968449] 'agreement among raft nodes before linearized reading' (duration: 127.000959ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:02:00.390985Z","caller":"traceutil/trace.go:171","msg":"trace[1054151133] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"126.104979ms","start":"2026-09-09T01:02:00.264869Z","end":"2026-09-09T01:02:00.390974Z","steps":["trace[1054151133] 'process raft request' (duration: 125.690574ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:02:00.391109Z","caller":"traceutil/trace.go:171","msg":"trace[1762176520] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"125.856515ms","start":"2026-09-09T01:02:00.26524Z","end":"2026-09-09T01:02:00.391096Z","steps":["trace[1762176520] 'process raft request' (duration: 125.357139ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:00.391284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.24868ms","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-09-09T01:02:00.391316Z","caller":"traceutil/trace.go:171","msg":"trace[759052166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:676; }","duration":"126.31185ms","start":"2026-09-09T01:02:00.264996Z","end":"2026-09-09T01:02:00.391308Z","steps":["trace[759052166] 'agreement among raft nodes before linearized reading' (duration: 126.203299ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:02:06.58437Z","caller":"traceutil/trace.go:171","msg":"trace[579519154] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"167.738587ms","start":"2026-09-09T01:02:06.416604Z","end":"2026-09-09T01:02:06.584342Z","steps":["trace[579519154] 'read index received' (duration: 164.406836ms)","trace[579519154] 'applied index is now lower than readState.Index' (duration: 3.330311ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:02:06.584431Z","caller":"traceutil/trace.go:171","msg":"trace[146249164] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"218.198593ms","start":"2026-09-09T01:02:06.366198Z","end":"2026-09-09T01:02:06.584397Z","steps":["trace[146249164] 'process raft request' (duration: 214.869692ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:06.584732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.101934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-09T01:02:06.584822Z","caller":"traceutil/trace.go:171","msg":"trace[844271460] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:757; }","duration":"160.229695ms","start":"2026-09-09T01:02:06.424575Z","end":"2026-09-09T01:02:06.584804Z","steps":["trace[844271460] 'agreement among raft nodes before linearized reading' (duration: 159.984603ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:06.584871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.890516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-09T01:02:06.584969Z","caller":"traceutil/trace.go:171","msg":"trace[1353529039] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:757; }","duration":"167.015207ms","start":"2026-09-09T01:02:06.417939Z","end":"2026-09-09T01:02:06.584954Z","steps":["trace[1353529039] 'agreement among raft nodes before linearized reading' (duration: 166.610552ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:06.584968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.275803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-09T01:02:06.585287Z","caller":"traceutil/trace.go:171","msg":"trace[1827638742] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:757; }","duration":"168.582746ms","start":"2026-09-09T01:02:06.416564Z","end":"2026-09-09T01:02:06.585147Z","steps":["trace[1827638742] 'agreement among raft nodes before linearized reading' (duration: 167.957369ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:02:06.829889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.685078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:02:06.830562Z","caller":"traceutil/trace.go:171","msg":"trace[2019229239] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"239.52752ms","start":"2026-09-09T01:02:06.590999Z","end":"2026-09-09T01:02:06.830526Z","steps":["trace[2019229239] 'process raft request' (duration: 95.139063ms)","trace[2019229239] 'compare' (duration: 143.537426ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:02:06.8307Z","caller":"traceutil/trace.go:171","msg":"trace[1374858534] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"239.58533ms","start":"2026-09-09T01:02:06.591075Z","end":"2026-09-09T01:02:06.83066Z","steps":["trace[1374858534] 'process raft request' (duration: 239.038873ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:02:06.831163Z","caller":"traceutil/trace.go:171","msg":"trace[212622989] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"239.079654ms","start":"2026-09-09T01:02:06.592063Z","end":"2026-09-09T01:02:06.831143Z","steps":["trace[212622989] 'process raft request' (duration: 238.188543ms)"],"step_count":1}