{"level":"warn","ts":"2026-10-04T09:49:34.308912Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-04T09:49:34.309059Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.186: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.186:2380","--initial-cluster=instance=https://162.253.55.186:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.186:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.186:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-04T09:49:34.309173Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-04T09:49:34.309197Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-10-04T09:49:34.309239Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-04T09:49:34.310416Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"]} {"level":"info","ts":"2026-10-04T09:49:34.310555Z","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.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.186:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-04T09:49:34.329928Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"18.933229ms"} {"level":"info","ts":"2026-10-04T09:49:34.358102Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"612d5169b08bb96b","cluster-id":"20ec8eafba602517"} {"level":"info","ts":"2026-10-04T09:49:34.358277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=()"} {"level":"info","ts":"2026-10-04T09:49:34.358317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 0"} {"level":"info","ts":"2026-10-04T09:49:34.35834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 612d5169b08bb96b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-04T09:49:34.358361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 1"} {"level":"info","ts":"2026-10-04T09:49:34.358437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"warn","ts":"2026-10-04T09:49:34.396311Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-04T09:49:34.39885Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-04T09:49:34.40739Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-04T09:49:34.410413Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"612d5169b08bb96b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-04T09:49:34.411469Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"612d5169b08bb96b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-04T09:49:34.411523Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-04T09:49:34.41155Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-04T09:49:34.411556Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-04T09:49:34.41448Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-04T09:49:34.414886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"info","ts":"2026-10-04T09:49:34.41493Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-10-04T09:49:34.415007Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","added-peer-id":"612d5169b08bb96b","added-peer-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-10-04T09:49:34.414992Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-10-04T09:49:34.41537Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"612d5169b08bb96b","initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-04T09:49:34.415418Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-04T09:49:35.163142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b is starting a new election at term 1"} {"level":"info","ts":"2026-10-04T09:49:35.163276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became pre-candidate at term 1"} {"level":"info","ts":"2026-10-04T09:49:35.163329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgPreVoteResp from 612d5169b08bb96b at term 1"} {"level":"info","ts":"2026-10-04T09:49:35.163354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became candidate at term 2"} {"level":"info","ts":"2026-10-04T09:49:35.163369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgVoteResp from 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-10-04T09:49:35.163392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became leader at term 2"} {"level":"info","ts":"2026-10-04T09:49:35.163414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 612d5169b08bb96b elected leader 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-10-04T09:49:35.164721Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T09:49:35.164789Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-04T09:49:35.165033Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-04T09:49:35.165482Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-04T09:49:35.165508Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-04T09:49:35.167914Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T09:49:35.167923Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-04T09:49:35.168011Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T09:49:35.168043Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-04T09:49:35.164789Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"612d5169b08bb96b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.186:2379]}","request-path":"/0/members/612d5169b08bb96b/attributes","cluster-id":"20ec8eafba602517","publish-timeout":"7s"} {"level":"info","ts":"2026-10-04T09:49:35.178495Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.186:2379"} {"level":"warn","ts":"2026-10-04T09:49:38.106185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.396014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-04T09:49:38.106344Z","caller":"traceutil/trace.go:171","msg":"trace[2041244582] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"123.453342ms","start":"2026-10-04T09:49:37.982869Z","end":"2026-10-04T09:49:38.106322Z","steps":["trace[2041244582] 'process raft request' (duration: 14.411653ms)","trace[2041244582] 'compare' (duration: 108.248051ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T09:49:38.290698Z","caller":"traceutil/trace.go:171","msg":"trace[1199083260] transaction","detail":"{read_only:false; response_revision:96; number_of_response:1; }","duration":"164.475713ms","start":"2026-10-04T09:49:38.126182Z","end":"2026-10-04T09:49:38.290658Z","steps":["trace[1199083260] 'process raft request' (duration: 104.916653ms)","trace[1199083260] 'compare' (duration: 59.358405ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T09:49:39.2094Z","caller":"traceutil/trace.go:171","msg":"trace[623081351] transaction","detail":"{read_only:false; response_revision:124; number_of_response:1; }","duration":"129.836906ms","start":"2026-10-04T09:49:39.079519Z","end":"2026-10-04T09:49:39.209355Z","steps":["trace[623081351] 'process raft request' (duration: 77.669416ms)","trace[623081351] 'compare' (duration: 51.932255ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T09:49:46.032821Z","caller":"traceutil/trace.go:171","msg":"trace[1790465681] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"102.639036ms","start":"2026-10-04T09:49:45.930142Z","end":"2026-10-04T09:49:46.032781Z","steps":["trace[1790465681] 'process raft request' (duration: 102.504653ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:49:47.242255Z","caller":"traceutil/trace.go:171","msg":"trace[765561611] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"148.047491ms","start":"2026-10-04T09:49:47.094179Z","end":"2026-10-04T09:49:47.242227Z","steps":["trace[765561611] 'process raft request' (duration: 147.725504ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:49:47.243013Z","caller":"traceutil/trace.go:171","msg":"trace[980421701] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"148.45253ms","start":"2026-10-04T09:49:47.094538Z","end":"2026-10-04T09:49:47.242991Z","steps":["trace[980421701] 'process raft request' (duration: 147.609541ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:49:47.243024Z","caller":"traceutil/trace.go:171","msg":"trace[1342671359] linearizableReadLoop","detail":"{readStateIndex:326; appliedIndex:323; }","duration":"136.449636ms","start":"2026-10-04T09:49:47.106528Z","end":"2026-10-04T09:49:47.242978Z","steps":["trace[1342671359] 'read index received' (duration: 79.613168ms)","trace[1342671359] 'applied index is now lower than readState.Index' (duration: 56.835078ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T09:49:47.243053Z","caller":"traceutil/trace.go:171","msg":"trace[1518648965] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"148.406648ms","start":"2026-10-04T09:49:47.094613Z","end":"2026-10-04T09:49:47.24302Z","steps":["trace[1518648965] 'process raft request' (duration: 148.270555ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:49:47.244573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.028389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-10-04T09:49:47.244663Z","caller":"traceutil/trace.go:171","msg":"trace[472350867] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:314; }","duration":"138.193253ms","start":"2026-10-04T09:49:47.106452Z","end":"2026-10-04T09:49:47.244645Z","steps":["trace[472350867] 'agreement among raft nodes before linearized reading' (duration: 136.709442ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:49:47.245313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.549705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-10-04T09:49:47.245375Z","caller":"traceutil/trace.go:171","msg":"trace[702160990] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:314; }","duration":"114.613036ms","start":"2026-10-04T09:49:47.130748Z","end":"2026-10-04T09:49:47.245361Z","steps":["trace[702160990] 'agreement among raft nodes before linearized reading' (duration: 112.825189ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:49:48.401825Z","caller":"traceutil/trace.go:171","msg":"trace[475889553] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"122.642413ms","start":"2026-10-04T09:49:48.279123Z","end":"2026-10-04T09:49:48.401765Z","steps":["trace[475889553] 'process raft request' (duration: 67.865619ms)","trace[475889553] 'compare' (duration: 54.497118ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T09:49:48.40201Z","caller":"traceutil/trace.go:171","msg":"trace[1808138370] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"109.662752ms","start":"2026-10-04T09:49:48.292316Z","end":"2026-10-04T09:49:48.401979Z","steps":["trace[1808138370] 'process raft request' (duration: 109.381746ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:49:59.846571Z","caller":"traceutil/trace.go:171","msg":"trace[1581723336] linearizableReadLoop","detail":"{readStateIndex:410; appliedIndex:409; }","duration":"302.584652ms","start":"2026-10-04T09:49:59.543962Z","end":"2026-10-04T09:49:59.846546Z","steps":["trace[1581723336] 'read index received' (duration: 302.404059ms)","trace[1581723336] 'applied index is now lower than readState.Index' (duration: 179.753µs)"],"step_count":2} {"level":"warn","ts":"2026-10-04T09:49:59.846753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.737895ms","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-10-04T09:49:59.846786Z","caller":"traceutil/trace.go:171","msg":"trace[1695747798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:395; }","duration":"302.844228ms","start":"2026-10-04T09:49:59.54393Z","end":"2026-10-04T09:49:59.846774Z","steps":["trace[1695747798] 'agreement among raft nodes before linearized reading' (duration: 302.717315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:49:59.846817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:49:59.543903Z","time spent":"302.906228ms","remote":"127.0.0.1:44158","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":"info","ts":"2026-10-04T09:49:59.847164Z","caller":"traceutil/trace.go:171","msg":"trace[262513488] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"305.219462ms","start":"2026-10-04T09:49:59.541933Z","end":"2026-10-04T09:49:59.847153Z","steps":["trace[262513488] 'process raft request' (duration: 304.499028ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:49:59.847396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:49:59.541916Z","time spent":"305.273124ms","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-04T09:50:18.985201Z","caller":"traceutil/trace.go:171","msg":"trace[1837391624] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"225.101861ms","start":"2026-10-04T09:50:18.760076Z","end":"2026-10-04T09:50:18.985177Z","steps":["trace[1837391624] 'process raft request' (duration: 224.923708ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.006193Z","caller":"traceutil/trace.go:171","msg":"trace[908210676] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"237.853742ms","start":"2026-10-04T09:50:18.768323Z","end":"2026-10-04T09:50:19.006177Z","steps":["trace[908210676] 'process raft request' (duration: 237.653859ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.00636Z","caller":"traceutil/trace.go:171","msg":"trace[2102525406] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"234.969534ms","start":"2026-10-04T09:50:18.771381Z","end":"2026-10-04T09:50:19.006351Z","steps":["trace[2102525406] 'process raft request' (duration: 234.73182ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.006424Z","caller":"traceutil/trace.go:171","msg":"trace[1803544686] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"227.641623ms","start":"2026-10-04T09:50:18.778774Z","end":"2026-10-04T09:50:19.006415Z","steps":["trace[1803544686] 'process raft request' (duration: 227.47138ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.006406Z","caller":"traceutil/trace.go:171","msg":"trace[467796685] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"231.991205ms","start":"2026-10-04T09:50:18.77437Z","end":"2026-10-04T09:50:19.006362Z","steps":["trace[467796685] 'process raft request' (duration: 231.780441ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.00656Z","caller":"traceutil/trace.go:171","msg":"trace[1879927662] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"218.802855ms","start":"2026-10-04T09:50:18.78775Z","end":"2026-10-04T09:50:19.006552Z","steps":["trace[1879927662] 'process raft request' (duration: 218.53507ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.006651Z","caller":"traceutil/trace.go:171","msg":"trace[724057440] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"214.609505ms","start":"2026-10-04T09:50:18.792028Z","end":"2026-10-04T09:50:19.006638Z","steps":["trace[724057440] 'process raft request' (duration: 214.459283ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.006552Z","caller":"traceutil/trace.go:171","msg":"trace[787903593] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"237.978824ms","start":"2026-10-04T09:50:18.768398Z","end":"2026-10-04T09:50:19.006377Z","steps":["trace[787903593] 'process raft request' (duration: 237.673009ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.006762Z","caller":"traceutil/trace.go:171","msg":"trace[1569985762] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"203.328287ms","start":"2026-10-04T09:50:18.803403Z","end":"2026-10-04T09:50:19.006731Z","steps":["trace[1569985762] 'process raft request' (duration: 203.169674ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.006974Z","caller":"traceutil/trace.go:171","msg":"trace[734367379] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"197.090634ms","start":"2026-10-04T09:50:18.809826Z","end":"2026-10-04T09:50:19.006916Z","steps":["trace[734367379] 'process raft request' (duration: 196.823779ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.007116Z","caller":"traceutil/trace.go:171","msg":"trace[124634708] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:524; }","duration":"237.575647ms","start":"2026-10-04T09:50:18.769482Z","end":"2026-10-04T09:50:19.007058Z","steps":["trace[124634708] 'read index received' (duration: 214.472983ms)","trace[124634708] 'applied index is now lower than readState.Index' (duration: 23.101894ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T09:50:19.007018Z","caller":"traceutil/trace.go:171","msg":"trace[1696755342] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"176.985828ms","start":"2026-10-04T09:50:18.830011Z","end":"2026-10-04T09:50:19.006997Z","steps":["trace[1696755342] 'process raft request' (duration: 176.767255ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:50:19.007243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.72721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-04T09:50:19.007274Z","caller":"traceutil/trace.go:171","msg":"trace[145440899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:517; }","duration":"237.813691ms","start":"2026-10-04T09:50:18.769451Z","end":"2026-10-04T09:50:19.007264Z","steps":["trace[145440899] 'agreement among raft nodes before linearized reading' (duration: 237.709559ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.55817Z","caller":"traceutil/trace.go:171","msg":"trace[974690744] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"104.889837ms","start":"2026-10-04T09:50:19.45326Z","end":"2026-10-04T09:50:19.558149Z","steps":["trace[974690744] 'process raft request' (duration: 104.810076ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:19.558222Z","caller":"traceutil/trace.go:171","msg":"trace[1139406040] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"105.031138ms","start":"2026-10-04T09:50:19.453143Z","end":"2026-10-04T09:50:19.558174Z","steps":["trace[1139406040] 'process raft request' (duration: 69.047063ms)","trace[1139406040] 'compare' (duration: 35.741991ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T09:50:26.598871Z","caller":"traceutil/trace.go:171","msg":"trace[921129652] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"484.117893ms","start":"2026-10-04T09:50:26.114697Z","end":"2026-10-04T09:50:26.598815Z","steps":["trace[921129652] 'process raft request' (duration: 478.797109ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:50:26.599068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:50:26.114674Z","time spent":"484.306556ms","remote":"127.0.0.1:44008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-04T09:50:26.613788Z","caller":"traceutil/trace.go:171","msg":"trace[361372943] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:640; }","duration":"474.373029ms","start":"2026-10-04T09:50:26.139356Z","end":"2026-10-04T09:50:26.613729Z","steps":["trace[361372943] 'read index received' (duration: 453.859274ms)","trace[361372943] 'applied index is now lower than readState.Index' (duration: 20.512685ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T09:50:26.613911Z","caller":"traceutil/trace.go:171","msg":"trace[1703156995] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"496.181024ms","start":"2026-10-04T09:50:26.117714Z","end":"2026-10-04T09:50:26.613895Z","steps":["trace[1703156995] 'process raft request' (duration: 495.882639ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:50:26.614021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:50:26.117692Z","time spent":"496.248156ms","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-04T09:50:26.614095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.520812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hzjhb\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-04T09:50:26.614167Z","caller":"traceutil/trace.go:171","msg":"trace[1842605831] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hzjhb; range_end:; response_count:1; response_revision:616; }","duration":"330.645994ms","start":"2026-10-04T09:50:26.283499Z","end":"2026-10-04T09:50:26.614145Z","steps":["trace[1842605831] 'agreement among raft nodes before linearized reading' (duration: 330.449211ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:50:26.614209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:50:26.283479Z","time spent":"330.720555ms","remote":"127.0.0.1:44062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-hzjhb\" "} {"level":"warn","ts":"2026-10-04T09:50:26.61418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.800106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-04T09:50:26.6143Z","caller":"traceutil/trace.go:171","msg":"trace[86792137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"474.962689ms","start":"2026-10-04T09:50:26.139305Z","end":"2026-10-04T09:50:26.614268Z","steps":["trace[86792137] 'agreement among raft nodes before linearized reading' (duration: 474.732335ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:50:26.614361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:50:26.139287Z","time spent":"475.06166ms","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-04T09:50:26.910902Z","caller":"traceutil/trace.go:171","msg":"trace[1794784200] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"288.215082ms","start":"2026-10-04T09:50:26.622654Z","end":"2026-10-04T09:50:26.910869Z","steps":["trace[1794784200] 'process raft request' (duration: 287.981878ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:26.911075Z","caller":"traceutil/trace.go:171","msg":"trace[1575520369] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"288.398755ms","start":"2026-10-04T09:50:26.622642Z","end":"2026-10-04T09:50:26.911041Z","steps":["trace[1575520369] 'process raft request' (duration: 288.171651ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:27.103032Z","caller":"traceutil/trace.go:171","msg":"trace[1185786629] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"470.390976ms","start":"2026-10-04T09:50:26.632601Z","end":"2026-10-04T09:50:27.102992Z","steps":["trace[1185786629] 'process raft request' (duration: 470.172873ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:27.103236Z","caller":"traceutil/trace.go:171","msg":"trace[532136223] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"429.845755ms","start":"2026-10-04T09:50:26.673362Z","end":"2026-10-04T09:50:27.103207Z","steps":["trace[532136223] 'process raft request' (duration: 429.55569ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:50:27.103295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:50:26.632573Z","time spent":"470.559229ms","remote":"127.0.0.1:44062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-04T09:50:27.103404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:50:26.673336Z","time spent":"429.999138ms","remote":"127.0.0.1:44128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-04T09:50:27.856801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.647833ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-04T09:50:27.857146Z","caller":"traceutil/trace.go:171","msg":"trace[1384107667] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:646; }","duration":"122.117682ms","start":"2026-10-04T09:50:27.735011Z","end":"2026-10-04T09:50:27.857129Z","steps":["trace[1384107667] 'read index received' (duration: 52.432714ms)","trace[1384107667] 'applied index is now lower than readState.Index' (duration: 69.683968ms)"],"step_count":2} {"level":"info","ts":"2026-10-04T09:50:27.857175Z","caller":"traceutil/trace.go:171","msg":"trace[537313289] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"200.755399ms","start":"2026-10-04T09:50:27.656402Z","end":"2026-10-04T09:50:27.857158Z","steps":["trace[537313289] 'process raft request' (duration: 200.508375ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:50:27.85743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.421726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-04T09:50:27.857472Z","caller":"traceutil/trace.go:171","msg":"trace[1972365431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"122.552658ms","start":"2026-10-04T09:50:27.734907Z","end":"2026-10-04T09:50:27.857459Z","steps":["trace[1972365431] 'agreement among raft nodes before linearized reading' (duration: 122.399556ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:27.857623Z","caller":"traceutil/trace.go:171","msg":"trace[1403307546] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"734.361492ms","start":"2026-10-04T09:50:27.123046Z","end":"2026-10-04T09:50:27.857408Z","steps":["trace[1403307546] 'process raft request' (duration: 129.01442ms)","trace[1403307546] 'compare' (duration: 604.289966ms)"],"step_count":2} {"level":"warn","ts":"2026-10-04T09:50:27.85797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:50:27.123008Z","time spent":"734.81961ms","remote":"127.0.0.1:44062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-04T09:50:28.077283Z","caller":"traceutil/trace.go:171","msg":"trace[1197275146] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"213.577104ms","start":"2026-10-04T09:50:27.863678Z","end":"2026-10-04T09:50:28.077255Z","steps":["trace[1197275146] 'process raft request' (duration: 213.404021ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:28.106457Z","caller":"traceutil/trace.go:171","msg":"trace[1671117241] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"242.582737ms","start":"2026-10-04T09:50:27.863843Z","end":"2026-10-04T09:50:28.106426Z","steps":["trace[1671117241] 'process raft request' (duration: 242.316193ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:28.106579Z","caller":"traceutil/trace.go:171","msg":"trace[1107604039] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"242.17767ms","start":"2026-10-04T09:50:27.864375Z","end":"2026-10-04T09:50:28.106553Z","steps":["trace[1107604039] 'process raft request' (duration: 242.067949ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:28.106593Z","caller":"traceutil/trace.go:171","msg":"trace[453625784] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"242.441445ms","start":"2026-10-04T09:50:27.864042Z","end":"2026-10-04T09:50:28.106483Z","steps":["trace[453625784] 'process raft request' (duration: 242.274432ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:28.106687Z","caller":"traceutil/trace.go:171","msg":"trace[1882654073] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"242.334893ms","start":"2026-10-04T09:50:27.864254Z","end":"2026-10-04T09:50:28.106588Z","steps":["trace[1882654073] 'process raft request' (duration: 242.133401ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:40.302157Z","caller":"traceutil/trace.go:171","msg":"trace[321068129] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"109.250055ms","start":"2026-10-04T09:50:40.192881Z","end":"2026-10-04T09:50:40.302131Z","steps":["trace[321068129] 'process raft request' (duration: 109.113723ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:50:44.845402Z","caller":"traceutil/trace.go:171","msg":"trace[1073544083] linearizableReadLoop","detail":"{readStateIndex:814; appliedIndex:813; }","duration":"442.974945ms","start":"2026-10-04T09:50:44.402385Z","end":"2026-10-04T09:50:44.84536Z","steps":["trace[1073544083] 'read index received' (duration: 442.603889ms)","trace[1073544083] 'applied index is now lower than readState.Index' (duration: 368.776µs)"],"step_count":2} {"level":"info","ts":"2026-10-04T09:50:44.845467Z","caller":"traceutil/trace.go:171","msg":"trace[158327131] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"514.249254ms","start":"2026-10-04T09:50:44.331182Z","end":"2026-10-04T09:50:44.845431Z","steps":["trace[158327131] 'process raft request' (duration: 513.940689ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:50:44.8457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:50:44.331132Z","time spent":"514.420557ms","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-04T09:50:44.845746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.334344ms","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-10-04T09:50:44.8458Z","caller":"traceutil/trace.go:171","msg":"trace[331323181] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:783; }","duration":"430.413145ms","start":"2026-10-04T09:50:44.415369Z","end":"2026-10-04T09:50:44.845782Z","steps":["trace[331323181] 'agreement among raft nodes before linearized reading' (duration: 430.199032ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:50:44.845814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.35187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6cc2q\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-10-04T09:50:44.845917Z","caller":"traceutil/trace.go:171","msg":"trace[1872676593] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6cc2q; range_end:; response_count:1; response_revision:783; }","duration":"443.573123ms","start":"2026-10-04T09:50:44.402317Z","end":"2026-10-04T09:50:44.84589Z","steps":["trace[1872676593] 'agreement among raft nodes before linearized reading' (duration: 443.232948ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:50:44.845962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:50:44.402292Z","time spent":"443.660154ms","remote":"127.0.0.1:44062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6cc2q\" "} {"level":"warn","ts":"2026-10-04T09:50:44.845848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-04T09:50:44.415353Z","time spent":"430.478006ms","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-04T09:52:51.925783Z","caller":"traceutil/trace.go:171","msg":"trace[408810317] linearizableReadLoop","detail":"{readStateIndex:1433; appliedIndex:1432; }","duration":"104.98345ms","start":"2026-10-04T09:52:51.820786Z","end":"2026-10-04T09:52:51.925769Z","steps":["trace[408810317] 'read index received' (duration: 104.892837ms)","trace[408810317] 'applied index is now lower than readState.Index' (duration: 89.693µs)"],"step_count":2} {"level":"info","ts":"2026-10-04T09:52:51.925899Z","caller":"traceutil/trace.go:171","msg":"trace[468990980] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"110.751646ms","start":"2026-10-04T09:52:51.815104Z","end":"2026-10-04T09:52:51.925855Z","steps":["trace[468990980] 'process raft request' (duration: 110.57663ms)"],"step_count":1} {"level":"warn","ts":"2026-10-04T09:52:51.926004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.119595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-10-04T09:52:51.926029Z","caller":"traceutil/trace.go:171","msg":"trace[2087916371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1374; }","duration":"105.253599ms","start":"2026-10-04T09:52:51.820767Z","end":"2026-10-04T09:52:51.926021Z","steps":["trace[2087916371] 'agreement among raft nodes before linearized reading' (duration: 105.058463ms)"],"step_count":1} {"level":"info","ts":"2026-10-04T09:52:52.035056Z","caller":"traceutil/trace.go:171","msg":"trace[1875245052] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"105.683928ms","start":"2026-10-04T09:52:51.929341Z","end":"2026-10-04T09:52:52.035025Z","steps":["trace[1875245052] 'process raft request' (duration: 62.318493ms)","trace[1875245052] 'compare' (duration: 43.19431ms)"],"step_count":2}