{"level":"warn","ts":"2026-07-27T20:05:14.704468Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-27T20:05:14.70455Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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://199.204.45.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-07-27T20:05:14.705043Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-27T20:05:14.70506Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-07-27T20:05:14.705076Z","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-07-27T20:05:14.705702Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-07-27T20:05:14.705793Z","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://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-07-27T20:05:14.7104Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.366981ms"} {"level":"info","ts":"2026-07-27T20:05:14.722533Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-07-27T20:05:14.722605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-07-27T20:05:14.722624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-07-27T20:05:14.722637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-27T20:05:14.722643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-07-27T20:05:14.722693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-07-27T20:05:14.73353Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-27T20:05:14.736689Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-27T20:05:14.738246Z","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-07-27T20:05:14.740936Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-27T20:05:14.741056Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-27T20:05:14.741273Z","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-07-27T20:05:14.741348Z","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-07-27T20:05:14.741362Z","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-07-27T20:05:14.741857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-07-27T20:05:14.74194Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-07-27T20:05:14.743483Z","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-07-27T20:05:14.743715Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-27T20:05:14.743748Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-27T20:05:14.74388Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-07-27T20:05:14.743893Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-07-27T20:05:15.024076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-07-27T20:05:15.024123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-27T20:05:15.024157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-07-27T20:05:15.024209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-07-27T20:05:15.024221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-07-27T20:05:15.024241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-07-27T20:05:15.024285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-07-27T20:05:15.029256Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T20:05:15.029907Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-07-27T20:05:15.030008Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-27T20:05:15.030408Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T20:05:15.03041Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-27T20:05:15.030556Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T20:05:15.030592Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T20:05:15.032293Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-27T20:05:15.032386Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-27T20:05:15.032403Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-27T20:05:15.039715Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-07-27T20:05:16.676919Z","caller":"traceutil/trace.go:171","msg":"trace[221256187] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"186.365216ms","start":"2026-07-27T20:05:16.49052Z","end":"2026-07-27T20:05:16.676885Z","steps":["trace[221256187] 'process raft request' (duration: 186.263174ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:16.677002Z","caller":"traceutil/trace.go:171","msg":"trace[2026134061] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"153.336387ms","start":"2026-07-27T20:05:16.523639Z","end":"2026-07-27T20:05:16.676975Z","steps":["trace[2026134061] 'process raft request' (duration: 153.299956ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:16.677018Z","caller":"traceutil/trace.go:171","msg":"trace[164620018] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"185.399543ms","start":"2026-07-27T20:05:16.491584Z","end":"2026-07-27T20:05:16.676983Z","steps":["trace[164620018] 'process raft request' (duration: 185.2784ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:16.677084Z","caller":"traceutil/trace.go:171","msg":"trace[394515659] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"186.784748ms","start":"2026-07-27T20:05:16.490272Z","end":"2026-07-27T20:05:16.677057Z","steps":["trace[394515659] 'process raft request' (duration: 114.46584ms)","trace[394515659] 'compare' (duration: 71.914818ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:05:16.677149Z","caller":"traceutil/trace.go:171","msg":"trace[1386741592] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"185.744061ms","start":"2026-07-27T20:05:16.491364Z","end":"2026-07-27T20:05:16.677108Z","steps":["trace[1386741592] 'process raft request' (duration: 185.475684ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:16.677142Z","caller":"traceutil/trace.go:171","msg":"trace[1689982932] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"186.52557ms","start":"2026-07-27T20:05:16.490559Z","end":"2026-07-27T20:05:16.677084Z","steps":["trace[1689982932] 'process raft request' (duration: 186.256104ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:16.677234Z","caller":"traceutil/trace.go:171","msg":"trace[2071413621] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"181.946524ms","start":"2026-07-27T20:05:16.495271Z","end":"2026-07-27T20:05:16.677218Z","steps":["trace[2071413621] 'process raft request' (duration: 181.629756ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:16.677277Z","caller":"traceutil/trace.go:171","msg":"trace[517877412] linearizableReadLoop","detail":"{readStateIndex:38; appliedIndex:32; }","duration":"184.89908ms","start":"2026-07-27T20:05:16.492345Z","end":"2026-07-27T20:05:16.677244Z","steps":["trace[517877412] 'read index received' (duration: 383.511µs)","trace[517877412] 'applied index is now lower than readState.Index' (duration: 184.514459ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:05:16.677512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.78819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-07-27T20:05:16.67747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.102846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-27T20:05:16.677565Z","caller":"traceutil/trace.go:171","msg":"trace[57717941] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:37; }","duration":"177.853601ms","start":"2026-07-27T20:05:16.499701Z","end":"2026-07-27T20:05:16.677554Z","steps":["trace[57717941] 'agreement among raft nodes before linearized reading' (duration: 177.758449ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:16.677577Z","caller":"traceutil/trace.go:171","msg":"trace[715986132] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:37; }","duration":"185.24466ms","start":"2026-07-27T20:05:16.492321Z","end":"2026-07-27T20:05:16.677565Z","steps":["trace[715986132] 'agreement among raft nodes before linearized reading' (duration: 185.050385ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:05:19.420201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.649817ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-27T20:05:19.420383Z","caller":"traceutil/trace.go:171","msg":"trace[297239240] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"436.709412ms","start":"2026-07-27T20:05:18.983632Z","end":"2026-07-27T20:05:19.420342Z","steps":["trace[297239240] 'process raft request' (duration: 184.348656ms)","trace[297239240] 'compare' (duration: 251.514073ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:05:19.420551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:05:18.983614Z","time spent":"436.867046ms","remote":"127.0.0.1:33008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-27T20:05:21.908877Z","caller":"traceutil/trace.go:171","msg":"trace[1258149641] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"260.120772ms","start":"2026-07-27T20:05:21.64873Z","end":"2026-07-27T20:05:21.908851Z","steps":["trace[1258149641] 'process raft request' (duration: 259.977039ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:21.912849Z","caller":"traceutil/trace.go:171","msg":"trace[1146322186] linearizableReadLoop","detail":"{readStateIndex:334; appliedIndex:332; }","duration":"218.400682ms","start":"2026-07-27T20:05:21.694426Z","end":"2026-07-27T20:05:21.912827Z","steps":["trace[1146322186] 'read index received' (duration: 214.235576ms)","trace[1146322186] 'applied index is now lower than readState.Index' (duration: 4.163936ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:05:21.912965Z","caller":"traceutil/trace.go:171","msg":"trace[1245777842] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"227.296128ms","start":"2026-07-27T20:05:21.685642Z","end":"2026-07-27T20:05:21.912938Z","steps":["trace[1245777842] 'process raft request' (duration: 227.072812ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:05:21.913251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.802623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-27T20:05:21.913316Z","caller":"traceutil/trace.go:171","msg":"trace[1221683931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:323; }","duration":"218.913966ms","start":"2026-07-27T20:05:21.694389Z","end":"2026-07-27T20:05:21.913303Z","steps":["trace[1221683931] 'agreement among raft nodes before linearized reading' (duration: 218.526065ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:52.789275Z","caller":"traceutil/trace.go:171","msg":"trace[818020282] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"243.404107ms","start":"2026-07-27T20:05:52.545845Z","end":"2026-07-27T20:05:52.789249Z","steps":["trace[818020282] 'read index received' (duration: 241.340655ms)","trace[818020282] 'applied index is now lower than readState.Index' (duration: 2.062542ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:05:52.78948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.609032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-07-27T20:05:52.789514Z","caller":"traceutil/trace.go:171","msg":"trace[1641256176] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:617; }","duration":"243.698235ms","start":"2026-07-27T20:05:52.545803Z","end":"2026-07-27T20:05:52.789502Z","steps":["trace[1641256176] 'agreement among raft nodes before linearized reading' (duration: 243.542771ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:52.789594Z","caller":"traceutil/trace.go:171","msg":"trace[1543610451] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"246.540937ms","start":"2026-07-27T20:05:52.543003Z","end":"2026-07-27T20:05:52.789544Z","steps":["trace[1543610451] 'process raft request' (duration: 244.104875ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:52.820659Z","caller":"traceutil/trace.go:171","msg":"trace[1633688399] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"271.016149ms","start":"2026-07-27T20:05:52.549626Z","end":"2026-07-27T20:05:52.820643Z","steps":["trace[1633688399] 'process raft request' (duration: 270.801594ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:52.821654Z","caller":"traceutil/trace.go:171","msg":"trace[7047810] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"226.507278ms","start":"2026-07-27T20:05:52.595135Z","end":"2026-07-27T20:05:52.821643Z","steps":["trace[7047810] 'process raft request' (duration: 225.917333ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:53.009647Z","caller":"traceutil/trace.go:171","msg":"trace[126161035] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"113.196847ms","start":"2026-07-27T20:05:52.896427Z","end":"2026-07-27T20:05:53.009624Z","steps":["trace[126161035] 'process raft request' (duration: 113.049143ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:53.01006Z","caller":"traceutil/trace.go:171","msg":"trace[1711743] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"112.481479ms","start":"2026-07-27T20:05:52.897546Z","end":"2026-07-27T20:05:53.010027Z","steps":["trace[1711743] 'process raft request' (duration: 112.035838ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:58.670127Z","caller":"traceutil/trace.go:171","msg":"trace[894109186] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"132.740595ms","start":"2026-07-27T20:05:58.537364Z","end":"2026-07-27T20:05:58.670105Z","steps":["trace[894109186] 'process raft request' (duration: 132.60413ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:00.063589Z","caller":"traceutil/trace.go:171","msg":"trace[2003370015] linearizableReadLoop","detail":"{readStateIndex:717; appliedIndex:716; }","duration":"441.855582ms","start":"2026-07-27T20:05:59.621708Z","end":"2026-07-27T20:06:00.063564Z","steps":["trace[2003370015] 'read index received' (duration: 441.601436ms)","trace[2003370015] 'applied index is now lower than readState.Index' (duration: 253.046µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:06:00.063696Z","caller":"traceutil/trace.go:171","msg":"trace[378588421] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"498.970494ms","start":"2026-07-27T20:05:59.564694Z","end":"2026-07-27T20:06:00.063664Z","steps":["trace[378588421] 'process raft request' (duration: 498.720197ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:06:00.063821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.099559ms","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-07-27T20:06:00.063863Z","caller":"traceutil/trace.go:171","msg":"trace[1233568665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:691; }","duration":"442.18787ms","start":"2026-07-27T20:05:59.621664Z","end":"2026-07-27T20:06:00.063852Z","steps":["trace[1233568665] 'agreement among raft nodes before linearized reading' (duration: 442.037167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:06:00.063899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:05:59.621647Z","time spent":"442.244132ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-27T20:06:00.064004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:05:59.564671Z","time spent":"499.097237ms","remote":"127.0.0.1:33084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T20:06:00.064143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.481571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:06:00.064221Z","caller":"traceutil/trace.go:171","msg":"trace[1876137147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:691; }","duration":"212.598954ms","start":"2026-07-27T20:05:59.851603Z","end":"2026-07-27T20:06:00.064202Z","steps":["trace[1876137147] 'agreement among raft nodes before linearized reading' (duration: 212.397609ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:06:00.064579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.643082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-27T20:06:00.064699Z","caller":"traceutil/trace.go:171","msg":"trace[201533073] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:691; }","duration":"277.223507ms","start":"2026-07-27T20:05:59.787453Z","end":"2026-07-27T20:06:00.064676Z","steps":["trace[201533073] 'agreement among raft nodes before linearized reading' (duration: 276.451228ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:07:10.774527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.731956ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-27T20:07:10.774619Z","caller":"traceutil/trace.go:171","msg":"trace[202846965] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"290.872485ms","start":"2026-07-27T20:07:10.483731Z","end":"2026-07-27T20:07:10.774603Z","steps":["trace[202846965] 'process raft request' (duration: 169.973496ms)","trace[202846965] 'compare' (duration: 120.355396ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:07:28.401963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.427298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-27T20:07:28.402106Z","caller":"traceutil/trace.go:171","msg":"trace[1423560184] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:1192; }","duration":"311.635933ms","start":"2026-07-27T20:07:28.090444Z","end":"2026-07-27T20:07:28.40208Z","steps":["trace[1423560184] 'range keys from in-memory index tree' (duration: 311.182492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:07:28.402161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:07:28.090422Z","time spent":"311.727786ms","remote":"127.0.0.1:32938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"info","ts":"2026-07-27T20:07:43.835845Z","caller":"traceutil/trace.go:171","msg":"trace[799123395] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"169.216323ms","start":"2026-07-27T20:07:43.666604Z","end":"2026-07-27T20:07:43.83582Z","steps":["trace[799123395] 'process raft request' (duration: 97.89422ms)","trace[799123395] 'compare' (duration: 71.23223ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:07:44.244299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.805795ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-27T20:07:44.24475Z","caller":"traceutil/trace.go:171","msg":"trace[1366259147] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"227.57039ms","start":"2026-07-27T20:07:44.017161Z","end":"2026-07-27T20:07:44.244731Z","steps":["trace[1366259147] 'process raft request' (duration: 227.244332ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:07:44.895256Z","caller":"traceutil/trace.go:171","msg":"trace[1025462581] linearizableReadLoop","detail":"{readStateIndex:1321; appliedIndex:1320; }","duration":"213.966678ms","start":"2026-07-27T20:07:44.681271Z","end":"2026-07-27T20:07:44.895238Z","steps":["trace[1025462581] 'read index received' (duration: 213.899956ms)","trace[1025462581] 'applied index is now lower than readState.Index' (duration: 66.072µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:07:44.895288Z","caller":"traceutil/trace.go:171","msg":"trace[118970954] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"235.255913ms","start":"2026-07-27T20:07:44.660004Z","end":"2026-07-27T20:07:44.89526Z","steps":["trace[118970954] 'process raft request' (duration: 235.12766ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:07:44.89545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.159102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-27T20:07:44.895481Z","caller":"traceutil/trace.go:171","msg":"trace[615596285] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1268; }","duration":"214.236876ms","start":"2026-07-27T20:07:44.681238Z","end":"2026-07-27T20:07:44.895475Z","steps":["trace[615596285] 'agreement among raft nodes before linearized reading' (duration: 214.096731ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:07:44.895647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.556223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-27T20:07:44.895745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.547314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-27T20:07:44.895778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.45923ms","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-07-27T20:07:44.895796Z","caller":"traceutil/trace.go:171","msg":"trace[457327801] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1268; }","duration":"206.517001ms","start":"2026-07-27T20:07:44.689274Z","end":"2026-07-27T20:07:44.895791Z","steps":["trace[457327801] 'agreement among raft nodes before linearized reading' (duration: 206.46818ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:07:44.895793Z","caller":"traceutil/trace.go:171","msg":"trace[1808314255] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1268; }","duration":"144.632126ms","start":"2026-07-27T20:07:44.75115Z","end":"2026-07-27T20:07:44.895782Z","steps":["trace[1808314255] 'agreement among raft nodes before linearized reading' (duration: 144.543944ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:07:44.895756Z","caller":"traceutil/trace.go:171","msg":"trace[225976821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1268; }","duration":"210.679346ms","start":"2026-07-27T20:07:44.685055Z","end":"2026-07-27T20:07:44.895734Z","steps":["trace[225976821] 'agreement among raft nodes before linearized reading' (duration: 210.368537ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:07:45.126728Z","caller":"traceutil/trace.go:171","msg":"trace[1252867006] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"228.356989ms","start":"2026-07-27T20:07:44.898339Z","end":"2026-07-27T20:07:45.126696Z","steps":["trace[1252867006] 'process raft request' (duration: 214.203053ms)","trace[1252867006] 'compare' (duration: 14.031103ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:07:45.135603Z","caller":"traceutil/trace.go:171","msg":"trace[889754825] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"233.181741ms","start":"2026-07-27T20:07:44.902401Z","end":"2026-07-27T20:07:45.135583Z","steps":["trace[889754825] 'process raft request' (duration: 233.11646ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:07:45.13568Z","caller":"traceutil/trace.go:171","msg":"trace[1853251955] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"235.847108ms","start":"2026-07-27T20:07:44.899814Z","end":"2026-07-27T20:07:45.135661Z","steps":["trace[1853251955] 'process raft request' (duration: 235.667834ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:07:45.135706Z","caller":"traceutil/trace.go:171","msg":"trace[24865604] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"236.252038ms","start":"2026-07-27T20:07:44.899407Z","end":"2026-07-27T20:07:45.135659Z","steps":["trace[24865604] 'process raft request' (duration: 235.94303ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:07:45.135789Z","caller":"traceutil/trace.go:171","msg":"trace[1915302751] linearizableReadLoop","detail":"{readStateIndex:1326; appliedIndex:1321; }","duration":"158.34225ms","start":"2026-07-27T20:07:44.977427Z","end":"2026-07-27T20:07:45.135769Z","steps":["trace[1915302751] 'read index received' (duration: 135.158587ms)","trace[1915302751] 'applied index is now lower than readState.Index' (duration: 23.182603ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:07:45.135986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.548955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-27T20:07:45.136081Z","caller":"traceutil/trace.go:171","msg":"trace[608520631] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1273; }","duration":"158.645397ms","start":"2026-07-27T20:07:44.977414Z","end":"2026-07-27T20:07:45.136059Z","steps":["trace[608520631] 'agreement among raft nodes before linearized reading' (duration: 158.417651ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:07:45.135992Z","caller":"traceutil/trace.go:171","msg":"trace[994338842] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"231.916909ms","start":"2026-07-27T20:07:44.904063Z","end":"2026-07-27T20:07:45.13598Z","steps":["trace[994338842] 'process raft request' (duration: 231.486188ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:07:57.04037Z","caller":"traceutil/trace.go:171","msg":"trace[1453597276] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"106.897737ms","start":"2026-07-27T20:07:56.933448Z","end":"2026-07-27T20:07:57.040345Z","steps":["trace[1453597276] 'process raft request' (duration: 106.745373ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:07:57.501286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.543629ms","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-07-27T20:07:57.501384Z","caller":"traceutil/trace.go:171","msg":"trace[126995321] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1355; }","duration":"157.696183ms","start":"2026-07-27T20:07:57.343664Z","end":"2026-07-27T20:07:57.50136Z","steps":["trace[126995321] 'range keys from in-memory index tree' (duration: 157.356865ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:07:57.501577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.209086ms","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-07-27T20:07:57.501612Z","caller":"traceutil/trace.go:171","msg":"trace[781949467] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1355; }","duration":"310.278428ms","start":"2026-07-27T20:07:57.191324Z","end":"2026-07-27T20:07:57.501603Z","steps":["trace[781949467] 'range keys from in-memory index tree' (duration: 310.065033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:07:57.501644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:07:57.191267Z","time spent":"310.366211ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-27T20:07:57.501918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.877643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-27T20:07:57.50199Z","caller":"traceutil/trace.go:171","msg":"trace[1657130717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1355; }","duration":"266.030157ms","start":"2026-07-27T20:07:57.23594Z","end":"2026-07-27T20:07:57.50197Z","steps":["trace[1657130717] 'range keys from in-memory index tree' (duration: 265.706349ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:07:57.502028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.90469ms","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-07-27T20:07:57.502099Z","caller":"traceutil/trace.go:171","msg":"trace[520346520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1355; }","duration":"306.000122ms","start":"2026-07-27T20:07:57.196081Z","end":"2026-07-27T20:07:57.502082Z","steps":["trace[520346520] 'range keys from in-memory index tree' (duration: 305.810568ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:07:57.502132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:07:57.196072Z","time spent":"306.052674ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-27T20:07:57.502715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.29093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-27T20:07:57.503101Z","caller":"traceutil/trace.go:171","msg":"trace[1301587883] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1355; }","duration":"310.70774ms","start":"2026-07-27T20:07:57.192348Z","end":"2026-07-27T20:07:57.503055Z","steps":["trace[1301587883] 'range keys from in-memory index tree' (duration: 310.071744ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:07:57.503287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:07:57.192326Z","time spent":"310.943635ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}