{"level":"warn","ts":"2026-04-16T16:31:24.669524Z","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-16T16:31:24.669616Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.5: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.5:2380","--initial-cluster=instance=https://199.19.213.5:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.5:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.5: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-16T16:31:24.669686Z","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-16T16:31:24.669727Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.5:2380"]} {"level":"info","ts":"2026-04-16T16:31:24.669753Z","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-16T16:31:24.670627Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"]} {"level":"info","ts":"2026-04-16T16:31:24.670745Z","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":16,"max-cpu-available":16,"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.5:2380"],"listen-peer-urls":["https://199.19.213.5:2380"],"advertise-client-urls":["https://199.19.213.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.5: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-16T16:31:24.674693Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.630612ms"} {"level":"info","ts":"2026-04-16T16:31:24.685751Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dcb0af7a3afe1d6d","cluster-id":"4564295d4e5c9a3e"} {"level":"info","ts":"2026-04-16T16:31:24.685832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T16:31:24.685859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became follower at term 0"} {"level":"info","ts":"2026-04-16T16:31:24.685876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dcb0af7a3afe1d6d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T16:31:24.685912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became follower at term 1"} {"level":"info","ts":"2026-04-16T16:31:24.685959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=(15902403223755824493)"} {"level":"warn","ts":"2026-04-16T16:31:24.69007Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T16:31:24.691304Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T16:31:24.692574Z","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-16T16:31:24.695186Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dcb0af7a3afe1d6d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T16:31:24.695437Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dcb0af7a3afe1d6d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T16:31:24.695591Z","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-16T16:31:24.695847Z","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-16T16:31:24.695965Z","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-16T16:31:24.697453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=(15902403223755824493)"} {"level":"info","ts":"2026-04-16T16:31:24.698007Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4564295d4e5c9a3e","local-member-id":"dcb0af7a3afe1d6d","added-peer-id":"dcb0af7a3afe1d6d","added-peer-peer-urls":["https://199.19.213.5:2380"]} {"level":"info","ts":"2026-04-16T16:31:24.700403Z","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-16T16:31:24.700546Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.5:2380"} {"level":"info","ts":"2026-04-16T16:31:24.70059Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.5:2380"} {"level":"info","ts":"2026-04-16T16:31:24.70146Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dcb0af7a3afe1d6d","initial-advertise-peer-urls":["https://199.19.213.5:2380"],"listen-peer-urls":["https://199.19.213.5:2380"],"advertise-client-urls":["https://199.19.213.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T16:31:24.701515Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T16:31:25.486677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T16:31:25.486746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T16:31:25.486772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d received MsgPreVoteResp from dcb0af7a3afe1d6d at term 1"} {"level":"info","ts":"2026-04-16T16:31:25.486793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became candidate at term 2"} {"level":"info","ts":"2026-04-16T16:31:25.486805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d received MsgVoteResp from dcb0af7a3afe1d6d at term 2"} {"level":"info","ts":"2026-04-16T16:31:25.486822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became leader at term 2"} {"level":"info","ts":"2026-04-16T16:31:25.486837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dcb0af7a3afe1d6d elected leader dcb0af7a3afe1d6d at term 2"} {"level":"info","ts":"2026-04-16T16:31:25.488054Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dcb0af7a3afe1d6d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.5:2379]}","request-path":"/0/members/dcb0af7a3afe1d6d/attributes","cluster-id":"4564295d4e5c9a3e","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T16:31:25.4881Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T16:31:25.488132Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T16:31:25.488261Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T16:31:25.488413Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T16:31:25.488467Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T16:31:25.489365Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4564295d4e5c9a3e","local-member-id":"dcb0af7a3afe1d6d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T16:31:25.489506Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T16:31:25.489558Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T16:31:25.491508Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T16:31:25.491624Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.5:2379"} {"level":"info","ts":"2026-04-16T16:31:54.61085Z","caller":"traceutil/trace.go:171","msg":"trace[191535542] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"135.097734ms","start":"2026-04-16T16:31:54.475721Z","end":"2026-04-16T16:31:54.610818Z","steps":["trace[191535542] 'process raft request' (duration: 134.87114ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:54.672625Z","caller":"traceutil/trace.go:171","msg":"trace[1231152578] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"191.083768ms","start":"2026-04-16T16:31:54.481511Z","end":"2026-04-16T16:31:54.672595Z","steps":["trace[1231152578] 'process raft request' (duration: 190.916534ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:54.672622Z","caller":"traceutil/trace.go:171","msg":"trace[1899707908] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"192.183999ms","start":"2026-04-16T16:31:54.480401Z","end":"2026-04-16T16:31:54.672585Z","steps":["trace[1899707908] 'process raft request' (duration: 191.913534ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:54.67275Z","caller":"traceutil/trace.go:171","msg":"trace[107785522] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"184.59762ms","start":"2026-04-16T16:31:54.488104Z","end":"2026-04-16T16:31:54.672702Z","steps":["trace[107785522] 'process raft request' (duration: 184.380366ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:54.672911Z","caller":"traceutil/trace.go:171","msg":"trace[1821510125] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"177.763084ms","start":"2026-04-16T16:31:54.495136Z","end":"2026-04-16T16:31:54.672899Z","steps":["trace[1821510125] 'process raft request' (duration: 177.572421ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:54.672922Z","caller":"traceutil/trace.go:171","msg":"trace[1265938440] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"183.935847ms","start":"2026-04-16T16:31:54.488972Z","end":"2026-04-16T16:31:54.672908Z","steps":["trace[1265938440] 'process raft request' (duration: 183.638201ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:54.67302Z","caller":"traceutil/trace.go:171","msg":"trace[754171454] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"175.041991ms","start":"2026-04-16T16:31:54.497961Z","end":"2026-04-16T16:31:54.673003Z","steps":["trace[754171454] 'process raft request' (duration: 174.835047ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:54.673001Z","caller":"traceutil/trace.go:171","msg":"trace[334346125] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"175.925418ms","start":"2026-04-16T16:31:54.497035Z","end":"2026-04-16T16:31:54.672961Z","steps":["trace[334346125] 'process raft request' (duration: 175.721434ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:54.673137Z","caller":"traceutil/trace.go:171","msg":"trace[1713967762] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"166.787539ms","start":"2026-04-16T16:31:54.506335Z","end":"2026-04-16T16:31:54.673122Z","steps":["trace[1713967762] 'process raft request' (duration: 166.593385ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:54.673129Z","caller":"traceutil/trace.go:171","msg":"trace[1417397729] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"132.393789ms","start":"2026-04-16T16:31:54.54071Z","end":"2026-04-16T16:31:54.673103Z","steps":["trace[1417397729] 'process raft request' (duration: 132.338128ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:54.673115Z","caller":"traceutil/trace.go:171","msg":"trace[1637011795] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"170.526492ms","start":"2026-04-16T16:31:54.502538Z","end":"2026-04-16T16:31:54.673065Z","steps":["trace[1637011795] 'process raft request' (duration: 170.326228ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:00.868036Z","caller":"traceutil/trace.go:171","msg":"trace[304462660] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"213.261964ms","start":"2026-04-16T16:32:00.654746Z","end":"2026-04-16T16:32:00.868008Z","steps":["trace[304462660] 'process raft request' (duration: 212.603301ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:01.037375Z","caller":"traceutil/trace.go:171","msg":"trace[1361370286] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"119.136839ms","start":"2026-04-16T16:32:00.9182Z","end":"2026-04-16T16:32:01.037336Z","steps":["trace[1361370286] 'process raft request' (duration: 91.27507ms)","trace[1361370286] 'compare' (duration: 27.620405ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:32:01.577302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.865538ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T16:32:01.577852Z","caller":"traceutil/trace.go:171","msg":"trace[456287794] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"341.805219ms","start":"2026-04-16T16:32:01.235805Z","end":"2026-04-16T16:32:01.57761Z","steps":["trace[456287794] 'process raft request' (duration: 130.069655ms)","trace[456287794] 'compare' (duration: 210.699444ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:32:01.578052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:01.235776Z","time spent":"342.183617ms","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:32:01.578408Z","caller":"traceutil/trace.go:171","msg":"trace[366506741] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"299.257931ms","start":"2026-04-16T16:32:01.279017Z","end":"2026-04-16T16:32:01.578275Z","steps":["trace[366506741] 'read index received' (duration: 86.760801ms)","trace[366506741] 'applied index is now lower than readState.Index' (duration: 212.49321ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:32:01.579036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.008296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-16T16:32:01.579112Z","caller":"traceutil/trace.go:171","msg":"trace[298302908] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"300.112638ms","start":"2026-04-16T16:32:01.27897Z","end":"2026-04-16T16:32:01.579083Z","steps":["trace[298302908] 'agreement among raft nodes before linearized reading' (duration: 299.69813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:01.579157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:01.27895Z","time spent":"300.197129ms","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T16:32:01.582542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.362326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-16T16:32:01.582584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.662138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xqq26\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-04-16T16:32:01.582622Z","caller":"traceutil/trace.go:171","msg":"trace[241072655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"285.474489ms","start":"2026-04-16T16:32:01.297128Z","end":"2026-04-16T16:32:01.582603Z","steps":["trace[241072655] 'agreement among raft nodes before linearized reading' (duration: 285.280675ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:01.582626Z","caller":"traceutil/trace.go:171","msg":"trace[1835029288] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"135.43999ms","start":"2026-04-16T16:32:01.447161Z","end":"2026-04-16T16:32:01.582601Z","steps":["trace[1835029288] 'process raft request' (duration: 131.37789ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:01.582652Z","caller":"traceutil/trace.go:171","msg":"trace[450156046] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xqq26; range_end:; response_count:1; response_revision:576; }","duration":"158.766781ms","start":"2026-04-16T16:32:01.423865Z","end":"2026-04-16T16:32:01.582631Z","steps":["trace[450156046] 'agreement among raft nodes before linearized reading' (duration: 158.636268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:01.582543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.405958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:32:01.58276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.314714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T16:32:01.582776Z","caller":"traceutil/trace.go:171","msg":"trace[1338634725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"141.676683ms","start":"2026-04-16T16:32:01.441069Z","end":"2026-04-16T16:32:01.582746Z","steps":["trace[1338634725] 'agreement among raft nodes before linearized reading' (duration: 141.397857ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:01.582839Z","caller":"traceutil/trace.go:171","msg":"trace[281351729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:576; }","duration":"285.432787ms","start":"2026-04-16T16:32:01.297387Z","end":"2026-04-16T16:32:01.58282Z","steps":["trace[281351729] 'agreement among raft nodes before linearized reading' (duration: 285.200973ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:17.639053Z","caller":"traceutil/trace.go:171","msg":"trace[16390794] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"107.976399ms","start":"2026-04-16T16:32:17.531047Z","end":"2026-04-16T16:32:17.639023Z","steps":["trace[16390794] 'process raft request' (duration: 107.787935ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:30.61892Z","caller":"traceutil/trace.go:171","msg":"trace[756366999] linearizableReadLoop","detail":"{readStateIndex:1860; appliedIndex:1859; }","duration":"111.958868ms","start":"2026-04-16T16:33:30.506914Z","end":"2026-04-16T16:33:30.618872Z","steps":["trace[756366999] 'read index received' (duration: 111.518469ms)","trace[756366999] 'applied index is now lower than readState.Index' (duration: 438.249µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:30.618999Z","caller":"traceutil/trace.go:171","msg":"trace[939831638] transaction","detail":"{read_only:false; response_revision:1794; number_of_response:1; }","duration":"295.419881ms","start":"2026-04-16T16:33:30.323545Z","end":"2026-04-16T16:33:30.618964Z","steps":["trace[939831638] 'process raft request' (duration: 295.013632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:30.619309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.364415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-16T16:33:30.619404Z","caller":"traceutil/trace.go:171","msg":"trace[1160074488] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1794; }","duration":"112.542109ms","start":"2026-04-16T16:33:30.50684Z","end":"2026-04-16T16:33:30.619382Z","steps":["trace[1160074488] 'agreement among raft nodes before linearized reading' (duration: 112.222093ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:31.080208Z","caller":"traceutil/trace.go:171","msg":"trace[641738093] linearizableReadLoop","detail":"{readStateIndex:1863; appliedIndex:1862; }","duration":"100.921635ms","start":"2026-04-16T16:33:30.979261Z","end":"2026-04-16T16:33:31.080183Z","steps":["trace[641738093] 'read index received' (duration: 100.66775ms)","trace[641738093] 'applied index is now lower than readState.Index' (duration: 252.674µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:31.080293Z","caller":"traceutil/trace.go:171","msg":"trace[318905979] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"156.353738ms","start":"2026-04-16T16:33:30.923893Z","end":"2026-04-16T16:33:31.080247Z","steps":["trace[318905979] 'process raft request' (duration: 156.116003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:31.080389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.111428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2b3923ba-8f6f-4d2d-ba62-5d64a091a8f4\" ","response":"range_response_count:1 size:3742"} {"level":"info","ts":"2026-04-16T16:33:31.080444Z","caller":"traceutil/trace.go:171","msg":"trace[1917141197] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2b3923ba-8f6f-4d2d-ba62-5d64a091a8f4; range_end:; response_count:1; response_revision:1797; }","duration":"101.21277ms","start":"2026-04-16T16:33:30.979205Z","end":"2026-04-16T16:33:31.080418Z","steps":["trace[1917141197] 'agreement among raft nodes before linearized reading' (duration: 101.118648ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:42.789862Z","caller":"traceutil/trace.go:171","msg":"trace[2125325471] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"116.498065ms","start":"2026-04-16T16:33:42.673337Z","end":"2026-04-16T16:33:42.789835Z","steps":["trace[2125325471] 'process raft request' (duration: 113.62035ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:34:22.424012Z","caller":"traceutil/trace.go:171","msg":"trace[1768528349] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"149.75235ms","start":"2026-04-16T16:34:22.274116Z","end":"2026-04-16T16:34:22.423869Z","steps":["trace[1768528349] 'process raft request' (duration: 148.74898ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:34:22.437141Z","caller":"traceutil/trace.go:171","msg":"trace[445508488] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"162.518977ms","start":"2026-04-16T16:34:22.274592Z","end":"2026-04-16T16:34:22.437111Z","steps":["trace[445508488] 'process raft request' (duration: 162.473486ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:34:22.437191Z","caller":"traceutil/trace.go:171","msg":"trace[120124635] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"162.773432ms","start":"2026-04-16T16:34:22.274387Z","end":"2026-04-16T16:34:22.437161Z","steps":["trace[120124635] 'process raft request' (duration: 162.568288ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:35:46.025134Z","caller":"traceutil/trace.go:171","msg":"trace[1755096934] transaction","detail":"{read_only:false; response_revision:2768; number_of_response:1; }","duration":"117.149442ms","start":"2026-04-16T16:35:45.907839Z","end":"2026-04-16T16:35:46.024988Z","steps":["trace[1755096934] 'process raft request' (duration: 112.039574ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:35:46.032763Z","caller":"traceutil/trace.go:171","msg":"trace[904732424] transaction","detail":"{read_only:false; response_revision:2769; number_of_response:1; }","duration":"124.540212ms","start":"2026-04-16T16:35:45.908159Z","end":"2026-04-16T16:35:46.0327Z","steps":["trace[904732424] 'process raft request' (duration: 124.287667ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:35:46.328555Z","caller":"traceutil/trace.go:171","msg":"trace[2070649679] transaction","detail":"{read_only:false; response_revision:2771; number_of_response:1; }","duration":"141.458937ms","start":"2026-04-16T16:35:46.186568Z","end":"2026-04-16T16:35:46.328026Z","steps":["trace[2070649679] 'process raft request' (duration: 141.269144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:39:45.059587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.805136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:39:45.059642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.100161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-04-16T16:39:45.059689Z","caller":"traceutil/trace.go:171","msg":"trace[689163313] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:4944; }","duration":"121.966569ms","start":"2026-04-16T16:39:44.937699Z","end":"2026-04-16T16:39:45.059665Z","steps":["trace[689163313] 'count revisions from in-memory index tree' (duration: 121.678614ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:39:45.059713Z","caller":"traceutil/trace.go:171","msg":"trace[902611681] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4944; }","duration":"151.236794ms","start":"2026-04-16T16:39:44.90846Z","end":"2026-04-16T16:39:45.059696Z","steps":["trace[902611681] 'range keys from in-memory index tree' (duration: 150.916567ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:39:45.059869Z","caller":"traceutil/trace.go:171","msg":"trace[1664893539] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"113.064341ms","start":"2026-04-16T16:39:44.946753Z","end":"2026-04-16T16:39:45.059817Z","steps":["trace[1664893539] 'process raft request' (duration: 82.253647ms)","trace[1664893539] 'compare' (duration: 30.265214ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:39:53.926061Z","caller":"traceutil/trace.go:171","msg":"trace[1142087640] linearizableReadLoop","detail":"{readStateIndex:5304; appliedIndex:5303; }","duration":"100.605415ms","start":"2026-04-16T16:39:53.825433Z","end":"2026-04-16T16:39:53.926038Z","steps":["trace[1142087640] 'read index received' (duration: 90.86895ms)","trace[1142087640] 'applied index is now lower than readState.Index' (duration: 9.734815ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:39:53.926292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.845529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-16T16:39:53.926353Z","caller":"traceutil/trace.go:171","msg":"trace[1490169080] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5117; }","duration":"100.956782ms","start":"2026-04-16T16:39:53.82538Z","end":"2026-04-16T16:39:53.926337Z","steps":["trace[1490169080] 'agreement among raft nodes before linearized reading' (duration: 100.764768ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:39:56.123454Z","caller":"traceutil/trace.go:171","msg":"trace[581034729] transaction","detail":"{read_only:false; response_revision:5171; number_of_response:1; }","duration":"105.364385ms","start":"2026-04-16T16:39:56.018059Z","end":"2026-04-16T16:39:56.123423Z","steps":["trace[581034729] 'process raft request' (duration: 105.206443ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:39:56.123453Z","caller":"traceutil/trace.go:171","msg":"trace[1382880758] transaction","detail":"{read_only:false; response_revision:5170; number_of_response:1; }","duration":"108.479315ms","start":"2026-04-16T16:39:56.014922Z","end":"2026-04-16T16:39:56.123402Z","steps":["trace[1382880758] 'process raft request' (duration: 103.786405ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:39:56.12379Z","caller":"traceutil/trace.go:171","msg":"trace[546242493] transaction","detail":"{read_only:false; response_revision:5172; number_of_response:1; }","duration":"105.697422ms","start":"2026-04-16T16:39:56.018069Z","end":"2026-04-16T16:39:56.123766Z","steps":["trace[546242493] 'process raft request' (duration: 105.314305ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:40:04.28881Z","caller":"traceutil/trace.go:171","msg":"trace[1301254435] transaction","detail":"{read_only:false; response_revision:5331; number_of_response:1; }","duration":"133.273235ms","start":"2026-04-16T16:40:04.155498Z","end":"2026-04-16T16:40:04.288771Z","steps":["trace[1301254435] 'process raft request' (duration: 34.123327ms)","trace[1301254435] 'compare' (duration: 98.929013ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:40:04.288937Z","caller":"traceutil/trace.go:171","msg":"trace[1464712553] linearizableReadLoop","detail":"{readStateIndex:5521; appliedIndex:5520; }","duration":"128.448323ms","start":"2026-04-16T16:40:04.160432Z","end":"2026-04-16T16:40:04.288881Z","steps":["trace[1464712553] 'read index received' (duration: 29.121112ms)","trace[1464712553] 'applied index is now lower than readState.Index' (duration: 99.323501ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:40:04.288925Z","caller":"traceutil/trace.go:171","msg":"trace[1728407326] transaction","detail":"{read_only:false; response_revision:5332; number_of_response:1; }","duration":"108.74776ms","start":"2026-04-16T16:40:04.180135Z","end":"2026-04-16T16:40:04.288883Z","steps":["trace[1728407326] 'process raft request' (duration: 108.654028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:40:04.289248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.789829ms","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-16T16:40:04.289354Z","caller":"traceutil/trace.go:171","msg":"trace[788388630] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5332; }","duration":"128.958822ms","start":"2026-04-16T16:40:04.16037Z","end":"2026-04-16T16:40:04.289329Z","steps":["trace[788388630] 'agreement among raft nodes before linearized reading' (duration: 128.712067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:40:04.289493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.169409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-16T16:40:04.28966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.8675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T16:40:04.289673Z","caller":"traceutil/trace.go:171","msg":"trace[929046066] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:5332; }","duration":"116.445554ms","start":"2026-04-16T16:40:04.173185Z","end":"2026-04-16T16:40:04.289631Z","steps":["trace[929046066] 'agreement among raft nodes before linearized reading' (duration: 116.073728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:40:04.289556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.91243ms","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-16T16:40:04.289718Z","caller":"traceutil/trace.go:171","msg":"trace[615816971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5332; }","duration":"127.962693ms","start":"2026-04-16T16:40:04.161743Z","end":"2026-04-16T16:40:04.289705Z","steps":["trace[615816971] 'agreement among raft nodes before linearized reading' (duration: 127.745059ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:40:04.289793Z","caller":"traceutil/trace.go:171","msg":"trace[316508253] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5332; }","duration":"129.215217ms","start":"2026-04-16T16:40:04.160537Z","end":"2026-04-16T16:40:04.289752Z","steps":["trace[316508253] 'agreement among raft nodes before linearized reading' (duration: 128.685117ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:40:04.409944Z","caller":"traceutil/trace.go:171","msg":"trace[1368032671] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"114.840094ms","start":"2026-04-16T16:40:04.295074Z","end":"2026-04-16T16:40:04.409914Z","steps":["trace[1368032671] 'process raft request' (duration: 103.176764ms)","trace[1368032671] 'compare' (duration: 11.413206ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:40:04.409962Z","caller":"traceutil/trace.go:171","msg":"trace[1798237688] transaction","detail":"{read_only:false; response_revision:5335; number_of_response:1; }","duration":"114.828914ms","start":"2026-04-16T16:40:04.295108Z","end":"2026-04-16T16:40:04.409937Z","steps":["trace[1798237688] 'process raft request' (duration: 114.708812ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:40:15.791906Z","caller":"traceutil/trace.go:171","msg":"trace[1135075907] linearizableReadLoop","detail":"{readStateIndex:5696; appliedIndex:5695; }","duration":"245.988196ms","start":"2026-04-16T16:40:15.545893Z","end":"2026-04-16T16:40:15.791881Z","steps":["trace[1135075907] 'read index received' (duration: 245.735191ms)","trace[1135075907] 'applied index is now lower than readState.Index' (duration: 251.775µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:40:15.791977Z","caller":"traceutil/trace.go:171","msg":"trace[519599873] transaction","detail":"{read_only:false; response_revision:5500; number_of_response:1; }","duration":"326.777046ms","start":"2026-04-16T16:40:15.465179Z","end":"2026-04-16T16:40:15.791956Z","steps":["trace[519599873] 'process raft request' (duration: 326.476591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:40:15.792068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.16337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:40:15.792107Z","caller":"traceutil/trace.go:171","msg":"trace[47598176] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:5500; }","duration":"246.262402ms","start":"2026-04-16T16:40:15.545834Z","end":"2026-04-16T16:40:15.792096Z","steps":["trace[47598176] 'agreement among raft nodes before linearized reading' (duration: 246.18104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:40:15.792124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:40:15.465152Z","time spent":"326.879158ms","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:40:15.792136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.731804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:40:15.792199Z","caller":"traceutil/trace.go:171","msg":"trace[509668031] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:5500; }","duration":"215.831605ms","start":"2026-04-16T16:40:15.57635Z","end":"2026-04-16T16:40:15.792182Z","steps":["trace[509668031] 'agreement among raft nodes before linearized reading' (duration: 215.728114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:40:15.792575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.863616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5rx6f\" ","response":"range_response_count:1 size:6523"} {"level":"info","ts":"2026-04-16T16:40:15.792653Z","caller":"traceutil/trace.go:171","msg":"trace[169572192] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5rx6f; range_end:; response_count:1; response_revision:5500; }","duration":"197.987839ms","start":"2026-04-16T16:40:15.594647Z","end":"2026-04-16T16:40:15.792635Z","steps":["trace[169572192] 'agreement among raft nodes before linearized reading' (duration: 197.724094ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:41:25.523422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2987} {"level":"info","ts":"2026-04-16T16:41:25.598571Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2987,"took":"73.357725ms","hash":1842103524,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":33759232,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-16T16:41:25.598645Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1842103524,"revision":2987,"compact-revision":-1} {"level":"info","ts":"2026-04-16T16:46:08.56189Z","caller":"traceutil/trace.go:171","msg":"trace[1630582453] linearizableReadLoop","detail":"{readStateIndex:8459; appliedIndex:8458; }","duration":"121.521497ms","start":"2026-04-16T16:46:08.440341Z","end":"2026-04-16T16:46:08.561862Z","steps":["trace[1630582453] 'read index received' (duration: 121.299083ms)","trace[1630582453] 'applied index is now lower than readState.Index' (duration: 218.144µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:46:08.562011Z","caller":"traceutil/trace.go:171","msg":"trace[776818891] transaction","detail":"{read_only:false; response_revision:8179; number_of_response:1; }","duration":"232.924872ms","start":"2026-04-16T16:46:08.32904Z","end":"2026-04-16T16:46:08.561965Z","steps":["trace[776818891] 'process raft request' (duration: 232.622907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:46:08.562128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.765921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:46:08.562168Z","caller":"traceutil/trace.go:171","msg":"trace[347173051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8179; }","duration":"121.825723ms","start":"2026-04-16T16:46:08.440329Z","end":"2026-04-16T16:46:08.562155Z","steps":["trace[347173051] 'agreement among raft nodes before linearized reading' (duration: 121.738941ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:46:19.771214Z","caller":"traceutil/trace.go:171","msg":"trace[1206480898] transaction","detail":"{read_only:false; response_revision:8238; number_of_response:1; }","duration":"103.394016ms","start":"2026-04-16T16:46:19.667799Z","end":"2026-04-16T16:46:19.771193Z","steps":["trace[1206480898] 'process raft request' (duration: 93.419518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:46:19.771296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.039123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-16T16:46:19.77136Z","caller":"traceutil/trace.go:171","msg":"trace[2091409938] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8238; }","duration":"100.142534ms","start":"2026-04-16T16:46:19.671202Z","end":"2026-04-16T16:46:19.771344Z","steps":["trace[2091409938] 'agreement among raft nodes before linearized reading' (duration: 99.976511ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:46:20.101485Z","caller":"traceutil/trace.go:171","msg":"trace[337953521] transaction","detail":"{read_only:false; response_revision:8240; number_of_response:1; }","duration":"324.963344ms","start":"2026-04-16T16:46:19.776472Z","end":"2026-04-16T16:46:20.101436Z","steps":["trace[337953521] 'process raft request' (duration: 314.6844ms)","trace[337953521] 'compare' (duration: 10.129732ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:46:20.101675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:46:19.776453Z","time spent":"325.142627ms","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:46:20.83812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.498857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-16T16:46:20.838306Z","caller":"traceutil/trace.go:171","msg":"trace[1377251824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8244; }","duration":"137.755021ms","start":"2026-04-16T16:46:20.700531Z","end":"2026-04-16T16:46:20.838286Z","steps":["trace[1377251824] 'range keys from in-memory index tree' (duration: 137.259263ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:46:20.962058Z","caller":"traceutil/trace.go:171","msg":"trace[997150872] transaction","detail":"{read_only:false; response_revision:8245; number_of_response:1; }","duration":"119.875965ms","start":"2026-04-16T16:46:20.842154Z","end":"2026-04-16T16:46:20.96203Z","steps":["trace[997150872] 'process raft request' (duration: 119.680792ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:46:22.378966Z","caller":"traceutil/trace.go:171","msg":"trace[1838978329] linearizableReadLoop","detail":"{readStateIndex:8535; appliedIndex:8534; }","duration":"120.478647ms","start":"2026-04-16T16:46:22.258464Z","end":"2026-04-16T16:46:22.378942Z","steps":["trace[1838978329] 'read index received' (duration: 120.319424ms)","trace[1838978329] 'applied index is now lower than readState.Index' (duration: 158.473µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:46:22.37908Z","caller":"traceutil/trace.go:171","msg":"trace[752652332] transaction","detail":"{read_only:false; response_revision:8251; number_of_response:1; }","duration":"139.410003ms","start":"2026-04-16T16:46:22.239659Z","end":"2026-04-16T16:46:22.379069Z","steps":["trace[752652332] 'process raft request' (duration: 139.143678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:46:22.379176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.915676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T16:46:22.379205Z","caller":"traceutil/trace.go:171","msg":"trace[477313205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8251; }","duration":"110.986578ms","start":"2026-04-16T16:46:22.268212Z","end":"2026-04-16T16:46:22.379198Z","steps":["trace[477313205] 'agreement among raft nodes before linearized reading' (duration: 110.888796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:46:22.379272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.816023ms","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-16T16:46:22.379289Z","caller":"traceutil/trace.go:171","msg":"trace[1886444038] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8251; }","duration":"120.871705ms","start":"2026-04-16T16:46:22.258413Z","end":"2026-04-16T16:46:22.379285Z","steps":["trace[1886444038] 'agreement among raft nodes before linearized reading' (duration: 120.830633ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:46:25.529935Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6097} {"level":"info","ts":"2026-04-16T16:46:25.626863Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6097,"took":"94.832805ms","hash":571537060,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":23072768,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-16T16:46:25.626992Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":571537060,"revision":6097,"compact-revision":2987} {"level":"info","ts":"2026-04-16T16:46:48.812537Z","caller":"traceutil/trace.go:171","msg":"trace[877638990] transaction","detail":"{read_only:false; response_revision:8447; number_of_response:1; }","duration":"286.787866ms","start":"2026-04-16T16:46:48.525713Z","end":"2026-04-16T16:46:48.812501Z","steps":["trace[877638990] 'process raft request' (duration: 286.595012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:46:49.11934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.448193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T16:46:49.119553Z","caller":"traceutil/trace.go:171","msg":"trace[776857474] transaction","detail":"{read_only:false; response_revision:8448; number_of_response:1; }","duration":"593.336644ms","start":"2026-04-16T16:46:48.526197Z","end":"2026-04-16T16:46:49.119534Z","steps":["trace[776857474] 'process raft request' (duration: 402.605035ms)","trace[776857474] 'compare' (duration: 190.040375ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:46:49.119622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:46:48.526157Z","time spent":"593.436456ms","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:46:49.119933Z","caller":"traceutil/trace.go:171","msg":"trace[1338455960] linearizableReadLoop","detail":"{readStateIndex:8740; appliedIndex:8738; }","duration":"545.155007ms","start":"2026-04-16T16:46:48.574753Z","end":"2026-04-16T16:46:49.119908Z","steps":["trace[1338455960] 'read index received' (duration: 237.55121ms)","trace[1338455960] 'applied index is now lower than readState.Index' (duration: 307.602687ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:46:49.120911Z","caller":"traceutil/trace.go:171","msg":"trace[536917781] transaction","detail":"{read_only:false; response_revision:8449; number_of_response:1; }","duration":"411.752427ms","start":"2026-04-16T16:46:48.709147Z","end":"2026-04-16T16:46:49.1209Z","steps":["trace[536917781] 'process raft request' (duration: 410.29692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:46:49.121066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:46:48.709113Z","time spent":"411.876459ms","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:46:49.12137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.181401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T16:46:49.121992Z","caller":"traceutil/trace.go:171","msg":"trace[397752220] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:8449; }","duration":"365.858875ms","start":"2026-04-16T16:46:48.756119Z","end":"2026-04-16T16:46:49.121978Z","steps":["trace[397752220] 'agreement among raft nodes before linearized reading' (duration: 365.148231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:46:49.122142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:46:48.756102Z","time spent":"366.025668ms","remote":"127.0.0.1:50800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:46:49.121437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.684833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.5\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-04-16T16:46:49.122423Z","caller":"traceutil/trace.go:171","msg":"trace[1798310401] range","detail":"{range_begin:/registry/masterleases/199.19.213.5; range_end:; response_count:1; response_revision:8449; }","duration":"498.738244ms","start":"2026-04-16T16:46:48.623676Z","end":"2026-04-16T16:46:49.122414Z","steps":["trace[1798310401] 'agreement among raft nodes before linearized reading' (duration: 497.575412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:46:49.122502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:46:48.623656Z","time spent":"498.817465ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.19.213.5\" "} {"level":"warn","ts":"2026-04-16T16:46:49.121647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.854669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414394"} {"level":"info","ts":"2026-04-16T16:46:49.123123Z","caller":"traceutil/trace.go:171","msg":"trace[1609491240] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:8449; }","duration":"548.377927ms","start":"2026-04-16T16:46:48.574733Z","end":"2026-04-16T16:46:49.123111Z","steps":["trace[1609491240] 'agreement among raft nodes before linearized reading' (duration: 546.468172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:46:49.123197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:46:48.574657Z","time spent":"548.52555ms","remote":"127.0.0.1:51112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":414417,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" "} {"level":"info","ts":"2026-04-16T16:46:52.398386Z","caller":"traceutil/trace.go:171","msg":"trace[792351393] transaction","detail":"{read_only:false; response_revision:8465; number_of_response:1; }","duration":"128.459677ms","start":"2026-04-16T16:46:52.269909Z","end":"2026-04-16T16:46:52.398368Z","steps":["trace[792351393] 'process raft request' (duration: 128.11535ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:46:52.535476Z","caller":"traceutil/trace.go:171","msg":"trace[73840555] transaction","detail":"{read_only:false; response_revision:8466; number_of_response:1; }","duration":"133.407001ms","start":"2026-04-16T16:46:52.40204Z","end":"2026-04-16T16:46:52.535447Z","steps":["trace[73840555] 'process raft request' (duration: 133.187426ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:46:52.553172Z","caller":"traceutil/trace.go:171","msg":"trace[489831950] linearizableReadLoop","detail":"{readStateIndex:8760; appliedIndex:8758; }","duration":"110.079151ms","start":"2026-04-16T16:46:52.443071Z","end":"2026-04-16T16:46:52.55315Z","steps":["trace[489831950] 'read index received' (duration: 92.231944ms)","trace[489831950] 'applied index is now lower than readState.Index' (duration: 17.843167ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:46:52.55326Z","caller":"traceutil/trace.go:171","msg":"trace[656394143] transaction","detail":"{read_only:false; response_revision:8467; number_of_response:1; }","duration":"151.108223ms","start":"2026-04-16T16:46:52.40212Z","end":"2026-04-16T16:46:52.553228Z","steps":["trace[656394143] 'process raft request' (duration: 150.861309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:46:52.553335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.247853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:46:52.553379Z","caller":"traceutil/trace.go:171","msg":"trace[1243148645] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8467; }","duration":"110.355526ms","start":"2026-04-16T16:46:52.443013Z","end":"2026-04-16T16:46:52.553369Z","steps":["trace[1243148645] 'agreement among raft nodes before linearized reading' (duration: 110.248344ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:47:52.454987Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002499.wal"} {"level":"info","ts":"2026-04-16T16:49:08.69995Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dcb0af7a3afe1d6d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-16T16:49:08.710585Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-16T16:49:08.710656Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-16T16:51:25.536501Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8275} {"level":"info","ts":"2026-04-16T16:51:25.617452Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8275,"took":"78.560107ms","hash":2482220695,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":24723456,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-16T16:51:25.617566Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2482220695,"revision":8275,"compact-revision":6097} {"level":"info","ts":"2026-04-16T16:56:25.542768Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10663} {"level":"info","ts":"2026-04-16T16:56:25.625516Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10663,"took":"80.455999ms","hash":4277794649,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":20185088,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-16T16:56:25.625576Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4277794649,"revision":10663,"compact-revision":8275}