{"level":"warn","ts":"2026-04-18T01:51:11.319509Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T01:51:11.319654Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.209: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.209:2380","--initial-cluster=instance=https://199.204.45.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.209: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-04-18T01:51:11.319771Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T01:51:11.319791Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-04-18T01:51:11.319823Z","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-04-18T01:51:11.321095Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"]} {"level":"info","ts":"2026-04-18T01:51:11.321241Z","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.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.209: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-04-18T01:51:11.325717Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.15936ms"} {"level":"info","ts":"2026-04-18T01:51:11.332802Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adfb641115bf6cbd","cluster-id":"3da6b677d4b80c6"} {"level":"info","ts":"2026-04-18T01:51:11.332868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T01:51:11.332885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 0"} {"level":"info","ts":"2026-04-18T01:51:11.332893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adfb641115bf6cbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T01:51:11.332912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 1"} {"level":"info","ts":"2026-04-18T01:51:11.332945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"warn","ts":"2026-04-18T01:51:11.33926Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T01:51:11.340331Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T01:51:11.341622Z","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-04-18T01:51:11.343798Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adfb641115bf6cbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T01:51:11.345319Z","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-04-18T01:51:11.346362Z","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-04-18T01:51:11.346375Z","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-04-18T01:51:11.345243Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adfb641115bf6cbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T01:51:11.347141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"info","ts":"2026-04-18T01:51:11.347249Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","added-peer-id":"adfb641115bf6cbd","added-peer-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-04-18T01:51:11.348429Z","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-04-18T01:51:11.348578Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adfb641115bf6cbd","initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T01:51:11.348599Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T01:51:11.348675Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-04-18T01:51:11.348686Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-04-18T01:51:11.933368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T01:51:11.933428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T01:51:11.933487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgPreVoteResp from adfb641115bf6cbd at term 1"} {"level":"info","ts":"2026-04-18T01:51:11.933506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became candidate at term 2"} {"level":"info","ts":"2026-04-18T01:51:11.933524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgVoteResp from adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-04-18T01:51:11.93354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became leader at term 2"} {"level":"info","ts":"2026-04-18T01:51:11.933557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adfb641115bf6cbd elected leader adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-04-18T01:51:11.955673Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T01:51:11.972953Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adfb641115bf6cbd","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.209:2379]}","request-path":"/0/members/adfb641115bf6cbd/attributes","cluster-id":"3da6b677d4b80c6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T01:51:11.972983Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T01:51:11.973029Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T01:51:11.97352Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T01:51:11.973662Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T01:51:11.976727Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-18T01:51:11.977365Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T01:51:11.977815Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T01:51:11.978037Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T01:51:11.980276Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.209:2379"} {"level":"info","ts":"2026-04-18T01:51:27.628821Z","caller":"traceutil/trace.go:171","msg":"trace[504849289] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"146.097153ms","start":"2026-04-18T01:51:27.482703Z","end":"2026-04-18T01:51:27.6288Z","steps":["trace[504849289] 'process raft request' (duration: 69.416254ms)","trace[504849289] 'compare' (duration: 76.419485ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:51:30.537449Z","caller":"traceutil/trace.go:171","msg":"trace[689301356] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"116.841481ms","start":"2026-04-18T01:51:30.420581Z","end":"2026-04-18T01:51:30.537423Z","steps":["trace[689301356] 'process raft request' (duration: 116.645846ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:35.89635Z","caller":"traceutil/trace.go:171","msg":"trace[2002645090] linearizableReadLoop","detail":"{readStateIndex:434; appliedIndex:433; }","duration":"331.508641ms","start":"2026-04-18T01:51:35.564825Z","end":"2026-04-18T01:51:35.896334Z","steps":["trace[2002645090] 'read index received' (duration: 331.352445ms)","trace[2002645090] 'applied index is now lower than readState.Index' (duration: 155.486µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:51:35.896414Z","caller":"traceutil/trace.go:171","msg":"trace[1153059807] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"560.962944ms","start":"2026-04-18T01:51:35.335424Z","end":"2026-04-18T01:51:35.896387Z","steps":["trace[1153059807] 'process raft request' (duration: 560.799669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:35.89647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.636847ms","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-04-18T01:51:35.896519Z","caller":"traceutil/trace.go:171","msg":"trace[1249946600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:419; }","duration":"331.741264ms","start":"2026-04-18T01:51:35.564771Z","end":"2026-04-18T01:51:35.896513Z","steps":["trace[1249946600] 'agreement among raft nodes before linearized reading' (duration: 331.653716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:35.896545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:35.564747Z","time spent":"331.790153ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-18T01:51:35.896832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.612966ms","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-04-18T01:51:35.896906Z","caller":"traceutil/trace.go:171","msg":"trace[1821431935] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:419; }","duration":"103.734902ms","start":"2026-04-18T01:51:35.793153Z","end":"2026-04-18T01:51:35.896888Z","steps":["trace[1821431935] 'agreement among raft nodes before linearized reading' (duration: 103.561387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:35.896927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:35.335407Z","time spent":"561.069131ms","remote":"127.0.0.1:52686","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-04-18T01:51:35.897434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.582541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T01:51:35.897549Z","caller":"traceutil/trace.go:171","msg":"trace[1395804734] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:419; }","duration":"289.740707ms","start":"2026-04-18T01:51:35.60779Z","end":"2026-04-18T01:51:35.89753Z","steps":["trace[1395804734] 'agreement among raft nodes before linearized reading' (duration: 288.909958ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:38.10816Z","caller":"traceutil/trace.go:171","msg":"trace[1440154179] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"202.499113ms","start":"2026-04-18T01:51:37.905629Z","end":"2026-04-18T01:51:38.108128Z","steps":["trace[1440154179] 'process raft request' (duration: 202.189231ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:38.110716Z","caller":"traceutil/trace.go:171","msg":"trace[1709016585] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"203.042539ms","start":"2026-04-18T01:51:37.907652Z","end":"2026-04-18T01:51:38.110695Z","steps":["trace[1709016585] 'process raft request' (duration: 203.00008ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:38.110772Z","caller":"traceutil/trace.go:171","msg":"trace[368421580] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"203.213784ms","start":"2026-04-18T01:51:37.907516Z","end":"2026-04-18T01:51:38.11073Z","steps":["trace[368421580] 'process raft request' (duration: 203.053798ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:39.773823Z","caller":"traceutil/trace.go:171","msg":"trace[458834049] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"128.278294ms","start":"2026-04-18T01:51:39.645525Z","end":"2026-04-18T01:51:39.773803Z","steps":["trace[458834049] 'process raft request' (duration: 128.03704ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:39.927039Z","caller":"traceutil/trace.go:171","msg":"trace[673982495] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"129.359134ms","start":"2026-04-18T01:51:39.797655Z","end":"2026-04-18T01:51:39.927014Z","steps":["trace[673982495] 'process raft request' (duration: 129.311985ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:39.927071Z","caller":"traceutil/trace.go:171","msg":"trace[1657559497] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"129.428063ms","start":"2026-04-18T01:51:39.797609Z","end":"2026-04-18T01:51:39.927037Z","steps":["trace[1657559497] 'process raft request' (duration: 127.707649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:42.645238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.55578ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T01:51:42.645433Z","caller":"traceutil/trace.go:171","msg":"trace[1577703172] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"431.227706ms","start":"2026-04-18T01:51:42.214188Z","end":"2026-04-18T01:51:42.645415Z","steps":["trace[1577703172] 'process raft request' (duration: 431.168668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:42.645504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:42.214167Z","time spent":"431.310644ms","remote":"127.0.0.1:52940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T01:51:42.645545Z","caller":"traceutil/trace.go:171","msg":"trace[1567274068] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"435.13516ms","start":"2026-04-18T01:51:42.210383Z","end":"2026-04-18T01:51:42.645518Z","steps":["trace[1567274068] 'process raft request' (duration: 162.063594ms)","trace[1567274068] 'compare' (duration: 272.411474ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:51:42.645708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:42.210369Z","time spent":"435.260116ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T01:51:42.646633Z","caller":"traceutil/trace.go:171","msg":"trace[1484445959] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"430.69317ms","start":"2026-04-18T01:51:42.215924Z","end":"2026-04-18T01:51:42.646617Z","steps":["trace[1484445959] 'process raft request' (duration: 430.281421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:42.646727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:42.215919Z","time spent":"430.775848ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T01:51:42.646938Z","caller":"traceutil/trace.go:171","msg":"trace[1215909068] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"431.09913ms","start":"2026-04-18T01:51:42.215786Z","end":"2026-04-18T01:51:42.646885Z","steps":["trace[1215909068] 'process raft request' (duration: 430.294472ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:42.647064Z","caller":"traceutil/trace.go:171","msg":"trace[282329520] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"431.215066ms","start":"2026-04-18T01:51:42.215836Z","end":"2026-04-18T01:51:42.647051Z","steps":["trace[282329520] 'process raft request' (duration: 430.314981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:42.647137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:42.215833Z","time spent":"431.268885ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T01:51:42.647183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:42.215783Z","time spent":"431.224557ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T01:51:42.64741Z","caller":"traceutil/trace.go:171","msg":"trace[461905804] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"431.683594ms","start":"2026-04-18T01:51:42.215713Z","end":"2026-04-18T01:51:42.647397Z","steps":["trace[461905804] 'process raft request' (duration: 430.253483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:42.647541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:42.215707Z","time spent":"431.738193ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T01:51:42.647623Z","caller":"traceutil/trace.go:171","msg":"trace[217156935] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"405.32555ms","start":"2026-04-18T01:51:42.242286Z","end":"2026-04-18T01:51:42.647612Z","steps":["trace[217156935] 'process raft request' (duration: 404.093514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:42.647684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:42.242272Z","time spent":"405.387239ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T01:51:42.647768Z","caller":"traceutil/trace.go:171","msg":"trace[2102258490] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"425.877681ms","start":"2026-04-18T01:51:42.22188Z","end":"2026-04-18T01:51:42.647758Z","steps":["trace[2102258490] 'process raft request' (duration: 424.375912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:42.647819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:42.221858Z","time spent":"425.93494ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T01:51:42.647891Z","caller":"traceutil/trace.go:171","msg":"trace[2067433129] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"424.798931ms","start":"2026-04-18T01:51:42.223084Z","end":"2026-04-18T01:51:42.647883Z","steps":["trace[2067433129] 'process raft request' (duration: 423.241903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:42.647936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:42.223078Z","time spent":"424.83596ms","remote":"127.0.0.1:52498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T01:51:42.647993Z","caller":"traceutil/trace.go:171","msg":"trace[1778270516] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"286.090242ms","start":"2026-04-18T01:51:42.361885Z","end":"2026-04-18T01:51:42.647976Z","steps":["trace[1778270516] 'process raft request' (duration: 284.558794ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:43.737389Z","caller":"traceutil/trace.go:171","msg":"trace[821747449] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"125.322174ms","start":"2026-04-18T01:51:43.612047Z","end":"2026-04-18T01:51:43.737369Z","steps":["trace[821747449] 'process raft request' (duration: 124.757439ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:45.997022Z","caller":"traceutil/trace.go:171","msg":"trace[1363407689] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"812.926737ms","start":"2026-04-18T01:51:45.184062Z","end":"2026-04-18T01:51:45.996988Z","steps":["trace[1363407689] 'process raft request' (duration: 812.577206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:45.997158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:45.184048Z","time spent":"813.040854ms","remote":"127.0.0.1:52490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T01:51:48.995315Z","caller":"traceutil/trace.go:171","msg":"trace[87861724] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"106.272573ms","start":"2026-04-18T01:51:48.888995Z","end":"2026-04-18T01:51:48.995268Z","steps":["trace[87861724] 'read index received' (duration: 105.182094ms)","trace[87861724] 'applied index is now lower than readState.Index' (duration: 1.089439ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:51:48.995354Z","caller":"traceutil/trace.go:171","msg":"trace[650111754] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"242.973674ms","start":"2026-04-18T01:51:48.752346Z","end":"2026-04-18T01:51:48.99532Z","steps":["trace[650111754] 'process raft request' (duration: 242.201765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:48.995512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.469307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-b5llj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-18T01:51:48.995588Z","caller":"traceutil/trace.go:171","msg":"trace[33210258] range","detail":"{range_begin:/registry/pods/kube-system/cilium-b5llj; range_end:; response_count:1; response_revision:575; }","duration":"106.637353ms","start":"2026-04-18T01:51:48.888928Z","end":"2026-04-18T01:51:48.995565Z","steps":["trace[33210258] 'agreement among raft nodes before linearized reading' (duration: 106.482737ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:49.545887Z","caller":"traceutil/trace.go:171","msg":"trace[1737429008] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"532.677013ms","start":"2026-04-18T01:51:49.012966Z","end":"2026-04-18T01:51:49.545643Z","steps":["trace[1737429008] 'process raft request' (duration: 532.476388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:49.546116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:49.012911Z","time spent":"533.10774ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T01:51:49.548686Z","caller":"traceutil/trace.go:171","msg":"trace[705530823] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"498.216432ms","start":"2026-04-18T01:51:49.050445Z","end":"2026-04-18T01:51:49.548662Z","steps":["trace[705530823] 'process raft request' (duration: 498.110175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:49.548813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:49.050428Z","time spent":"498.325919ms","remote":"127.0.0.1:52744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T01:51:50.806602Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835592229848082909,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T01:51:51.307158Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835592229848082909,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T01:51:51.350408Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.372810944s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T01:51:51.357252Z","caller":"traceutil/trace.go:171","msg":"trace[780581671] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"1.381846729s","start":"2026-04-18T01:51:49.975383Z","end":"2026-04-18T01:51:51.357229Z","steps":["trace[780581671] 'process raft request' (duration: 1.379832626s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:51.357459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:49.975355Z","time spent":"1.381951245s","remote":"127.0.0.1:52532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T01:51:51.387837Z","caller":"traceutil/trace.go:171","msg":"trace[1519833275] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:595; }","duration":"1.081209156s","start":"2026-04-18T01:51:50.306567Z","end":"2026-04-18T01:51:51.387776Z","steps":["trace[1519833275] 'read index received' (duration: 1.044545786s)","trace[1519833275] 'applied index is now lower than readState.Index' (duration: 36.66239ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:51:51.388139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079751857s","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-04-18T01:51:51.388165Z","caller":"traceutil/trace.go:171","msg":"trace[2073025847] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:578; }","duration":"1.079811555s","start":"2026-04-18T01:51:50.308346Z","end":"2026-04-18T01:51:51.388157Z","steps":["trace[2073025847] 'agreement among raft nodes before linearized reading' (duration: 1.079763727s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:51.388186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:50.308338Z","time spent":"1.079843154s","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-18T01:51:51.388334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079947821s","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-04-18T01:51:51.388354Z","caller":"traceutil/trace.go:171","msg":"trace[1542265997] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:578; }","duration":"1.079968031s","start":"2026-04-18T01:51:50.308381Z","end":"2026-04-18T01:51:51.388349Z","steps":["trace[1542265997] 'agreement among raft nodes before linearized reading' (duration: 1.079935302s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:51.388367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:50.308288Z","time spent":"1.080076307s","remote":"127.0.0.1:52686","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-04-18T01:51:51.388363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079585222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-18T01:51:51.388325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.08140854s","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-04-18T01:51:51.388522Z","caller":"traceutil/trace.go:171","msg":"trace[483878988] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"1.082002864s","start":"2026-04-18T01:51:50.30649Z","end":"2026-04-18T01:51:51.388493Z","steps":["trace[483878988] 'agreement among raft nodes before linearized reading' (duration: 1.081381321s)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:51.388437Z","caller":"traceutil/trace.go:171","msg":"trace[1452603839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:578; }","duration":"1.079688169s","start":"2026-04-18T01:51:50.308736Z","end":"2026-04-18T01:51:51.388424Z","steps":["trace[1452603839] 'agreement among raft nodes before linearized reading' (duration: 1.079553232s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:51.388601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:50.308727Z","time spent":"1.079867784s","remote":"127.0.0.1:52686","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-04-18T01:51:51.388609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.279832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T01:51:51.3887Z","caller":"traceutil/trace.go:171","msg":"trace[445797092] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"782.404679ms","start":"2026-04-18T01:51:50.606289Z","end":"2026-04-18T01:51:51.388693Z","steps":["trace[445797092] 'agreement among raft nodes before linearized reading' (duration: 782.189595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:51.388677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:50.306475Z","time spent":"1.082187478s","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-18T01:51:51.388896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:50.606268Z","time spent":"782.619823ms","remote":"127.0.0.1:52464","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-04-18T01:51:53.300992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.325288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T01:51:53.301174Z","caller":"traceutil/trace.go:171","msg":"trace[310589192] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:618; }","duration":"197.589141ms","start":"2026-04-18T01:51:53.103564Z","end":"2026-04-18T01:51:53.301153Z","steps":["trace[310589192] 'range keys from in-memory index tree' (duration: 197.193452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:55.10052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.266089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-b5llj\" ","response":"range_response_count:1 size:17790"} {"level":"info","ts":"2026-04-18T01:51:55.100586Z","caller":"traceutil/trace.go:171","msg":"trace[135018655] range","detail":"{range_begin:/registry/pods/kube-system/cilium-b5llj; range_end:; response_count:1; response_revision:643; }","duration":"166.402335ms","start":"2026-04-18T01:51:54.934169Z","end":"2026-04-18T01:51:55.100572Z","steps":["trace[135018655] 'range keys from in-memory index tree' (duration: 165.582028ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:55.125015Z","caller":"traceutil/trace.go:171","msg":"trace[682942012] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"190.030245ms","start":"2026-04-18T01:51:54.934945Z","end":"2026-04-18T01:51:55.124975Z","steps":["trace[682942012] 'read index received' (duration: 189.978876ms)","trace[682942012] 'applied index is now lower than readState.Index' (duration: 50.179µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:51:55.125088Z","caller":"traceutil/trace.go:171","msg":"trace[1206749180] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"190.638557ms","start":"2026-04-18T01:51:54.93439Z","end":"2026-04-18T01:51:55.125028Z","steps":["trace[1206749180] 'process raft request' (duration: 190.340856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:55.125664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.693816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T01:51:55.125739Z","caller":"traceutil/trace.go:171","msg":"trace[1967359785] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:1; response_revision:644; }","duration":"190.789312ms","start":"2026-04-18T01:51:54.934927Z","end":"2026-04-18T01:51:55.125716Z","steps":["trace[1967359785] 'agreement among raft nodes before linearized reading' (duration: 190.18755ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:55.32636Z","caller":"traceutil/trace.go:171","msg":"trace[1408596729] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"201.241025ms","start":"2026-04-18T01:51:55.125092Z","end":"2026-04-18T01:51:55.326333Z","steps":["trace[1408596729] 'read index received' (duration: 181.417346ms)","trace[1408596729] 'applied index is now lower than readState.Index' (duration: 19.822439ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:51:55.326545Z","caller":"traceutil/trace.go:171","msg":"trace[1396593636] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"212.345825ms","start":"2026-04-18T01:51:55.114059Z","end":"2026-04-18T01:51:55.326405Z","steps":["trace[1396593636] 'process raft request' (duration: 192.471957ms)","trace[1396593636] 'compare' (duration: 19.686603ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:51:55.326597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.298501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-04-18T01:51:55.326796Z","caller":"traceutil/trace.go:171","msg":"trace[281426643] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:645; }","duration":"224.515955ms","start":"2026-04-18T01:51:55.102237Z","end":"2026-04-18T01:51:55.326753Z","steps":["trace[281426643] 'agreement among raft nodes before linearized reading' (duration: 224.221234ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:55.515703Z","caller":"traceutil/trace.go:171","msg":"trace[1228599319] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"108.491556ms","start":"2026-04-18T01:51:55.407188Z","end":"2026-04-18T01:51:55.51568Z","steps":["trace[1228599319] 'read index received' (duration: 38.866451ms)","trace[1228599319] 'applied index is now lower than readState.Index' (duration: 69.624395ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:51:55.515764Z","caller":"traceutil/trace.go:171","msg":"trace[470798982] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"150.290791ms","start":"2026-04-18T01:51:55.365441Z","end":"2026-04-18T01:51:55.515732Z","steps":["trace[470798982] 'process raft request' (duration: 80.656077ms)","trace[470798982] 'compare' (duration: 69.476559ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:51:55.515928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.140106ms","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-04-18T01:51:55.515972Z","caller":"traceutil/trace.go:171","msg":"trace[2135338034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"108.217073ms","start":"2026-04-18T01:51:55.407744Z","end":"2026-04-18T01:51:55.515961Z","steps":["trace[2135338034] 'agreement among raft nodes before linearized reading' (duration: 108.057357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:55.516119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.301971ms","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-04-18T01:51:55.516179Z","caller":"traceutil/trace.go:171","msg":"trace[70884224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"108.403278ms","start":"2026-04-18T01:51:55.407762Z","end":"2026-04-18T01:51:55.516165Z","steps":["trace[70884224] 'agreement among raft nodes before linearized reading' (duration: 108.253842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:55.516118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.908503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-18T01:51:55.516527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.430307ms","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-04-18T01:51:55.516601Z","caller":"traceutil/trace.go:171","msg":"trace[1245253716] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"108.69411ms","start":"2026-04-18T01:51:55.407889Z","end":"2026-04-18T01:51:55.516583Z","steps":["trace[1245253716] 'agreement among raft nodes before linearized reading' (duration: 108.071348ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:55.516435Z","caller":"traceutil/trace.go:171","msg":"trace[175658811] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"109.259434ms","start":"2026-04-18T01:51:55.407156Z","end":"2026-04-18T01:51:55.516415Z","steps":["trace[175658811] 'agreement among raft nodes before linearized reading' (duration: 108.720339ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:55.759154Z","caller":"traceutil/trace.go:171","msg":"trace[1855409433] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"238.5438ms","start":"2026-04-18T01:51:55.520584Z","end":"2026-04-18T01:51:55.759128Z","steps":["trace[1855409433] 'process raft request' (duration: 235.991744ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:55.759381Z","caller":"traceutil/trace.go:171","msg":"trace[1222185085] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"237.634677ms","start":"2026-04-18T01:51:55.521718Z","end":"2026-04-18T01:51:55.759352Z","steps":["trace[1222185085] 'process raft request' (duration: 237.272507ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:55.759431Z","caller":"traceutil/trace.go:171","msg":"trace[1601718190] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:666; }","duration":"237.064113ms","start":"2026-04-18T01:51:55.522347Z","end":"2026-04-18T01:51:55.759411Z","steps":["trace[1601718190] 'read index received' (duration: 8.153925ms)","trace[1601718190] 'applied index is now lower than readState.Index' (duration: 228.909278ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:51:55.75954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.1784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-18T01:51:55.759636Z","caller":"traceutil/trace.go:171","msg":"trace[1654343478] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:650; }","duration":"237.254747ms","start":"2026-04-18T01:51:55.522319Z","end":"2026-04-18T01:51:55.759574Z","steps":["trace[1654343478] 'agreement among raft nodes before linearized reading' (duration: 237.16474ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:55.759566Z","caller":"traceutil/trace.go:171","msg":"trace[168743143] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"237.088002ms","start":"2026-04-18T01:51:55.522455Z","end":"2026-04-18T01:51:55.759543Z","steps":["trace[168743143] 'process raft request' (duration: 236.840169ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:56.0011Z","caller":"traceutil/trace.go:171","msg":"trace[146277698] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"292.73084ms","start":"2026-04-18T01:51:55.708322Z","end":"2026-04-18T01:51:56.001053Z","steps":["trace[146277698] 'process raft request' (duration: 292.551995ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:56.2581Z","caller":"traceutil/trace.go:171","msg":"trace[431446004] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"155.182116ms","start":"2026-04-18T01:51:56.102893Z","end":"2026-04-18T01:51:56.258075Z","steps":["trace[431446004] 'read index received' (duration: 155.137787ms)","trace[431446004] 'applied index is now lower than readState.Index' (duration: 43.249µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T01:51:56.258251Z","caller":"traceutil/trace.go:171","msg":"trace[1746166735] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"230.933167ms","start":"2026-04-18T01:51:56.027215Z","end":"2026-04-18T01:51:56.258148Z","steps":["trace[1746166735] 'process raft request' (duration: 230.611386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:56.26067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.401459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-04-18T01:51:56.260729Z","caller":"traceutil/trace.go:171","msg":"trace[1471396854] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:652; }","duration":"157.864738ms","start":"2026-04-18T01:51:56.102847Z","end":"2026-04-18T01:51:56.260712Z","steps":["trace[1471396854] 'agreement among raft nodes before linearized reading' (duration: 155.321322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:56.523379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.421406ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T01:51:56.523512Z","caller":"traceutil/trace.go:171","msg":"trace[1008822144] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:652; }","duration":"134.578141ms","start":"2026-04-18T01:51:56.388915Z","end":"2026-04-18T01:51:56.523493Z","steps":["trace[1008822144] 'range keys from in-memory index tree' (duration: 134.401576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:51:56.524288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.531703ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T01:51:56.524417Z","caller":"traceutil/trace.go:171","msg":"trace[660968505] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"301.693523ms","start":"2026-04-18T01:51:56.222677Z","end":"2026-04-18T01:51:56.52437Z","steps":["trace[660968505] 'process raft request' (duration: 112.995965ms)","trace[660968505] 'compare' (duration: 188.26191ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T01:51:56.524523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T01:51:56.222658Z","time spent":"301.799319ms","remote":"127.0.0.1:52528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T01:51:56.528269Z","caller":"traceutil/trace.go:171","msg":"trace[1323723960] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"195.121752ms","start":"2026-04-18T01:51:56.333139Z","end":"2026-04-18T01:51:56.52826Z","steps":["trace[1323723960] 'process raft request' (duration: 195.062034ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:51:56.528511Z","caller":"traceutil/trace.go:171","msg":"trace[1873756922] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"256.162368ms","start":"2026-04-18T01:51:56.272342Z","end":"2026-04-18T01:51:56.528505Z","steps":["trace[1873756922] 'process raft request' (duration: 255.76326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:52:07.722195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.003181ms","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-04-18T01:52:07.722296Z","caller":"traceutil/trace.go:171","msg":"trace[1495472873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:744; }","duration":"147.155346ms","start":"2026-04-18T01:52:07.575124Z","end":"2026-04-18T01:52:07.72228Z","steps":["trace[1495472873] 'range keys from in-memory index tree' (duration: 146.755857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:52:07.722203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.762301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T01:52:07.722399Z","caller":"traceutil/trace.go:171","msg":"trace[60021516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:744; }","duration":"115.004134ms","start":"2026-04-18T01:52:07.607371Z","end":"2026-04-18T01:52:07.722376Z","steps":["trace[60021516] 'range keys from in-memory index tree' (duration: 114.625628ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T01:52:07.868797Z","caller":"traceutil/trace.go:171","msg":"trace[1499068170] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"141.716476ms","start":"2026-04-18T01:52:07.727054Z","end":"2026-04-18T01:52:07.868771Z","steps":["trace[1499068170] 'process raft request' (duration: 141.239451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T01:53:55.376459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.477988ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T01:53:55.376583Z","caller":"traceutil/trace.go:171","msg":"trace[267313220] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"275.024161ms","start":"2026-04-18T01:53:55.101538Z","end":"2026-04-18T01:53:55.376562Z","steps":["trace[267313220] 'process raft request' (duration: 158.356672ms)","trace[267313220] 'compare' (duration: 116.245697ms)"],"step_count":2}