{"level":"warn","ts":"2026-04-23T12:24:54.701312Z","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-23T12:24:54.701397Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.105: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.105:2380","--initial-cluster=instance=https://199.19.213.105:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.105:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.105: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-23T12:24:54.701483Z","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-23T12:24:54.701495Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.105:2380"]} {"level":"info","ts":"2026-04-23T12:24:54.701512Z","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-23T12:24:54.702055Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"]} {"level":"info","ts":"2026-04-23T12:24:54.702127Z","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.105:2380"],"listen-peer-urls":["https://199.19.213.105:2380"],"advertise-client-urls":["https://199.19.213.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.105: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-23T12:24:54.705921Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.589169ms"} {"level":"info","ts":"2026-04-23T12:24:54.713672Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"eb6db91b2c71522f","cluster-id":"f43476f3367c14fb"} {"level":"info","ts":"2026-04-23T12:24:54.71376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T12:24:54.713788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became follower at term 0"} {"level":"info","ts":"2026-04-23T12:24:54.713806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft eb6db91b2c71522f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T12:24:54.713815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became follower at term 1"} {"level":"info","ts":"2026-04-23T12:24:54.713854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f switched to configuration voters=(16964418897735406127)"} {"level":"warn","ts":"2026-04-23T12:24:54.71861Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T12:24:54.719788Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T12:24:54.720865Z","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-23T12:24:54.722876Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"eb6db91b2c71522f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T12:24:54.723139Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"eb6db91b2c71522f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T12:24:54.72322Z","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-23T12:24:54.723261Z","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-23T12:24:54.72327Z","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-23T12:24:54.725152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f switched to configuration voters=(16964418897735406127)"} {"level":"info","ts":"2026-04-23T12:24:54.72551Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f43476f3367c14fb","local-member-id":"eb6db91b2c71522f","added-peer-id":"eb6db91b2c71522f","added-peer-peer-urls":["https://199.19.213.105:2380"]} {"level":"info","ts":"2026-04-23T12:24:54.727441Z","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-23T12:24:54.727658Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"eb6db91b2c71522f","initial-advertise-peer-urls":["https://199.19.213.105:2380"],"listen-peer-urls":["https://199.19.213.105:2380"],"advertise-client-urls":["https://199.19.213.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T12:24:54.727694Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T12:24:54.727715Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.105:2380"} {"level":"info","ts":"2026-04-23T12:24:54.727791Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.105:2380"} {"level":"info","ts":"2026-04-23T12:24:55.014619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T12:24:55.014728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T12:24:55.014755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f received MsgPreVoteResp from eb6db91b2c71522f at term 1"} {"level":"info","ts":"2026-04-23T12:24:55.014774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became candidate at term 2"} {"level":"info","ts":"2026-04-23T12:24:55.014785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f received MsgVoteResp from eb6db91b2c71522f at term 2"} {"level":"info","ts":"2026-04-23T12:24:55.0148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became leader at term 2"} {"level":"info","ts":"2026-04-23T12:24:55.014814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: eb6db91b2c71522f elected leader eb6db91b2c71522f at term 2"} {"level":"info","ts":"2026-04-23T12:24:55.015713Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T12:24:55.016348Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"eb6db91b2c71522f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.105:2379]}","request-path":"/0/members/eb6db91b2c71522f/attributes","cluster-id":"f43476f3367c14fb","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T12:24:55.016559Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T12:24:55.016956Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T12:24:55.017139Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T12:24:55.017162Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T12:24:55.019901Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T12:24:55.022469Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.105:2379"} {"level":"info","ts":"2026-04-23T12:24:55.030498Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f43476f3367c14fb","local-member-id":"eb6db91b2c71522f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T12:24:55.030577Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T12:24:55.030603Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T12:25:20.037665Z","caller":"traceutil/trace.go:171","msg":"trace[387125956] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"230.14887ms","start":"2026-04-23T12:25:19.807493Z","end":"2026-04-23T12:25:20.037642Z","steps":["trace[387125956] 'process raft request' (duration: 226.627158ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:25:20.043857Z","caller":"traceutil/trace.go:171","msg":"trace[714587652] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"226.495293ms","start":"2026-04-23T12:25:19.817339Z","end":"2026-04-23T12:25:20.043834Z","steps":["trace[714587652] 'process raft request' (duration: 226.248087ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:25:20.043945Z","caller":"traceutil/trace.go:171","msg":"trace[1508800806] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"222.94955ms","start":"2026-04-23T12:25:19.820975Z","end":"2026-04-23T12:25:20.043924Z","steps":["trace[1508800806] 'process raft request' (duration: 222.818957ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:25:20.194608Z","caller":"traceutil/trace.go:171","msg":"trace[590585525] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"120.279007ms","start":"2026-04-23T12:25:20.074304Z","end":"2026-04-23T12:25:20.194583Z","steps":["trace[590585525] 'process raft request' (duration: 81.369345ms)","trace[590585525] 'compare' (duration: 38.511592ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T12:25:21.742277Z","caller":"traceutil/trace.go:171","msg":"trace[526354034] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:591; }","duration":"159.000897ms","start":"2026-04-23T12:25:21.58325Z","end":"2026-04-23T12:25:21.742251Z","steps":["trace[526354034] 'read index received' (duration: 158.843644ms)","trace[526354034] 'applied index is now lower than readState.Index' (duration: 156.153µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T12:25:21.742406Z","caller":"traceutil/trace.go:171","msg":"trace[1730309310] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"176.849027ms","start":"2026-04-23T12:25:21.565513Z","end":"2026-04-23T12:25:21.742362Z","steps":["trace[1730309310] 'process raft request' (duration: 176.601341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T12:25:21.74246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.192301ms","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-23T12:25:21.742529Z","caller":"traceutil/trace.go:171","msg":"trace[288671631] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:574; }","duration":"159.323405ms","start":"2026-04-23T12:25:21.583196Z","end":"2026-04-23T12:25:21.74252Z","steps":["trace[288671631] 'agreement among raft nodes before linearized reading' (duration: 159.155452ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:25:23.896308Z","caller":"traceutil/trace.go:171","msg":"trace[918994299] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"133.83907ms","start":"2026-04-23T12:25:23.762438Z","end":"2026-04-23T12:25:23.896278Z","steps":["trace[918994299] 'process raft request' (duration: 133.309347ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:25:23.906399Z","caller":"traceutil/trace.go:171","msg":"trace[515638042] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"100.47257ms","start":"2026-04-23T12:25:23.805899Z","end":"2026-04-23T12:25:23.906372Z","steps":["trace[515638042] 'process raft request' (duration: 100.258735ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:25:26.682121Z","caller":"traceutil/trace.go:171","msg":"trace[683763384] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"165.402652ms","start":"2026-04-23T12:25:26.516693Z","end":"2026-04-23T12:25:26.682096Z","steps":["trace[683763384] 'process raft request' (duration: 165.265389ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:25:27.363484Z","caller":"traceutil/trace.go:171","msg":"trace[1902823532] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"181.850683ms","start":"2026-04-23T12:25:27.181606Z","end":"2026-04-23T12:25:27.363456Z","steps":["trace[1902823532] 'read index received' (duration: 181.587008ms)","trace[1902823532] 'applied index is now lower than readState.Index' (duration: 262.695µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T12:25:27.36376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.129989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-23T12:25:27.363838Z","caller":"traceutil/trace.go:171","msg":"trace[2135384540] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"182.252612ms","start":"2026-04-23T12:25:27.181571Z","end":"2026-04-23T12:25:27.363824Z","steps":["trace[2135384540] 'agreement among raft nodes before linearized reading' (duration: 182.004667ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:25:27.363794Z","caller":"traceutil/trace.go:171","msg":"trace[1220536500] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"227.01645ms","start":"2026-04-23T12:25:27.136547Z","end":"2026-04-23T12:25:27.363564Z","steps":["trace[1220536500] 'process raft request' (duration: 226.756164ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:25:27.596501Z","caller":"traceutil/trace.go:171","msg":"trace[1501870278] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"228.311307ms","start":"2026-04-23T12:25:27.368165Z","end":"2026-04-23T12:25:27.596476Z","steps":["trace[1501870278] 'process raft request' (duration: 228.106673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T12:25:47.304768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.016981ms","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-04-23T12:25:47.304844Z","caller":"traceutil/trace.go:171","msg":"trace[455840713] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:780; }","duration":"307.143544ms","start":"2026-04-23T12:25:46.997686Z","end":"2026-04-23T12:25:47.30483Z","steps":["trace[455840713] 'range keys from in-memory index tree' (duration: 306.815858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T12:25:47.304874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T12:25:46.997667Z","time spent":"307.199495ms","remote":"127.0.0.1:58888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-23T12:27:36.510057Z","caller":"traceutil/trace.go:171","msg":"trace[1804830946] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"106.86725ms","start":"2026-04-23T12:27:36.403174Z","end":"2026-04-23T12:27:36.510041Z","steps":["trace[1804830946] 'process raft request' (duration: 14.495646ms)","trace[1804830946] 'compare' (duration: 91.98916ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T12:27:50.803444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.281775ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T12:27:50.803592Z","caller":"traceutil/trace.go:171","msg":"trace[587738396] transaction","detail":"{read_only:false; response_revision:1704; number_of_response:1; }","duration":"165.315115ms","start":"2026-04-23T12:27:50.638264Z","end":"2026-04-23T12:27:50.803579Z","steps":["trace[587738396] 'process raft request' (duration: 165.266315ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:27:50.803637Z","caller":"traceutil/trace.go:171","msg":"trace[1554015911] transaction","detail":"{read_only:false; response_revision:1703; number_of_response:1; }","duration":"165.375655ms","start":"2026-04-23T12:27:50.63823Z","end":"2026-04-23T12:27:50.803606Z","steps":["trace[1554015911] 'compare' (duration: 160.056083ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:28:08.203798Z","caller":"traceutil/trace.go:171","msg":"trace[622231243] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"110.080037ms","start":"2026-04-23T12:28:08.093687Z","end":"2026-04-23T12:28:08.203767Z","steps":["trace[622231243] 'process raft request' (duration: 109.880185ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:28:18.357364Z","caller":"traceutil/trace.go:171","msg":"trace[1894390059] linearizableReadLoop","detail":"{readStateIndex:2320; appliedIndex:2319; }","duration":"123.249022ms","start":"2026-04-23T12:28:18.23409Z","end":"2026-04-23T12:28:18.357339Z","steps":["trace[1894390059] 'read index received' (duration: 123.051641ms)","trace[1894390059] 'applied index is now lower than readState.Index' (duration: 196.311µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T12:28:18.357526Z","caller":"traceutil/trace.go:171","msg":"trace[1566386800] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"142.723133ms","start":"2026-04-23T12:28:18.21478Z","end":"2026-04-23T12:28:18.357503Z","steps":["trace[1566386800] 'process raft request' (duration: 142.412789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T12:28:18.357793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.620096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T12:28:18.357948Z","caller":"traceutil/trace.go:171","msg":"trace[2070666626] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:2230; }","duration":"123.856588ms","start":"2026-04-23T12:28:18.234048Z","end":"2026-04-23T12:28:18.357905Z","steps":["trace[2070666626] 'agreement among raft nodes before linearized reading' (duration: 123.538495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T12:28:18.357875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.103498ms","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":"warn","ts":"2026-04-23T12:28:18.358099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.698705ms","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-23T12:28:18.358143Z","caller":"traceutil/trace.go:171","msg":"trace[1654014561] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2230; }","duration":"113.405731ms","start":"2026-04-23T12:28:18.24471Z","end":"2026-04-23T12:28:18.358116Z","steps":["trace[1654014561] 'agreement among raft nodes before linearized reading' (duration: 113.037728ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:28:18.358196Z","caller":"traceutil/trace.go:171","msg":"trace[849306643] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2230; }","duration":"110.822077ms","start":"2026-04-23T12:28:18.247353Z","end":"2026-04-23T12:28:18.358175Z","steps":["trace[849306643] 'agreement among raft nodes before linearized reading' (duration: 110.554445ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:28:50.685288Z","caller":"traceutil/trace.go:171","msg":"trace[347990510] transaction","detail":"{read_only:false; response_revision:2484; number_of_response:1; }","duration":"110.388845ms","start":"2026-04-23T12:28:50.574873Z","end":"2026-04-23T12:28:50.685262Z","steps":["trace[347990510] 'process raft request' (duration: 110.254943ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:28:50.687531Z","caller":"traceutil/trace.go:171","msg":"trace[1092050439] transaction","detail":"{read_only:false; response_revision:2485; number_of_response:1; }","duration":"111.808066ms","start":"2026-04-23T12:28:50.5757Z","end":"2026-04-23T12:28:50.687508Z","steps":["trace[1092050439] 'process raft request' (duration: 111.543824ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:28:57.914681Z","caller":"traceutil/trace.go:171","msg":"trace[5959182] transaction","detail":"{read_only:false; response_revision:2533; number_of_response:1; }","duration":"115.050295ms","start":"2026-04-23T12:28:57.799605Z","end":"2026-04-23T12:28:57.914655Z","steps":["trace[5959182] 'process raft request' (duration: 114.876731ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:30:51.457164Z","caller":"traceutil/trace.go:171","msg":"trace[84542189] linearizableReadLoop","detail":"{readStateIndex:3348; appliedIndex:3347; }","duration":"118.757359ms","start":"2026-04-23T12:30:51.338383Z","end":"2026-04-23T12:30:51.457141Z","steps":["trace[84542189] 'read index received' (duration: 118.581207ms)","trace[84542189] 'applied index is now lower than readState.Index' (duration: 169.882µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T12:30:51.457468Z","caller":"traceutil/trace.go:171","msg":"trace[1667781802] transaction","detail":"{read_only:false; response_revision:3223; number_of_response:1; }","duration":"120.470947ms","start":"2026-04-23T12:30:51.336951Z","end":"2026-04-23T12:30:51.457422Z","steps":["trace[1667781802] 'process raft request' (duration: 120.06324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T12:30:51.457825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.4309ms","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-23T12:30:51.457872Z","caller":"traceutil/trace.go:171","msg":"trace[1195801720] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3223; }","duration":"119.532481ms","start":"2026-04-23T12:30:51.338329Z","end":"2026-04-23T12:30:51.457862Z","steps":["trace[1195801720] 'agreement among raft nodes before linearized reading' (duration: 119.373789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T12:30:51.45797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.728176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-23T12:30:51.458057Z","caller":"traceutil/trace.go:171","msg":"trace[1187826886] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3223; }","duration":"111.858258ms","start":"2026-04-23T12:30:51.34618Z","end":"2026-04-23T12:30:51.458038Z","steps":["trace[1187826886] 'agreement among raft nodes before linearized reading' (duration: 111.595684ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:30:51.677815Z","caller":"traceutil/trace.go:171","msg":"trace[718385094] transaction","detail":"{read_only:false; response_revision:3225; number_of_response:1; }","duration":"215.753488ms","start":"2026-04-23T12:30:51.462038Z","end":"2026-04-23T12:30:51.677791Z","steps":["trace[718385094] 'process raft request' (duration: 212.627758ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:34:27.185301Z","caller":"traceutil/trace.go:171","msg":"trace[1832319517] transaction","detail":"{read_only:false; response_revision:5367; number_of_response:1; }","duration":"128.013165ms","start":"2026-04-23T12:34:27.057254Z","end":"2026-04-23T12:34:27.185267Z","steps":["trace[1832319517] 'process raft request' (duration: 127.645571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T12:34:27.210278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.085479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T12:34:27.210358Z","caller":"traceutil/trace.go:171","msg":"trace[1210336675] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5369; }","duration":"107.18987ms","start":"2026-04-23T12:34:27.10315Z","end":"2026-04-23T12:34:27.21034Z","steps":["trace[1210336675] 'agreement among raft nodes before linearized reading' (duration: 107.066649ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:34:55.511622Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2874} {"level":"info","ts":"2026-04-23T12:34:55.612921Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2874,"took":"99.451242ms","hash":3629876681,"current-db-size-bytes":54104064,"current-db-size":"54 MB","current-db-size-in-use-bytes":31055872,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-23T12:34:55.612987Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3629876681,"revision":2874,"compact-revision":-1} {"level":"info","ts":"2026-04-23T12:35:06.811998Z","caller":"traceutil/trace.go:171","msg":"trace[921676908] transaction","detail":"{read_only:false; response_revision:5756; number_of_response:1; }","duration":"116.873735ms","start":"2026-04-23T12:35:06.6951Z","end":"2026-04-23T12:35:06.811974Z","steps":["trace[921676908] 'process raft request' (duration: 116.34397ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T12:35:06.977648Z","caller":"traceutil/trace.go:171","msg":"trace[200151133] transaction","detail":"{read_only:false; response_revision:5757; number_of_response:1; }","duration":"161.069542ms","start":"2026-04-23T12:35:06.816536Z","end":"2026-04-23T12:35:06.977606Z","steps":["trace[200151133] 'process raft request' (duration: 118.441543ms)","trace[200151133] 'compare' (duration: 42.220754ms)"],"step_count":2}