{"level":"warn","ts":"2026-09-12T03:57:26.416231Z","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-12T03:57:26.416324Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.95: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.95:2380","--initial-cluster=instance=https://162.253.55.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.95: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-12T03:57:26.417833Z","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-12T03:57:26.417856Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.95:2380"]} {"level":"info","ts":"2026-09-12T03:57:26.417879Z","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-12T03:57:26.418673Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.95:2379"]} {"level":"info","ts":"2026-09-12T03:57:26.418779Z","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.95:2380"],"listen-peer-urls":["https://162.253.55.95:2380"],"advertise-client-urls":["https://162.253.55.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.95: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-12T03:57:26.425346Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.259361ms"} {"level":"info","ts":"2026-09-12T03:57:26.439534Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"282167b6747c9cda","cluster-id":"dc65cfc6e389e361"} {"level":"info","ts":"2026-09-12T03:57:26.439601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda switched to configuration voters=()"} {"level":"info","ts":"2026-09-12T03:57:26.439621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda became follower at term 0"} {"level":"info","ts":"2026-09-12T03:57:26.439632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 282167b6747c9cda [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-12T03:57:26.439643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda became follower at term 1"} {"level":"info","ts":"2026-09-12T03:57:26.439676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda switched to configuration voters=(2891706469084601562)"} {"level":"warn","ts":"2026-09-12T03:57:26.450151Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-12T03:57:26.45134Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-12T03:57:26.452962Z","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-12T03:57:26.455059Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"282167b6747c9cda","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-12T03:57:26.455463Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"282167b6747c9cda","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-12T03:57:26.455458Z","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-12T03:57:26.457129Z","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-12T03:57:26.457224Z","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-12T03:57:26.460055Z","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-12T03:57:26.460183Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.95:2380"} {"level":"info","ts":"2026-09-12T03:57:26.460197Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.95:2380"} {"level":"info","ts":"2026-09-12T03:57:26.460783Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"282167b6747c9cda","initial-advertise-peer-urls":["https://162.253.55.95:2380"],"listen-peer-urls":["https://162.253.55.95:2380"],"advertise-client-urls":["https://162.253.55.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-12T03:57:26.460817Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-12T03:57:26.462421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda switched to configuration voters=(2891706469084601562)"} {"level":"info","ts":"2026-09-12T03:57:26.462599Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dc65cfc6e389e361","local-member-id":"282167b6747c9cda","added-peer-id":"282167b6747c9cda","added-peer-peer-urls":["https://162.253.55.95:2380"]} {"level":"info","ts":"2026-09-12T03:57:26.841488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda is starting a new election at term 1"} {"level":"info","ts":"2026-09-12T03:57:26.841543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda became pre-candidate at term 1"} {"level":"info","ts":"2026-09-12T03:57:26.841577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda received MsgPreVoteResp from 282167b6747c9cda at term 1"} {"level":"info","ts":"2026-09-12T03:57:26.841588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda became candidate at term 2"} {"level":"info","ts":"2026-09-12T03:57:26.841593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda received MsgVoteResp from 282167b6747c9cda at term 2"} {"level":"info","ts":"2026-09-12T03:57:26.841605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"282167b6747c9cda became leader at term 2"} {"level":"info","ts":"2026-09-12T03:57:26.841612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 282167b6747c9cda elected leader 282167b6747c9cda at term 2"} {"level":"info","ts":"2026-09-12T03:57:26.842344Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"282167b6747c9cda","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.95:2379]}","request-path":"/0/members/282167b6747c9cda/attributes","cluster-id":"dc65cfc6e389e361","publish-timeout":"7s"} {"level":"info","ts":"2026-09-12T03:57:26.842371Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T03:57:26.842467Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T03:57:26.842717Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-12T03:57:26.842789Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-12T03:57:26.844281Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-12T03:57:26.845071Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.95:2379"} {"level":"info","ts":"2026-09-12T03:57:26.845263Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T03:57:26.847034Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dc65cfc6e389e361","local-member-id":"282167b6747c9cda","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T03:57:26.847286Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T03:57:26.847438Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T03:57:30.666022Z","caller":"traceutil/trace.go:171","msg":"trace[952906274] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"164.021875ms","start":"2026-09-12T03:57:30.501973Z","end":"2026-09-12T03:57:30.665995Z","steps":["trace[952906274] 'process raft request' (duration: 158.582997ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:57:32.296624Z","caller":"traceutil/trace.go:171","msg":"trace[26013871] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"100.429749ms","start":"2026-09-12T03:57:32.196178Z","end":"2026-09-12T03:57:32.296607Z","steps":["trace[26013871] 'process raft request' (duration: 92.249909ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:57:32.29671Z","caller":"traceutil/trace.go:171","msg":"trace[1877338298] linearizableReadLoop","detail":"{readStateIndex:243; appliedIndex:242; }","duration":"100.217433ms","start":"2026-09-12T03:57:32.196486Z","end":"2026-09-12T03:57:32.296703Z","steps":["trace[1877338298] 'read index received' (duration: 91.900839ms)","trace[1877338298] 'applied index is now lower than readState.Index' (duration: 8.316164ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:57:32.296837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.318086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T03:57:32.296881Z","caller":"traceutil/trace.go:171","msg":"trace[2042050353] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:238; }","duration":"100.412969ms","start":"2026-09-12T03:57:32.196459Z","end":"2026-09-12T03:57:32.296872Z","steps":["trace[2042050353] 'agreement among raft nodes before linearized reading' (duration: 100.314096ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:57:36.074702Z","caller":"traceutil/trace.go:171","msg":"trace[682907704] linearizableReadLoop","detail":"{readStateIndex:307; appliedIndex:306; }","duration":"119.785239ms","start":"2026-09-12T03:57:35.954896Z","end":"2026-09-12T03:57:36.074681Z","steps":["trace[682907704] 'read index received' (duration: 119.731927ms)","trace[682907704] 'applied index is now lower than readState.Index' (duration: 52.332µs)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:57:36.074822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.918934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-12T03:57:36.074801Z","caller":"traceutil/trace.go:171","msg":"trace[386795220] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"195.943692ms","start":"2026-09-12T03:57:35.878822Z","end":"2026-09-12T03:57:36.074766Z","steps":["trace[386795220] 'process raft request' (duration: 195.758976ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:57:36.075135Z","caller":"traceutil/trace.go:171","msg":"trace[1991729820] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:295; }","duration":"119.996616ms","start":"2026-09-12T03:57:35.954839Z","end":"2026-09-12T03:57:36.074836Z","steps":["trace[1991729820] 'agreement among raft nodes before linearized reading' (duration: 119.919233ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:57:36.492591Z","caller":"traceutil/trace.go:171","msg":"trace[1812093281] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:307; }","duration":"411.459873ms","start":"2026-09-12T03:57:36.081106Z","end":"2026-09-12T03:57:36.492566Z","steps":["trace[1812093281] 'read index received' (duration: 411.037729ms)","trace[1812093281] 'applied index is now lower than readState.Index' (duration: 420.814µs)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:57:36.492791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.661299ms","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-12T03:57:36.492882Z","caller":"traceutil/trace.go:171","msg":"trace[32452996] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:296; }","duration":"411.794644ms","start":"2026-09-12T03:57:36.081057Z","end":"2026-09-12T03:57:36.492851Z","steps":["trace[32452996] 'agreement among raft nodes before linearized reading' (duration: 411.606818ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:57:36.492931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:57:36.081038Z","time spent":"411.883967ms","remote":"127.0.0.1:37610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-09-12T03:57:36.492886Z","caller":"traceutil/trace.go:171","msg":"trace[1670164704] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"413.405498ms","start":"2026-09-12T03:57:36.079252Z","end":"2026-09-12T03:57:36.492658Z","steps":["trace[1670164704] 'process raft request' (duration: 412.810268ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:57:36.493818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.216334ms","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-09-12T03:57:36.493917Z","caller":"traceutil/trace.go:171","msg":"trace[120730402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:296; }","duration":"352.337488ms","start":"2026-09-12T03:57:36.141546Z","end":"2026-09-12T03:57:36.493883Z","steps":["trace[120730402] 'agreement among raft nodes before linearized reading' (duration: 351.222871ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:57:36.493962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:57:36.14153Z","time spent":"352.418772ms","remote":"127.0.0.1:37796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-12T03:57:36.494379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:57:36.079237Z","time spent":"413.836202ms","remote":"127.0.0.1:37796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T03:57:36.666711Z","caller":"traceutil/trace.go:171","msg":"trace[1346609457] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"169.440328ms","start":"2026-09-12T03:57:36.49725Z","end":"2026-09-12T03:57:36.66669Z","steps":["trace[1346609457] 'process raft request' (duration: 169.295133ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:57:36.666965Z","caller":"traceutil/trace.go:171","msg":"trace[1197687678] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"169.550932ms","start":"2026-09-12T03:57:36.497403Z","end":"2026-09-12T03:57:36.666954Z","steps":["trace[1197687678] 'process raft request' (duration: 169.252131ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:58:09.2216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.623701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-12T03:58:09.221717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.639645ms","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-12T03:58:09.221763Z","caller":"traceutil/trace.go:171","msg":"trace[1756551435] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:497; }","duration":"242.782229ms","start":"2026-09-12T03:58:08.978899Z","end":"2026-09-12T03:58:09.221681Z","steps":["trace[1756551435] 'range keys from in-memory index tree' (duration: 242.516177ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:58:09.22186Z","caller":"traceutil/trace.go:171","msg":"trace[1031460773] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:497; }","duration":"196.805563ms","start":"2026-09-12T03:58:09.025003Z","end":"2026-09-12T03:58:09.221808Z","steps":["trace[1031460773] 'range keys from in-memory index tree' (duration: 196.484679ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:58:09.744947Z","caller":"traceutil/trace.go:171","msg":"trace[1639318911] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"121.445305ms","start":"2026-09-12T03:58:09.623476Z","end":"2026-09-12T03:58:09.744921Z","steps":["trace[1639318911] 'process raft request' (duration: 121.307989ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:58:09.752733Z","caller":"traceutil/trace.go:171","msg":"trace[2136980600] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"122.045823ms","start":"2026-09-12T03:58:09.630669Z","end":"2026-09-12T03:58:09.752715Z","steps":["trace[2136980600] 'process raft request' (duration: 120.976045ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:58:09.752902Z","caller":"traceutil/trace.go:171","msg":"trace[1248013136] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"103.688939ms","start":"2026-09-12T03:58:09.649194Z","end":"2026-09-12T03:58:09.752882Z","steps":["trace[1248013136] 'process raft request' (duration: 102.900643ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:58:09.753113Z","caller":"traceutil/trace.go:171","msg":"trace[1821091111] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"120.722492ms","start":"2026-09-12T03:58:09.632384Z","end":"2026-09-12T03:58:09.753106Z","steps":["trace[1821091111] 'process raft request' (duration: 119.33394ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:58:09.753179Z","caller":"traceutil/trace.go:171","msg":"trace[333015551] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"106.518196ms","start":"2026-09-12T03:58:09.646654Z","end":"2026-09-12T03:58:09.753172Z","steps":["trace[333015551] 'process raft request' (duration: 105.160645ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:58:09.753238Z","caller":"traceutil/trace.go:171","msg":"trace[726885280] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"105.249949ms","start":"2026-09-12T03:58:09.647982Z","end":"2026-09-12T03:58:09.753231Z","steps":["trace[726885280] 'process raft request' (duration: 103.971541ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:58:09.75329Z","caller":"traceutil/trace.go:171","msg":"trace[1977798920] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"105.239198ms","start":"2026-09-12T03:58:09.648046Z","end":"2026-09-12T03:58:09.753286Z","steps":["trace[1977798920] 'process raft request' (duration: 104.009933ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:58:15.696115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.627547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fb6fn\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-12T03:58:15.696243Z","caller":"traceutil/trace.go:171","msg":"trace[1818397853] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fb6fn; range_end:; response_count:1; response_revision:605; }","duration":"286.816946ms","start":"2026-09-12T03:58:15.409387Z","end":"2026-09-12T03:58:15.696204Z","steps":["trace[1818397853] 'range keys from in-memory index tree' (duration: 286.306152ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:58:15.728031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.296499ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-12T03:58:15.728274Z","caller":"traceutil/trace.go:171","msg":"trace[566526293] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"117.883671ms","start":"2026-09-12T03:58:15.610314Z","end":"2026-09-12T03:58:15.728198Z","steps":["trace[566526293] 'read index received' (duration: 64.013µs)","trace[566526293] 'applied index is now lower than readState.Index' (duration: 117.817948ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:58:15.728442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.09968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T03:58:15.728534Z","caller":"traceutil/trace.go:171","msg":"trace[690285179] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"118.259388ms","start":"2026-09-12T03:58:15.610256Z","end":"2026-09-12T03:58:15.728515Z","steps":["trace[690285179] 'agreement among raft nodes before linearized reading' (duration: 118.090121ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:58:16.360492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.87965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T03:58:16.360777Z","caller":"traceutil/trace.go:171","msg":"trace[498722276] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"565.46609ms","start":"2026-09-12T03:58:15.795291Z","end":"2026-09-12T03:58:16.360757Z","steps":["trace[498722276] 'process raft request' (duration: 565.371325ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:58:16.360742Z","caller":"traceutil/trace.go:171","msg":"trace[267495903] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"635.19692ms","start":"2026-09-12T03:58:15.725484Z","end":"2026-09-12T03:58:16.360681Z","steps":["trace[267495903] 'process raft request' (duration: 400.946964ms)","trace[267495903] 'compare' (duration: 233.666279ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:58:16.360858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:58:15.795257Z","time spent":"565.568835ms","remote":"127.0.0.1:38020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T03:58:16.3609Z","caller":"traceutil/trace.go:171","msg":"trace[220807370] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:628; }","duration":"630.382167ms","start":"2026-09-12T03:58:15.730472Z","end":"2026-09-12T03:58:16.360854Z","steps":["trace[220807370] 'read index received' (duration: 9.91496ms)","trace[220807370] 'applied index is now lower than readState.Index' (duration: 620.462967ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:58:16.361069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:58:15.725454Z","time spent":"635.397749ms","remote":"127.0.0.1:37698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T03:58:16.361266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.758334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T03:58:16.361321Z","caller":"traceutil/trace.go:171","msg":"trace[1995558681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"630.87809ms","start":"2026-09-12T03:58:15.730426Z","end":"2026-09-12T03:58:16.361304Z","steps":["trace[1995558681] 'agreement among raft nodes before linearized reading' (duration: 630.624008ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:58:16.361393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:58:15.730402Z","time spent":"630.978644ms","remote":"127.0.0.1:37472","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-12T03:58:17.714808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.395401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T03:58:17.714903Z","caller":"traceutil/trace.go:171","msg":"trace[708039522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"105.559969ms","start":"2026-09-12T03:58:17.609322Z","end":"2026-09-12T03:58:17.714882Z","steps":["trace[708039522] 'range keys from in-memory index tree' (duration: 105.230024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:58:31.899432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.509443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T03:58:31.899567Z","caller":"traceutil/trace.go:171","msg":"trace[124292409] linearizableReadLoop","detail":"{readStateIndex:799; appliedIndex:798; }","duration":"291.961354ms","start":"2026-09-12T03:58:31.607585Z","end":"2026-09-12T03:58:31.899547Z","steps":["trace[124292409] 'read index received' (duration: 159.178788ms)","trace[124292409] 'applied index is now lower than readState.Index' (duration: 132.781296ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:58:31.89965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.061648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T03:58:31.899681Z","caller":"traceutil/trace.go:171","msg":"trace[1858510132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:772; }","duration":"292.115881ms","start":"2026-09-12T03:58:31.607555Z","end":"2026-09-12T03:58:31.899671Z","steps":["trace[1858510132] 'agreement among raft nodes before linearized reading' (duration: 292.050017ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:58:31.899881Z","caller":"traceutil/trace.go:171","msg":"trace[1107747861] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"368.99544ms","start":"2026-09-12T03:58:31.530861Z","end":"2026-09-12T03:58:31.899857Z","steps":["trace[1107747861] 'process raft request' (duration: 235.988613ms)","trace[1107747861] 'compare' (duration: 132.389687ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:58:31.900009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:58:31.530842Z","time spent":"369.097385ms","remote":"127.0.0.1:37698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}