{"level":"warn","ts":"2026-06-22T01:52:44.818425Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T01:52:44.818525Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132: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.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132: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-06-22T01:52:44.818598Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T01:52:44.818614Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-06-22T01:52:44.818633Z","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-06-22T01:52:44.819295Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]} {"level":"info","ts":"2026-06-22T01:52:44.81937Z","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.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132: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-06-22T01:52:44.824699Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.097877ms"} {"level":"info","ts":"2026-06-22T01:52:44.833112Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"} {"level":"info","ts":"2026-06-22T01:52:44.833291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"} {"level":"info","ts":"2026-06-22T01:52:44.833342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"} {"level":"info","ts":"2026-06-22T01:52:44.833371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-22T01:52:44.833395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"} {"level":"info","ts":"2026-06-22T01:52:44.833462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"warn","ts":"2026-06-22T01:52:44.841912Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-22T01:52:44.843393Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-22T01:52:44.845267Z","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-06-22T01:52:44.849617Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-22T01:52:44.849852Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-22T01:52:44.850221Z","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-06-22T01:52:44.850327Z","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-06-22T01:52:44.850355Z","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-06-22T01:52:44.854535Z","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-06-22T01:52:44.854817Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-06-22T01:52:44.854847Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-06-22T01:52:44.855716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"info","ts":"2026-06-22T01:52:44.85579Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-22T01:52:44.855848Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-22T01:52:44.855893Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-06-22T01:52:44.934493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"} {"level":"info","ts":"2026-06-22T01:52:44.934566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-22T01:52:44.934613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"} {"level":"info","ts":"2026-06-22T01:52:44.934634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"} {"level":"info","ts":"2026-06-22T01:52:44.934642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-06-22T01:52:44.934653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"} {"level":"info","ts":"2026-06-22T01:52:44.934664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-06-22T01:52:44.935539Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"} {"level":"info","ts":"2026-06-22T01:52:44.935574Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T01:52:44.935622Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T01:52:44.93602Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:52:44.936563Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-22T01:52:44.936664Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-22T01:52:44.938243Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-22T01:52:44.938886Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:52:44.939134Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:52:44.939302Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:52:44.939707Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"} {"level":"info","ts":"2026-06-22T01:53:28.634319Z","caller":"traceutil/trace.go:171","msg":"trace[1589649264] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"214.932559ms","start":"2026-06-22T01:53:28.419344Z","end":"2026-06-22T01:53:28.634277Z","steps":["trace[1589649264] 'process raft request' (duration: 213.246163ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:30.268553Z","caller":"traceutil/trace.go:171","msg":"trace[1724883623] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"540.625858ms","start":"2026-06-22T01:53:29.727896Z","end":"2026-06-22T01:53:30.268522Z","steps":["trace[1724883623] 'process raft request' (duration: 535.462997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:53:30.269077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:53:29.727879Z","time spent":"540.768022ms","remote":"127.0.0.1:41892","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-06-22T01:53:35.956968Z","caller":"traceutil/trace.go:171","msg":"trace[646317349] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"101.592699ms","start":"2026-06-22T01:53:35.855335Z","end":"2026-06-22T01:53:35.956928Z","steps":["trace[646317349] 'process raft request' (duration: 101.357332ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:44.828621Z","caller":"traceutil/trace.go:171","msg":"trace[1129178534] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"318.975933ms","start":"2026-06-22T01:53:44.509611Z","end":"2026-06-22T01:53:44.828587Z","steps":["trace[1129178534] 'process raft request' (duration: 318.644094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:53:44.82899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:53:44.509588Z","time spent":"319.119057ms","remote":"127.0.0.1:41550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T01:54:19.922395Z","caller":"traceutil/trace.go:171","msg":"trace[70572033] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"107.094604ms","start":"2026-06-22T01:54:19.815269Z","end":"2026-06-22T01:54:19.922363Z","steps":["trace[70572033] 'process raft request' (duration: 106.865257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:20.196594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.644427ms","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-06-22T01:54:20.196746Z","caller":"traceutil/trace.go:171","msg":"trace[292015114] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:975; }","duration":"128.858413ms","start":"2026-06-22T01:54:20.067866Z","end":"2026-06-22T01:54:20.196725Z","steps":["trace[292015114] 'range keys from in-memory index tree' (duration: 128.340829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:45.909341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.013204ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T01:54:45.909446Z","caller":"traceutil/trace.go:171","msg":"trace[1989204239] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1100; }","duration":"175.550588ms","start":"2026-06-22T01:54:45.733879Z","end":"2026-06-22T01:54:45.90943Z","steps":["trace[1989204239] 'read index received' (duration: 59.136403ms)","trace[1989204239] 'applied index is now lower than readState.Index' (duration: 116.412745ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:54:45.909567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.867464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:54:45.909524Z","caller":"traceutil/trace.go:171","msg":"trace[781310676] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"272.907169ms","start":"2026-06-22T01:54:45.636551Z","end":"2026-06-22T01:54:45.909458Z","steps":["trace[781310676] 'process raft request' (duration: 156.539565ms)","trace[781310676] 'compare' (duration: 115.854549ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:54:45.909606Z","caller":"traceutil/trace.go:171","msg":"trace[972523652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1057; }","duration":"118.962166ms","start":"2026-06-22T01:54:45.790635Z","end":"2026-06-22T01:54:45.909597Z","steps":["trace[972523652] 'agreement among raft nodes before linearized reading' (duration: 118.900314ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:45.909656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.786219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-22T01:54:45.909668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.771905ms","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-06-22T01:54:45.909732Z","caller":"traceutil/trace.go:171","msg":"trace[1515775064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1057; }","duration":"168.902582ms","start":"2026-06-22T01:54:45.740813Z","end":"2026-06-22T01:54:45.909716Z","steps":["trace[1515775064] 'agreement among raft nodes before linearized reading' (duration: 168.720007ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:45.909752Z","caller":"traceutil/trace.go:171","msg":"trace[1832220962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1057; }","duration":"175.910028ms","start":"2026-06-22T01:54:45.733825Z","end":"2026-06-22T01:54:45.909735Z","steps":["trace[1832220962] 'agreement among raft nodes before linearized reading' (duration: 175.671162ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:46.480519Z","caller":"traceutil/trace.go:171","msg":"trace[255771601] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"113.694888ms","start":"2026-06-22T01:54:46.366797Z","end":"2026-06-22T01:54:46.480492Z","steps":["trace[255771601] 'process raft request' (duration: 113.534344ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:47.761274Z","caller":"traceutil/trace.go:171","msg":"trace[89062834] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"119.82821ms","start":"2026-06-22T01:54:47.64142Z","end":"2026-06-22T01:54:47.761249Z","steps":["trace[89062834] 'process raft request' (duration: 119.681386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:48.518375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.843613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-22T01:54:48.5184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.916859ms","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-06-22T01:54:48.518464Z","caller":"traceutil/trace.go:171","msg":"trace[1994444931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1062; }","duration":"588.963986ms","start":"2026-06-22T01:54:47.92948Z","end":"2026-06-22T01:54:48.518444Z","steps":["trace[1994444931] 'range keys from in-memory index tree' (duration: 588.691179ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:48.518468Z","caller":"traceutil/trace.go:171","msg":"trace[289436789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1062; }","duration":"572.024612ms","start":"2026-06-22T01:54:47.946427Z","end":"2026-06-22T01:54:48.518451Z","steps":["trace[289436789] 'range keys from in-memory index tree' (duration: 571.705534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:48.518504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:54:47.929468Z","time spent":"589.027568ms","remote":"127.0.0.1:41646","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-06-22T01:54:48.51852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:54:47.946407Z","time spent":"572.104665ms","remote":"127.0.0.1:41646","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":"warn","ts":"2026-06-22T01:54:48.518499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.897282ms","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-06-22T01:54:48.518595Z","caller":"traceutil/trace.go:171","msg":"trace[228800220] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1062; }","duration":"605.052796ms","start":"2026-06-22T01:54:47.91352Z","end":"2026-06-22T01:54:48.518573Z","steps":["trace[228800220] 'range keys from in-memory index tree' (duration: 604.689906ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:48.518641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:54:47.913496Z","time spent":"605.135928ms","remote":"127.0.0.1:41646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-22T01:54:48.518434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.144616ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T01:54:48.518938Z","caller":"traceutil/trace.go:171","msg":"trace[1583932632] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"466.007298ms","start":"2026-06-22T01:54:48.052879Z","end":"2026-06-22T01:54:48.518886Z","steps":["trace[1583932632] 'process raft request' (duration: 339.340557ms)","trace[1583932632] 'compare' (duration: 125.871849ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:54:48.519091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:54:48.052857Z","time spent":"466.116692ms","remote":"127.0.0.1:41646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T01:54:48.806564Z","caller":"traceutil/trace.go:171","msg":"trace[653342017] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"282.269691ms","start":"2026-06-22T01:54:48.524273Z","end":"2026-06-22T01:54:48.806543Z","steps":["trace[653342017] 'process raft request' (duration: 282.196209ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:48.806625Z","caller":"traceutil/trace.go:171","msg":"trace[1891033224] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"282.683623ms","start":"2026-06-22T01:54:48.52391Z","end":"2026-06-22T01:54:48.806593Z","steps":["trace[1891033224] 'process raft request' (duration: 282.404635ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:54:48.80674Z","caller":"traceutil/trace.go:171","msg":"trace[1093886401] linearizableReadLoop","detail":"{readStateIndex:1111; appliedIndex:1108; }","duration":"107.940918ms","start":"2026-06-22T01:54:48.698771Z","end":"2026-06-22T01:54:48.806712Z","steps":["trace[1093886401] 'read index received' (duration: 107.519406ms)","trace[1093886401] 'applied index is now lower than readState.Index' (duration: 419.492µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:54:48.80684Z","caller":"traceutil/trace.go:171","msg":"trace[1182032857] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"282.314802ms","start":"2026-06-22T01:54:48.524513Z","end":"2026-06-22T01:54:48.806828Z","steps":["trace[1182032857] 'process raft request' (duration: 281.995153ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:54:48.806968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.194155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-22T01:54:48.807032Z","caller":"traceutil/trace.go:171","msg":"trace[1740094431] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:1; response_revision:1067; }","duration":"108.300938ms","start":"2026-06-22T01:54:48.698718Z","end":"2026-06-22T01:54:48.807019Z","steps":["trace[1740094431] 'agreement among raft nodes before linearized reading' (duration: 108.107402ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:03.9851Z","caller":"traceutil/trace.go:171","msg":"trace[221945855] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"114.857411ms","start":"2026-06-22T01:55:03.870217Z","end":"2026-06-22T01:55:03.985074Z","steps":["trace[221945855] 'process raft request' (duration: 114.726557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:21.31866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.375384ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T01:55:21.318854Z","caller":"traceutil/trace.go:171","msg":"trace[350869129] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"217.965955ms","start":"2026-06-22T01:55:21.100869Z","end":"2026-06-22T01:55:21.318835Z","steps":["trace[350869129] 'process raft request' (duration: 217.914324ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:21.318902Z","caller":"traceutil/trace.go:171","msg":"trace[1375732300] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"218.102229ms","start":"2026-06-22T01:55:21.100761Z","end":"2026-06-22T01:55:21.318863Z","steps":["trace[1375732300] 'process raft request' (duration: 69.409717ms)","trace[1375732300] 'compare' (duration: 148.216559ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:55:22.503132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.195389ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-22T01:55:22.503292Z","caller":"traceutil/trace.go:171","msg":"trace[676193718] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"429.004822ms","start":"2026-06-22T01:55:22.074274Z","end":"2026-06-22T01:55:22.503278Z","steps":["trace[676193718] 'process raft request' (duration: 428.939751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:22.503332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:22.074259Z","time spent":"429.056933ms","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:55:22.50349Z","caller":"traceutil/trace.go:171","msg":"trace[751894131] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"442.353506ms","start":"2026-06-22T01:55:22.061115Z","end":"2026-06-22T01:55:22.503469Z","steps":["trace[751894131] 'process raft request' (duration: 190.769706ms)","trace[751894131] 'compare' (duration: 250.86932ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:55:22.503528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:22.061101Z","time spent":"442.409267ms","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:55:22.503614Z","caller":"traceutil/trace.go:171","msg":"trace[1530199631] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1301; }","duration":"431.301104ms","start":"2026-06-22T01:55:22.072303Z","end":"2026-06-22T01:55:22.503604Z","steps":["trace[1530199631] 'read index received' (duration: 179.593592ms)","trace[1530199631] 'applied index is now lower than readState.Index' (duration: 251.706782ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:55:22.503806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.49709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-06-22T01:55:22.503858Z","caller":"traceutil/trace.go:171","msg":"trace[1776853146] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1250; }","duration":"431.588303ms","start":"2026-06-22T01:55:22.072263Z","end":"2026-06-22T01:55:22.503851Z","steps":["trace[1776853146] 'agreement among raft nodes before linearized reading' (duration: 431.442209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:22.503878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:22.072245Z","time spent":"431.627564ms","remote":"127.0.0.1:41646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-22T01:55:22.504013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.356533ms","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-06-22T01:55:22.504034Z","caller":"traceutil/trace.go:171","msg":"trace[469085503] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1250; }","duration":"425.400225ms","start":"2026-06-22T01:55:22.078629Z","end":"2026-06-22T01:55:22.504029Z","steps":["trace[469085503] 'agreement among raft nodes before linearized reading' (duration: 425.343483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:22.50405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:22.078619Z","time spent":"425.427495ms","remote":"127.0.0.1:41646","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\" "} {"level":"warn","ts":"2026-06-22T01:55:22.50419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.240917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:55:22.504213Z","caller":"traceutil/trace.go:171","msg":"trace[1200338343] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1250; }","duration":"291.296479ms","start":"2026-06-22T01:55:22.212911Z","end":"2026-06-22T01:55:22.504208Z","steps":["trace[1200338343] 'agreement among raft nodes before linearized reading' (duration: 291.260148ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:55:22.841217Z","caller":"traceutil/trace.go:171","msg":"trace[547193140] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"333.770533ms","start":"2026-06-22T01:55:22.507418Z","end":"2026-06-22T01:55:22.841188Z","steps":["trace[547193140] 'process raft request' (duration: 270.274427ms)","trace[547193140] 'compare' (duration: 63.197708ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:55:22.841364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:22.507402Z","time spent":"333.881417ms","remote":"127.0.0.1:41646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T01:55:23.098527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.796375ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T01:55:23.098745Z","caller":"traceutil/trace.go:171","msg":"trace[420507568] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1303; }","duration":"390.804474ms","start":"2026-06-22T01:55:22.707924Z","end":"2026-06-22T01:55:23.098728Z","steps":["trace[420507568] 'read index received' (duration: 69.781327ms)","trace[420507568] 'applied index is now lower than readState.Index' (duration: 321.022287ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:55:23.09882Z","caller":"traceutil/trace.go:171","msg":"trace[355539925] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"590.014299ms","start":"2026-06-22T01:55:22.508777Z","end":"2026-06-22T01:55:23.098791Z","steps":["trace[355539925] 'process raft request' (duration: 589.855365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:23.09895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:22.50877Z","time spent":"590.112762ms","remote":"127.0.0.1:41408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:55:23.099004Z","caller":"traceutil/trace.go:171","msg":"trace[469107129] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"456.772237ms","start":"2026-06-22T01:55:22.642218Z","end":"2026-06-22T01:55:23.09899Z","steps":["trace[469107129] 'process raft request' (duration: 456.466228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:23.099075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:22.642195Z","time spent":"456.841629ms","remote":"127.0.0.1:41646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T01:55:23.09913Z","caller":"traceutil/trace.go:171","msg":"trace[1035434004] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"590.76974ms","start":"2026-06-22T01:55:22.508347Z","end":"2026-06-22T01:55:23.099117Z","steps":["trace[1035434004] 'process raft request' (duration: 480.296696ms)","trace[1035434004] 'compare' (duration: 109.672072ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:55:23.099193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:22.508336Z","time spent":"590.819561ms","remote":"127.0.0.1:41646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T01:55:23.09936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.446241ms","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-06-22T01:55:23.099393Z","caller":"traceutil/trace.go:171","msg":"trace[1150047000] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1254; }","duration":"391.517443ms","start":"2026-06-22T01:55:22.707865Z","end":"2026-06-22T01:55:23.099383Z","steps":["trace[1150047000] 'agreement among raft nodes before linearized reading' (duration: 391.389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:23.09942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:22.707845Z","time spent":"391.568835ms","remote":"127.0.0.1:41646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-22T01:55:23.099484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.453835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:55:23.099551Z","caller":"traceutil/trace.go:171","msg":"trace[2066607143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1254; }","duration":"308.556818ms","start":"2026-06-22T01:55:22.790979Z","end":"2026-06-22T01:55:23.099536Z","steps":["trace[2066607143] 'agreement among raft nodes before linearized reading' (duration: 308.451226ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:23.099591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:22.790964Z","time spent":"308.61471ms","remote":"127.0.0.1:41320","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-06-22T01:55:24.183308Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879919633607650,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-22T01:55:24.209618Z","caller":"traceutil/trace.go:171","msg":"trace[261159270] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"595.56809ms","start":"2026-06-22T01:55:23.614025Z","end":"2026-06-22T01:55:24.209593Z","steps":["trace[261159270] 'process raft request' (duration: 595.325744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:24.209765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:23.613994Z","time spent":"595.695384ms","remote":"127.0.0.1:41542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5883,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T01:55:24.49451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.946473ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-22T01:55:24.494619Z","caller":"traceutil/trace.go:171","msg":"trace[1462904132] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1312; }","duration":"812.304232ms","start":"2026-06-22T01:55:23.682294Z","end":"2026-06-22T01:55:24.494598Z","steps":["trace[1462904132] 'read index received' (duration: 527.054378ms)","trace[1462904132] 'applied index is now lower than readState.Index' (duration: 285.247704ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:55:24.494708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.419085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:55:24.494744Z","caller":"traceutil/trace.go:171","msg":"trace[1629554339] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1260; }","duration":"812.498748ms","start":"2026-06-22T01:55:23.682234Z","end":"2026-06-22T01:55:24.494733Z","steps":["trace[1629554339] 'agreement among raft nodes before linearized reading' (duration: 812.412765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:55:24.494777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:55:23.682214Z","time spent":"812.553299ms","remote":"127.0.0.1:46770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-06-22T01:55:34.604314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.229575ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-22T01:55:35.135105Z","caller":"traceutil/trace.go:171","msg":"trace[954745046] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"101.273484ms","start":"2026-06-22T01:55:35.033804Z","end":"2026-06-22T01:55:35.135078Z","steps":["trace[954745046] 'process raft request' (duration: 101.102429ms)"],"step_count":1}