{"level":"warn","ts":"2026-04-14T06:26:19.853768Z","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-14T06:26:19.853858Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144: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.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-14T06:26:19.85393Z","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-14T06:26:19.853938Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-04-14T06:26:19.853958Z","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-14T06:26:19.854623Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-04-14T06:26:19.854697Z","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.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-14T06:26:19.859149Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.26266ms"} {"level":"info","ts":"2026-04-14T06:26:19.867284Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-04-14T06:26:19.867355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T06:26:19.867377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-04-14T06:26:19.867387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T06:26:19.867399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-04-14T06:26:19.867439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-04-14T06:26:19.873812Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T06:26:19.875473Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T06:26:19.876726Z","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-14T06:26:19.879114Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T06:26:19.880462Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T06:26:19.882134Z","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-14T06:26:19.882619Z","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-14T06:26:19.882662Z","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-14T06:26:19.885067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-04-14T06:26:19.88535Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-04-14T06:26:19.885751Z","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-14T06:26:19.885829Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-04-14T06:26:19.885859Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-04-14T06:26:19.886587Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T06:26:19.886518Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T06:26:20.268213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T06:26:20.268319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T06:26:20.268384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-04-14T06:26:20.268412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-04-14T06:26:20.268429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-04-14T06:26:20.268453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-04-14T06:26:20.26848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-04-14T06:26:20.269572Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T06:26:20.269585Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T06:26:20.269636Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T06:26:20.269765Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T06:26:20.270653Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T06:26:20.270751Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T06:26:20.270787Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T06:26:20.272216Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-04-14T06:26:20.272469Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T06:26:20.272502Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T06:26:20.279069Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-14T06:27:00.402234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.682967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T06:27:00.402373Z","caller":"traceutil/trace.go:171","msg":"trace[1817337659] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:685; }","duration":"111.886361ms","start":"2026-04-14T06:27:00.290462Z","end":"2026-04-14T06:27:00.402349Z","steps":["trace[1817337659] 'count revisions from in-memory index tree' (duration: 111.572445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T06:27:00.402475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.078764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T06:27:00.402607Z","caller":"traceutil/trace.go:171","msg":"trace[449286536] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:685; }","duration":"111.35203ms","start":"2026-04-14T06:27:00.291235Z","end":"2026-04-14T06:27:00.402588Z","steps":["trace[449286536] 'range keys from in-memory index tree' (duration: 111.013653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T06:27:00.402653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.140007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T06:27:00.402699Z","caller":"traceutil/trace.go:171","msg":"trace[1602708336] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:685; }","duration":"112.230709ms","start":"2026-04-14T06:27:00.290458Z","end":"2026-04-14T06:27:00.402688Z","steps":["trace[1602708336] 'range keys from in-memory index tree' (duration: 112.070865ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:27:00.796872Z","caller":"traceutil/trace.go:171","msg":"trace[2137956920] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"137.953417ms","start":"2026-04-14T06:27:00.658904Z","end":"2026-04-14T06:27:00.796857Z","steps":["trace[2137956920] 'process raft request' (duration: 137.66495ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:27:00.79679Z","caller":"traceutil/trace.go:171","msg":"trace[2035781792] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:710; }","duration":"135.138656ms","start":"2026-04-14T06:27:00.661621Z","end":"2026-04-14T06:27:00.796759Z","steps":["trace[2035781792] 'read index received' (duration: 134.927222ms)","trace[2035781792] 'applied index is now lower than readState.Index' (duration: 210.034µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T06:27:00.7973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.658918ms","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-04-14T06:27:00.797419Z","caller":"traceutil/trace.go:171","msg":"trace[893630716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:687; }","duration":"135.836981ms","start":"2026-04-14T06:27:00.661563Z","end":"2026-04-14T06:27:00.7974Z","steps":["trace[893630716] 'agreement among raft nodes before linearized reading' (duration: 135.503504ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:27:16.750561Z","caller":"traceutil/trace.go:171","msg":"trace[2061412302] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"162.17491ms","start":"2026-04-14T06:27:16.588334Z","end":"2026-04-14T06:27:16.750509Z","steps":["trace[2061412302] 'process raft request' (duration: 161.877923ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:27:16.999759Z","caller":"traceutil/trace.go:171","msg":"trace[1563116245] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"241.274874ms","start":"2026-04-14T06:27:16.758463Z","end":"2026-04-14T06:27:16.999737Z","steps":["trace[1563116245] 'process raft request' (duration: 241.128211ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:27:17.00701Z","caller":"traceutil/trace.go:171","msg":"trace[995867765] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:827; }","duration":"130.581827ms","start":"2026-04-14T06:27:16.876398Z","end":"2026-04-14T06:27:17.00698Z","steps":["trace[995867765] 'read index received' (duration: 123.305453ms)","trace[995867765] 'applied index is now lower than readState.Index' (duration: 7.274524ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T06:27:17.007125Z","caller":"traceutil/trace.go:171","msg":"trace[2143109072] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"221.662095ms","start":"2026-04-14T06:27:16.785449Z","end":"2026-04-14T06:27:17.007112Z","steps":["trace[2143109072] 'process raft request' (duration: 221.446841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T06:27:17.007326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.923434ms","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-14T06:27:17.007369Z","caller":"traceutil/trace.go:171","msg":"trace[1737086743] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:801; }","duration":"131.023946ms","start":"2026-04-14T06:27:16.876336Z","end":"2026-04-14T06:27:17.00736Z","steps":["trace[1737086743] 'agreement among raft nodes before linearized reading' (duration: 130.884783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T06:27:17.007582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.031189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T06:27:17.007663Z","caller":"traceutil/trace.go:171","msg":"trace[850849334] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:801; }","duration":"125.171162ms","start":"2026-04-14T06:27:16.882474Z","end":"2026-04-14T06:27:17.007645Z","steps":["trace[850849334] 'agreement among raft nodes before linearized reading' (duration: 124.973508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T06:27:17.007857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.185136ms","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-04-14T06:27:17.007944Z","caller":"traceutil/trace.go:171","msg":"trace[2124412327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:801; }","duration":"120.315908ms","start":"2026-04-14T06:27:16.887608Z","end":"2026-04-14T06:27:17.007924Z","steps":["trace[2124412327] 'agreement among raft nodes before linearized reading' (duration: 120.068523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T06:27:54.278309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.92825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T06:27:54.27859Z","caller":"traceutil/trace.go:171","msg":"trace[296727251] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"247.301371ms","start":"2026-04-14T06:27:54.031267Z","end":"2026-04-14T06:27:54.278569Z","steps":["trace[296727251] 'process raft request' (duration: 247.195228ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:27:54.278922Z","caller":"traceutil/trace.go:171","msg":"trace[1746511195] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"279.481826ms","start":"2026-04-14T06:27:53.99942Z","end":"2026-04-14T06:27:54.278902Z","steps":["trace[1746511195] 'process raft request' (duration: 40.857099ms)","trace[1746511195] 'compare' (duration: 236.579703ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T06:28:19.368049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.398221ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-14T06:28:19.368165Z","caller":"traceutil/trace.go:171","msg":"trace[404987766] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1144; }","duration":"266.006832ms","start":"2026-04-14T06:28:19.102141Z","end":"2026-04-14T06:28:19.368148Z","steps":["trace[404987766] 'read index received' (duration: 119.402847ms)","trace[404987766] 'applied index is now lower than readState.Index' (duration: 146.602505ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T06:28:19.368514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.354979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-14T06:28:19.368609Z","caller":"traceutil/trace.go:171","msg":"trace[555009759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1102; }","duration":"266.504342ms","start":"2026-04-14T06:28:19.102085Z","end":"2026-04-14T06:28:19.368589Z","steps":["trace[555009759] 'agreement among raft nodes before linearized reading' (duration: 266.232117ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:28:21.72139Z","caller":"traceutil/trace.go:171","msg":"trace[175131535] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"273.925181ms","start":"2026-04-14T06:28:21.447436Z","end":"2026-04-14T06:28:21.721361Z","steps":["trace[175131535] 'process raft request' (duration: 273.855009ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:28:21.721608Z","caller":"traceutil/trace.go:171","msg":"trace[647073274] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"274.995973ms","start":"2026-04-14T06:28:21.446599Z","end":"2026-04-14T06:28:21.721595Z","steps":["trace[647073274] 'process raft request' (duration: 273.8963ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:28:51.983616Z","caller":"traceutil/trace.go:171","msg":"trace[23838957] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1334; }","duration":"114.952752ms","start":"2026-04-14T06:28:51.868635Z","end":"2026-04-14T06:28:51.983588Z","steps":["trace[23838957] 'read index received' (duration: 114.695476ms)","trace[23838957] 'applied index is now lower than readState.Index' (duration: 256.026µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T06:28:51.983695Z","caller":"traceutil/trace.go:171","msg":"trace[1379228000] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"122.167435ms","start":"2026-04-14T06:28:51.861499Z","end":"2026-04-14T06:28:51.983667Z","steps":["trace[1379228000] 'process raft request' (duration: 121.847279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T06:28:51.983899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.243617ms","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-04-14T06:28:51.984194Z","caller":"traceutil/trace.go:171","msg":"trace[1590328882] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1283; }","duration":"115.623606ms","start":"2026-04-14T06:28:51.868538Z","end":"2026-04-14T06:28:51.984162Z","steps":["trace[1590328882] 'agreement among raft nodes before linearized reading' (duration: 115.178636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T06:28:52.152467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.073064ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T06:28:52.152592Z","caller":"traceutil/trace.go:171","msg":"trace[1339759532] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"164.418806ms","start":"2026-04-14T06:28:51.98815Z","end":"2026-04-14T06:28:52.152569Z","steps":["trace[1339759532] 'process raft request' (duration: 42.140069ms)","trace[1339759532] 'compare' (duration: 121.92086ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T06:28:52.511281Z","caller":"traceutil/trace.go:171","msg":"trace[142410988] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"155.668448ms","start":"2026-04-14T06:28:52.355594Z","end":"2026-04-14T06:28:52.511262Z","steps":["trace[142410988] 'process raft request' (duration: 155.578667ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:28:52.780997Z","caller":"traceutil/trace.go:171","msg":"trace[95542531] linearizableReadLoop","detail":"{readStateIndex:1341; appliedIndex:1339; }","duration":"149.894486ms","start":"2026-04-14T06:28:52.631082Z","end":"2026-04-14T06:28:52.780976Z","steps":["trace[95542531] 'read index received' (duration: 90.268255ms)","trace[95542531] 'applied index is now lower than readState.Index' (duration: 59.625621ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T06:28:52.781159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.065169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T06:28:52.781204Z","caller":"traceutil/trace.go:171","msg":"trace[1967565285] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"159.348198ms","start":"2026-04-14T06:28:52.621835Z","end":"2026-04-14T06:28:52.781183Z","steps":["trace[1967565285] 'process raft request' (duration: 159.060531ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:28:52.78121Z","caller":"traceutil/trace.go:171","msg":"trace[1798513303] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1290; }","duration":"150.162562ms","start":"2026-04-14T06:28:52.631035Z","end":"2026-04-14T06:28:52.781198Z","steps":["trace[1798513303] 'agreement among raft nodes before linearized reading' (duration: 150.058399ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:28:52.781382Z","caller":"traceutil/trace.go:171","msg":"trace[752304000] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"164.866695ms","start":"2026-04-14T06:28:52.616507Z","end":"2026-04-14T06:28:52.781373Z","steps":["trace[752304000] 'process raft request' (duration: 104.813064ms)","trace[752304000] 'compare' (duration: 59.387556ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T06:28:52.781464Z","caller":"traceutil/trace.go:171","msg":"trace[907328948] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"127.753555ms","start":"2026-04-14T06:28:52.653698Z","end":"2026-04-14T06:28:52.781451Z","steps":["trace[907328948] 'process raft request' (duration: 127.238843ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:28:52.954263Z","caller":"traceutil/trace.go:171","msg":"trace[1864630399] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"168.749807ms","start":"2026-04-14T06:28:52.785494Z","end":"2026-04-14T06:28:52.954244Z","steps":["trace[1864630399] 'process raft request' (duration: 168.635415ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:28:52.967888Z","caller":"traceutil/trace.go:171","msg":"trace[450151221] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1343; }","duration":"127.350805ms","start":"2026-04-14T06:28:52.840513Z","end":"2026-04-14T06:28:52.967864Z","steps":["trace[450151221] 'read index received' (duration: 113.868847ms)","trace[450151221] 'applied index is now lower than readState.Index' (duration: 13.480918ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T06:28:52.968053Z","caller":"traceutil/trace.go:171","msg":"trace[1217233154] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"181.838217ms","start":"2026-04-14T06:28:52.786181Z","end":"2026-04-14T06:28:52.968019Z","steps":["trace[1217233154] 'process raft request' (duration: 181.550711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T06:28:52.968127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.60787ms","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-04-14T06:28:52.968162Z","caller":"traceutil/trace.go:171","msg":"trace[417211472] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1292; }","duration":"127.697542ms","start":"2026-04-14T06:28:52.840454Z","end":"2026-04-14T06:28:52.968151Z","steps":["trace[417211472] 'agreement among raft nodes before linearized reading' (duration: 127.504688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T06:29:20.07019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.7329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T06:29:20.070304Z","caller":"traceutil/trace.go:171","msg":"trace[1044043221] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1470; }","duration":"166.952215ms","start":"2026-04-14T06:29:19.903322Z","end":"2026-04-14T06:29:20.070274Z","steps":["trace[1044043221] 'range keys from in-memory index tree' (duration: 166.553766ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:29:20.070364Z","caller":"traceutil/trace.go:171","msg":"trace[960274676] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"146.444237ms","start":"2026-04-14T06:29:19.923877Z","end":"2026-04-14T06:29:20.070321Z","steps":["trace[960274676] 'process raft request' (duration: 94.190761ms)","trace[960274676] 'compare' (duration: 51.900458ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T06:29:20.23297Z","caller":"traceutil/trace.go:171","msg":"trace[1343884563] linearizableReadLoop","detail":"{readStateIndex:1531; appliedIndex:1529; }","duration":"117.430457ms","start":"2026-04-14T06:29:20.115513Z","end":"2026-04-14T06:29:20.232943Z","steps":["trace[1343884563] 'read index received' (duration: 12.365933ms)","trace[1343884563] 'applied index is now lower than readState.Index' (duration: 105.063374ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T06:29:20.233227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.690982ms","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-04-14T06:29:20.233271Z","caller":"traceutil/trace.go:171","msg":"trace[347375640] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1473; }","duration":"117.792705ms","start":"2026-04-14T06:29:20.115467Z","end":"2026-04-14T06:29:20.23326Z","steps":["trace[347375640] 'agreement among raft nodes before linearized reading' (duration: 117.58667ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T06:29:20.233288Z","caller":"traceutil/trace.go:171","msg":"trace[1290280305] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"156.743877ms","start":"2026-04-14T06:29:20.076511Z","end":"2026-04-14T06:29:20.233255Z","steps":["trace[1290280305] 'process raft request' (duration: 113.880302ms)","trace[1290280305] 'compare' (duration: 42.422485ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T06:29:20.440702Z","caller":"traceutil/trace.go:171","msg":"trace[244991938] linearizableReadLoop","detail":"{readStateIndex:1533; appliedIndex:1532; }","duration":"138.394895ms","start":"2026-04-14T06:29:20.302282Z","end":"2026-04-14T06:29:20.440677Z","steps":["trace[244991938] 'read index received' (duration: 138.124139ms)","trace[244991938] 'applied index is now lower than readState.Index' (duration: 269.786µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T06:29:20.440753Z","caller":"traceutil/trace.go:171","msg":"trace[1048165520] transaction","detail":"{read_only:false; response_revision:1475; number_of_response:1; }","duration":"140.96843ms","start":"2026-04-14T06:29:20.299759Z","end":"2026-04-14T06:29:20.440728Z","steps":["trace[1048165520] 'process raft request' (duration: 140.758355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T06:29:20.440906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.579648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T06:29:20.441013Z","caller":"traceutil/trace.go:171","msg":"trace[229803416] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1475; }","duration":"138.736692ms","start":"2026-04-14T06:29:20.302249Z","end":"2026-04-14T06:29:20.440986Z","steps":["trace[229803416] 'agreement among raft nodes before linearized reading' (duration: 138.524138ms)"],"step_count":1}