{"level":"warn","ts":"2026-03-31T05:09:33.050805Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T05:09:33.050898Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.235: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.19.213.235:2380","--initial-cluster=instance=https://199.19.213.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.235: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-03-31T05:09:33.050969Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T05:09:33.050976Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.235:2380"]} {"level":"info","ts":"2026-03-31T05:09:33.050995Z","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-03-31T05:09:33.051648Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"]} {"level":"info","ts":"2026-03-31T05:09:33.051732Z","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.19.213.235:2380"],"listen-peer-urls":["https://199.19.213.235:2380"],"advertise-client-urls":["https://199.19.213.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.235: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-03-31T05:09:33.056116Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.140904ms"} {"level":"info","ts":"2026-03-31T05:09:33.064275Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"61a3fe3fc9dc5d35","cluster-id":"e13fd0e1d9ce1168"} {"level":"info","ts":"2026-03-31T05:09:33.064385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=()"} {"level":"info","ts":"2026-03-31T05:09:33.064424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became follower at term 0"} {"level":"info","ts":"2026-03-31T05:09:33.064443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 61a3fe3fc9dc5d35 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-31T05:09:33.064466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became follower at term 1"} {"level":"info","ts":"2026-03-31T05:09:33.064517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=(7035746592805903669)"} {"level":"warn","ts":"2026-03-31T05:09:33.075689Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-31T05:09:33.079497Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-31T05:09:33.080724Z","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-03-31T05:09:33.08317Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"61a3fe3fc9dc5d35","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-31T05:09:33.08357Z","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-03-31T05:09:33.083627Z","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-03-31T05:09:33.083641Z","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-03-31T05:09:33.083566Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"61a3fe3fc9dc5d35","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-31T05:09:33.085158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=(7035746592805903669)"} {"level":"info","ts":"2026-03-31T05:09:33.085355Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e13fd0e1d9ce1168","local-member-id":"61a3fe3fc9dc5d35","added-peer-id":"61a3fe3fc9dc5d35","added-peer-peer-urls":["https://199.19.213.235:2380"]} {"level":"info","ts":"2026-03-31T05:09:33.088775Z","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-03-31T05:09:33.088888Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.235:2380"} {"level":"info","ts":"2026-03-31T05:09:33.088902Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.235:2380"} {"level":"info","ts":"2026-03-31T05:09:33.089104Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"61a3fe3fc9dc5d35","initial-advertise-peer-urls":["https://199.19.213.235:2380"],"listen-peer-urls":["https://199.19.213.235:2380"],"advertise-client-urls":["https://199.19.213.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-31T05:09:33.089127Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-31T05:09:33.566392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 is starting a new election at term 1"} {"level":"info","ts":"2026-03-31T05:09:33.566439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-31T05:09:33.566465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 received MsgPreVoteResp from 61a3fe3fc9dc5d35 at term 1"} {"level":"info","ts":"2026-03-31T05:09:33.566478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became candidate at term 2"} {"level":"info","ts":"2026-03-31T05:09:33.566484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 received MsgVoteResp from 61a3fe3fc9dc5d35 at term 2"} {"level":"info","ts":"2026-03-31T05:09:33.566531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became leader at term 2"} {"level":"info","ts":"2026-03-31T05:09:33.566543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 61a3fe3fc9dc5d35 elected leader 61a3fe3fc9dc5d35 at term 2"} {"level":"info","ts":"2026-03-31T05:09:33.568065Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"61a3fe3fc9dc5d35","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.235:2379]}","request-path":"/0/members/61a3fe3fc9dc5d35/attributes","cluster-id":"e13fd0e1d9ce1168","publish-timeout":"7s"} {"level":"info","ts":"2026-03-31T05:09:33.568087Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T05:09:33.568205Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T05:09:33.568408Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-31T05:09:33.56848Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-31T05:09:33.571617Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.235:2379"} {"level":"info","ts":"2026-03-31T05:09:33.571896Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T05:09:33.572379Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-31T05:09:33.573013Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e13fd0e1d9ce1168","local-member-id":"61a3fe3fc9dc5d35","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T05:09:33.573082Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T05:09:33.573106Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-03-31T05:10:04.059584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.022479ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T05:10:04.059767Z","caller":"traceutil/trace.go:171","msg":"trace[294318013] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"268.774082ms","start":"2026-03-31T05:10:03.790976Z","end":"2026-03-31T05:10:04.05975Z","steps":["trace[294318013] 'process raft request' (duration: 164.96642ms)","trace[294318013] 'compare' (duration: 102.877194ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T05:10:04.081696Z","caller":"traceutil/trace.go:171","msg":"trace[1190646941] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:613; }","duration":"146.994715ms","start":"2026-03-31T05:10:03.934676Z","end":"2026-03-31T05:10:04.081671Z","steps":["trace[1190646941] 'read index received' (duration: 21.315623ms)","trace[1190646941] 'applied index is now lower than readState.Index' (duration: 125.678082ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T05:10:04.081793Z","caller":"traceutil/trace.go:171","msg":"trace[1886262925] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"192.187655ms","start":"2026-03-31T05:10:03.889522Z","end":"2026-03-31T05:10:04.08171Z","steps":["trace[1886262925] 'process raft request' (duration: 191.879466ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T05:10:04.081922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.228501ms","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-03-31T05:10:04.082106Z","caller":"traceutil/trace.go:171","msg":"trace[398438008] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:595; }","duration":"147.455728ms","start":"2026-03-31T05:10:03.934635Z","end":"2026-03-31T05:10:04.082091Z","steps":["trace[398438008] 'agreement among raft nodes before linearized reading' (duration: 147.16902ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:10:04.974387Z","caller":"traceutil/trace.go:171","msg":"trace[510584833] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"191.780162ms","start":"2026-03-31T05:10:04.782584Z","end":"2026-03-31T05:10:04.974364Z","steps":["trace[510584833] 'read index received' (duration: 188.182027ms)","trace[510584833] 'applied index is now lower than readState.Index' (duration: 3.596995ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T05:10:04.974467Z","caller":"traceutil/trace.go:171","msg":"trace[200419886] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"203.403732ms","start":"2026-03-31T05:10:04.771037Z","end":"2026-03-31T05:10:04.97444Z","steps":["trace[200419886] 'process raft request' (duration: 199.696524ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T05:10:04.974645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.043219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"info","ts":"2026-03-31T05:10:04.974722Z","caller":"traceutil/trace.go:171","msg":"trace[721877930] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:621; }","duration":"192.152223ms","start":"2026-03-31T05:10:04.782552Z","end":"2026-03-31T05:10:04.974704Z","steps":["trace[721877930] 'agreement among raft nodes before linearized reading' (duration: 191.980418ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:10:11.828128Z","caller":"traceutil/trace.go:171","msg":"trace[1120098984] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:701; }","duration":"234.160141ms","start":"2026-03-31T05:10:11.593942Z","end":"2026-03-31T05:10:11.828102Z","steps":["trace[1120098984] 'read index received' (duration: 233.965495ms)","trace[1120098984] 'applied index is now lower than readState.Index' (duration: 191.465µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T05:10:11.828249Z","caller":"traceutil/trace.go:171","msg":"trace[1050461572] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"283.045348ms","start":"2026-03-31T05:10:11.545188Z","end":"2026-03-31T05:10:11.828233Z","steps":["trace[1050461572] 'process raft request' (duration: 282.780871ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T05:10:11.828539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.50681ms","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-03-31T05:10:11.828615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.043089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-484rf\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-03-31T05:10:11.828654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.690845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-31T05:10:11.828689Z","caller":"traceutil/trace.go:171","msg":"trace[1155485261] range","detail":"{range_begin:/registry/pods/kube-system/cilium-484rf; range_end:; response_count:1; response_revision:681; }","duration":"105.180573ms","start":"2026-03-31T05:10:11.72349Z","end":"2026-03-31T05:10:11.828671Z","steps":["trace[1155485261] 'agreement among raft nodes before linearized reading' (duration: 104.946356ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:10:11.828743Z","caller":"traceutil/trace.go:171","msg":"trace[1051506204] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:681; }","duration":"234.829269ms","start":"2026-03-31T05:10:11.593892Z","end":"2026-03-31T05:10:11.828721Z","steps":["trace[1051506204] 'agreement among raft nodes before linearized reading' (duration: 234.600153ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:10:11.828648Z","caller":"traceutil/trace.go:171","msg":"trace[1342593818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:681; }","duration":"120.680835ms","start":"2026-03-31T05:10:11.707943Z","end":"2026-03-31T05:10:11.828624Z","steps":["trace[1342593818] 'agreement among raft nodes before linearized reading' (duration: 120.340375ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:10:12.016443Z","caller":"traceutil/trace.go:171","msg":"trace[1301483178] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"183.456329ms","start":"2026-03-31T05:10:11.832956Z","end":"2026-03-31T05:10:12.016412Z","steps":["trace[1301483178] 'process raft request' (duration: 101.960067ms)","trace[1301483178] 'compare' (duration: 81.242804ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T05:10:12.018428Z","caller":"traceutil/trace.go:171","msg":"trace[1237035343] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"185.075997ms","start":"2026-03-31T05:10:11.833329Z","end":"2026-03-31T05:10:12.018405Z","steps":["trace[1237035343] 'process raft request' (duration: 184.702146ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:10:12.018483Z","caller":"traceutil/trace.go:171","msg":"trace[763576625] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"176.632701ms","start":"2026-03-31T05:10:11.841822Z","end":"2026-03-31T05:10:12.018455Z","steps":["trace[763576625] 'process raft request' (duration: 176.500837ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:10:12.018665Z","caller":"traceutil/trace.go:171","msg":"trace[1229485041] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"185.282472ms","start":"2026-03-31T05:10:11.83337Z","end":"2026-03-31T05:10:12.018652Z","steps":["trace[1229485041] 'process raft request' (duration: 184.775098ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:11:22.187924Z","caller":"traceutil/trace.go:171","msg":"trace[292997809] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"111.796426ms","start":"2026-03-31T05:11:22.076103Z","end":"2026-03-31T05:11:22.187899Z","steps":["trace[292997809] 'process raft request' (duration: 111.660833ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:11:23.063136Z","caller":"traceutil/trace.go:171","msg":"trace[1633108180] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"140.48059ms","start":"2026-03-31T05:11:22.922623Z","end":"2026-03-31T05:11:23.063103Z","steps":["trace[1633108180] 'process raft request' (duration: 140.221014ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:11:48.618664Z","caller":"traceutil/trace.go:171","msg":"trace[2003537906] linearizableReadLoop","detail":"{readStateIndex:1262; appliedIndex:1261; }","duration":"103.192147ms","start":"2026-03-31T05:11:48.515455Z","end":"2026-03-31T05:11:48.618647Z","steps":["trace[2003537906] 'read index received' (duration: 93.243276ms)","trace[2003537906] 'applied index is now lower than readState.Index' (duration: 9.948191ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T05:11:48.618742Z","caller":"traceutil/trace.go:171","msg":"trace[927332214] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"123.914399ms","start":"2026-03-31T05:11:48.494806Z","end":"2026-03-31T05:11:48.618721Z","steps":["trace[927332214] 'process raft request' (duration: 113.977558ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T05:11:48.618842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.390232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-31T05:11:48.618863Z","caller":"traceutil/trace.go:171","msg":"trace[111780848] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1217; }","duration":"103.460203ms","start":"2026-03-31T05:11:48.515398Z","end":"2026-03-31T05:11:48.618858Z","steps":["trace[111780848] 'agreement among raft nodes before linearized reading' (duration: 103.31735ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:11:55.442538Z","caller":"traceutil/trace.go:171","msg":"trace[1782868833] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1299; }","duration":"293.110834ms","start":"2026-03-31T05:11:55.149401Z","end":"2026-03-31T05:11:55.442511Z","steps":["trace[1782868833] 'read index received' (duration: 292.846737ms)","trace[1782868833] 'applied index is now lower than readState.Index' (duration: 262.957µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T05:11:55.442688Z","caller":"traceutil/trace.go:171","msg":"trace[1780039501] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"316.246864ms","start":"2026-03-31T05:11:55.126401Z","end":"2026-03-31T05:11:55.442648Z","steps":["trace[1780039501] 'process raft request' (duration: 315.961967ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T05:11:55.442753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.320099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T05:11:55.442825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.395886ms","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-03-31T05:11:55.442837Z","caller":"traceutil/trace.go:171","msg":"trace[44048465] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1254; }","duration":"293.432992ms","start":"2026-03-31T05:11:55.14937Z","end":"2026-03-31T05:11:55.442803Z","steps":["trace[44048465] 'agreement among raft nodes before linearized reading' (duration: 293.291178ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:11:55.442872Z","caller":"traceutil/trace.go:171","msg":"trace[1009481516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1254; }","duration":"154.465438ms","start":"2026-03-31T05:11:55.288393Z","end":"2026-03-31T05:11:55.442858Z","steps":["trace[1009481516] 'agreement among raft nodes before linearized reading' (duration: 154.299434ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T05:11:55.442852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T05:11:55.126378Z","time spent":"316.386378ms","remote":"127.0.0.1:46212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11375,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T05:11:55.577802Z","caller":"traceutil/trace.go:171","msg":"trace[2056018172] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"130.411207ms","start":"2026-03-31T05:11:55.447363Z","end":"2026-03-31T05:11:55.577774Z","steps":["trace[2056018172] 'process raft request' (duration: 114.818249ms)","trace[2056018172] 'compare' (duration: 15.478635ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T05:11:55.598616Z","caller":"traceutil/trace.go:171","msg":"trace[2108601102] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"151.180078ms","start":"2026-03-31T05:11:55.447413Z","end":"2026-03-31T05:11:55.598593Z","steps":["trace[2108601102] 'process raft request' (duration: 151.022385ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:11:55.598934Z","caller":"traceutil/trace.go:171","msg":"trace[1520555723] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"148.381461ms","start":"2026-03-31T05:11:55.450517Z","end":"2026-03-31T05:11:55.598899Z","steps":["trace[1520555723] 'process raft request' (duration: 148.028031ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:11:55.598991Z","caller":"traceutil/trace.go:171","msg":"trace[1084246221] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"146.22828ms","start":"2026-03-31T05:11:55.452713Z","end":"2026-03-31T05:11:55.598941Z","steps":["trace[1084246221] 'process raft request' (duration: 146.117927ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:11:56.116062Z","caller":"traceutil/trace.go:171","msg":"trace[1032134441] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"124.170393ms","start":"2026-03-31T05:11:55.991867Z","end":"2026-03-31T05:11:56.116038Z","steps":["trace[1032134441] 'process raft request' (duration: 33.271078ms)","trace[1032134441] 'compare' (duration: 90.69576ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T05:11:56.117475Z","caller":"traceutil/trace.go:171","msg":"trace[1352010860] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"122.811892ms","start":"2026-03-31T05:11:55.994643Z","end":"2026-03-31T05:11:56.117455Z","steps":["trace[1352010860] 'process raft request' (duration: 122.549626ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:12:08.603226Z","caller":"traceutil/trace.go:171","msg":"trace[1048300419] linearizableReadLoop","detail":"{readStateIndex:1399; appliedIndex:1398; }","duration":"105.103148ms","start":"2026-03-31T05:12:08.498098Z","end":"2026-03-31T05:12:08.603201Z","steps":["trace[1048300419] 'read index received' (duration: 92.516514ms)","trace[1048300419] 'applied index is now lower than readState.Index' (duration: 12.584944ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T05:12:08.603286Z","caller":"traceutil/trace.go:171","msg":"trace[907929887] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"137.161627ms","start":"2026-03-31T05:12:08.466102Z","end":"2026-03-31T05:12:08.603264Z","steps":["trace[907929887] 'process raft request' (duration: 124.432139ms)","trace[907929887] 'compare' (duration: 12.476742ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T05:12:08.603437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.335133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-31T05:12:08.603476Z","caller":"traceutil/trace.go:171","msg":"trace[1507468468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1350; }","duration":"105.424975ms","start":"2026-03-31T05:12:08.498041Z","end":"2026-03-31T05:12:08.603466Z","steps":["trace[1507468468] 'agreement among raft nodes before linearized reading' (duration: 105.281692ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T05:12:08.801194Z","caller":"traceutil/trace.go:171","msg":"trace[1670187242] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"194.276173ms","start":"2026-03-31T05:12:08.606886Z","end":"2026-03-31T05:12:08.801162Z","steps":["trace[1670187242] 'process raft request' (duration: 129.764914ms)","trace[1670187242] 'compare' (duration: 64.214342ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T05:12:08.80163Z","caller":"traceutil/trace.go:171","msg":"trace[545478683] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"194.210241ms","start":"2026-03-31T05:12:08.6074Z","end":"2026-03-31T05:12:08.80161Z","steps":["trace[545478683] 'process raft request' (duration: 193.686599ms)"],"step_count":1}